builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-082 starttime: 1506988525.48 results: success (0) revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.477622) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.478062) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.478333) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.516657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.517035) ========= 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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 16:55: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% 23.8M=0s 2017-10-02 16:55:25 (23.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149247 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.691516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.691811) ========= 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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016403 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:25.741334) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 16:55:25.744684) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 --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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 16:55:25,791 truncating revision to first 12 chars 2017-10-02 16:55:25,791 Setting DEBUG logging. 2017-10-02 16:55:25,791 attempt 1/10 2017-10-02 16:55:25,791 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c6b4fd1d769?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 16:55:26,607 unpacking tar archive at: mozilla-central-8c6b4fd1d769/testing/mozharness/ program finished with exit code 0 elapsedTime=1.081645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 16:55:26.843463) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.845733) ========= script_repo_revision: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.846103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.846403) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 16:55:26.860399) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 16:55:26.860740) ========= /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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:55:27 INFO - MultiFileLogger online at 20171002 16:55:27 in /builds/slave/test 16:55:27 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 16:55:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:55:27 INFO - {'append_to_log': False, 16:55:27 INFO - 'base_work_dir': '/builds/slave/test', 16:55:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:55:27 INFO - 'branch': 'Firefox-Non-PGO', 16:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:55:27 INFO - 'code_coverage': False, 16:55:27 INFO - 'config_files': ('talos/linux_config.py',), 16:55:27 INFO - 'default_actions': ('clobber', 16:55:27 INFO - 'read-buildbot-config', 16:55:27 INFO - 'download-and-extract', 16:55:27 INFO - 'populate-webroot', 16:55:27 INFO - 'create-virtualenv', 16:55:27 INFO - 'install', 16:55:27 INFO - 'setup-mitmproxy', 16:55:27 INFO - 'run-tests'), 16:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:55:27 INFO - 'disable_ccov_upload': False, 16:55:27 INFO - 'disable_stylo': False, 16:55:27 INFO - 'download_minidump_stackwalk': True, 16:55:27 INFO - 'download_symbols': 'ondemand', 16:55:27 INFO - 'enable_stylo': False, 16:55:27 INFO - 'enable_webrender': False, 16:55:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:55:27 INFO - 'gecko_profile': False, 16:55:27 INFO - 'gecko_profile_interval': 0, 16:55:27 INFO - 'installer_path': 'installer.exe', 16:55:27 INFO - 'log_level': 'info', 16:55:27 INFO - 'log_name': 'talos', 16:55:27 INFO - 'log_to_console': True, 16:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:55:27 INFO - 'opt_config_files': (), 16:55:27 INFO - 'pip_index': False, 16:55:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:55:27 INFO - 'system_bits': '32', 16:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:55:27 INFO - 'title': 'talos-linux64-ix-082', 16:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:55:27 INFO - 'use_talos_json': True, 16:55:27 INFO - 'verify': 'False', 16:55:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:55:27 INFO - 'work_dir': 'build'} 16:55:27 INFO - [mozharness: 2017-10-02 23:55:27.047605Z] Running clobber step. 16:55:27 INFO - Running pre-action listener: _resource_record_pre_action 16:55:27 INFO - Running main action method: clobber 16:55:27 INFO - rmtree: /builds/slave/test/build 16:55:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:55:28 INFO - Running post-action listener: _resource_record_post_action 16:55:28 INFO - [mozharness: 2017-10-02 23:55:28.525251Z] Finished clobber step (success) 16:55:28 INFO - [mozharness: 2017-10-02 23:55:28.525349Z] Running read-buildbot-config step. 16:55:28 INFO - Running pre-action listener: _resource_record_pre_action 16:55:28 INFO - Running main action method: read_buildbot_config 16:55:28 INFO - Using buildbot properties: 16:55:28 INFO - { 16:55:28 INFO - "project": "", 16:55:28 INFO - "product": "firefox", 16:55:28 INFO - "who": "kwierso@gmail.com", 16:55:28 INFO - "installer_path": "public/build/target.tar.bz2", 16:55:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:55:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:55:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 16:55:28 INFO - "stage_platform": "linux64", 16:55:28 INFO - "basedir": "/builds/slave/test", 16:55:28 INFO - "buildnumber": 90, 16:55:28 INFO - "platform": "ubuntu64_hw", 16:55:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:55:28 INFO - "slavebuilddir": "test", 16:55:28 INFO - "taskId": "VuCrBSJQSZygIRcX11fgQg", 16:55:28 INFO - "branch": "mozilla-central", 16:55:28 INFO - "script_repo_revision": "production", 16:55:28 INFO - "revision": "8c6b4fd1d76927cf8b07eb045c5aadd47b77d910", 16:55:28 INFO - "slavename": "talos-linux64-ix-082", 16:55:28 INFO - "repo_path": "mozilla-central" 16:55:28 INFO - } 16:55:28 INFO - Finding installer, test and symbols from parent task. 16:55:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VuCrBSJQSZygIRcX11fgQg'}, attempt #1 16:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VuCrBSJQSZygIRcX11fgQg'}, attempt #1 16:55:29 INFO - Task dependencies: YAgzs5MDS5qLhHYHYdDeDQ 16:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ'}, attempt #1 16:55:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip 16:55:29 INFO - Running post-action listener: _resource_record_post_action 16:55:29 INFO - [mozharness: 2017-10-02 23:55:29.991708Z] Finished read-buildbot-config step (success) 16:55:29 INFO - [mozharness: 2017-10-02 23:55:29.991924Z] Running download-and-extract step. 16:55:29 INFO - Running pre-action listener: _resource_record_pre_action 16:55:29 INFO - Running main action method: download_and_extract 16:55:29 INFO - mkdir: /builds/slave/test/build/tests 16:55:29 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')]} 16:55:29 INFO - trying https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json 16:55:29 INFO - Downloading https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:55:30 INFO - Downloaded 989 bytes. 16:55:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:55:30 INFO - Using the following test package requirements: 16:55:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:55:30 INFO - u'common': [u'target.common.tests.zip'], 16:55:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:55:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:55:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:55:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:55:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:55:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:55:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:55:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:55:30 INFO - u'target.web-platform.tests.tar.gz'], 16:55:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:55:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:55:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip 16:55:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:55:30 INFO - Fetch https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.common.tests.zip into memory 16:55:32 INFO - Content-Length response header: 55366782 16:55:32 INFO - Bytes received: 55366782 16:55:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip 16:55:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:55:42 INFO - Fetch https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.talos.tests.zip into memory 16:55:43 INFO - Content-Length response header: 14522427 16:55:43 INFO - Bytes received: 14522427 16:55:44 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')]} 16:55:44 INFO - trying https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:44 INFO - Downloading https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:55:45 INFO - Downloaded 61637993 bytes. 16:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:46 INFO - mkdir: /builds/slave/test/properties 16:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 16:55:46 INFO - Contents: 16:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 16:55:46 INFO - Running post-action listener: _resource_record_post_action 16:55:46 INFO - Running post-action listener: find_tests_for_verification 16:55:46 INFO - Running post-action listener: set_extra_try_arguments 16:55:46 INFO - [mozharness: 2017-10-02 23:55:46.374936Z] Finished download-and-extract step (success) 16:55:46 INFO - [mozharness: 2017-10-02 23:55:46.375072Z] Running populate-webroot step. 16:55:46 INFO - Running pre-action listener: _resource_record_pre_action 16:55:46 INFO - Running main action method: populate_webroot 16:55:46 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:55:46 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['tresize', 16:55:46 INFO - 'tcanvasmark']}, 16:55:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:55:46 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['dromaeo_css', 16:55:46 INFO - 'kraken']}, 16:55:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:46 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:55:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'tests': ['damp', 'tps']}, 16:55:46 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['damp', 'tps']}, 16:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:55:46 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['dromaeo_dom']}, 16:55:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:55:46 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['basic_compositor_video', 16:55:46 INFO - 'glvideo']}, 16:55:46 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:55:46 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['ts_paint_webext', 16:55:46 INFO - 'tp5o_webext']}, 16:55:46 INFO - 'other-e10s': {'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_many_windows', 16:55:46 INFO - 'sessionrestore_no_auto_restore', 16:55:46 INFO - 'tabpaint', 16:55:46 INFO - 'cpstartup']}, 16:55:46 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['a11yr', 16:55:46 INFO - 'ts_paint', 16:55:46 INFO - 'tpaint', 16:55:46 INFO - 'sessionrestore', 16:55:46 INFO - 'sessionrestore_many_windows', 16:55:46 INFO - 'sessionrestore_no_auto_restore', 16:55:46 INFO - 'tabpaint', 16:55:46 INFO - 'cpstartup']}, 16:55:46 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 16:55:46 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:55:46 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['perf_reftest_singletons']}, 16:55:46 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['perf_reftest']}, 16:55:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:55:46 INFO - 'tsvgr_opacity', 16:55:46 INFO - 'tart', 16:55:46 INFO - 'tscrollx', 16:55:46 INFO - 'tsvg_static']}, 16:55:46 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['tsvgx', 16:55:46 INFO - 'tsvgr_opacity', 16:55:46 INFO - 'tart', 16:55:46 INFO - 'tscrollx', 16:55:46 INFO - 'tsvg_static']}, 16:55:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:55:46 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--disable-stylo'], 16:55:46 INFO - 'tests': ['tp5o']}, 16:55:46 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:46 INFO - 'talos_options': ['--mitmproxy', 16:55:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:46 INFO - '--firstNonBlankPaint'], 16:55:46 INFO - 'tests': ['tp6_google', 16:55:46 INFO - 'tp6_youtube', 16:55:46 INFO - 'tp6_amazon', 16:55:46 INFO - 'tp6_facebook']}, 16:55:46 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:46 INFO - 'talos_options': ['--disable-stylo', 16:55:46 INFO - '--mitmproxy', 16:55:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:46 INFO - '--firstNonBlankPaint'], 16:55:46 INFO - 'tests': ['tp6_google', 16:55:46 INFO - 'tp6_youtube', 16:55:46 INFO - 'tp6_amazon', 16:55:46 INFO - 'tp6_facebook']}, 16:55:46 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:55:46 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 16:55:46 INFO - 'talos_options': ['--stylo-threads=1', 16:55:46 INFO - '--mitmproxy', 16:55:46 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:55:46 INFO - '--firstNonBlankPaint'], 16:55:46 INFO - 'tests': ['tp6_google', 16:55:46 INFO - 'tp6_youtube', 16:55:46 INFO - 'tp6_amazon', 16:55:46 INFO - 'tp6_facebook']}, 16:55:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--xperf_path', 16:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:46 INFO - 'tests': ['tp5n']}, 16:55:46 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:55:46 INFO - 'talos_options': ['--disable-stylo', 16:55:46 INFO - '--xperf_path', 16:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:55:46 INFO - 'tests': ['tp5n']}}} 16:55:46 INFO - Running post-action listener: _resource_record_post_action 16:55:46 INFO - [mozharness: 2017-10-02 23:55:46.391908Z] Finished populate-webroot step (success) 16:55:46 INFO - [mozharness: 2017-10-02 23:55:46.392016Z] Running create-virtualenv step. 16:55:46 INFO - Running pre-action listener: _resource_record_pre_action 16:55:46 INFO - Running main action method: create_virtualenv 16:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 16:55:46 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:55:46 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:55:46 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:55:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:55:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 16:55:48 INFO - Installing pip...............done. 16:55:48 INFO - Return code: 0 16:55:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:55:48 INFO - Reading from file tmpfile_stdout 16:55:48 INFO - Output received: 16:55:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:55:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55: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', 'pip>=1.5'] in /builds/slave/test/build 16:55: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 pip>=1.5 16:55:48 INFO - Using env: {'DISPLAY': ':0', 16:55:48 INFO - 'HOME': '/home/cltbld', 16:55:48 INFO - 'LANG': 'en_US.UTF-8', 16:55:48 INFO - 'LANGUAGE': 'en_US:en', 16:55:48 INFO - 'LOGNAME': 'cltbld', 16:55:48 INFO - 'MAIL': '/var/mail/cltbld', 16:55:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:48 INFO - 'MOZ_NO_REMOTE': '1', 16:55:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:48 INFO - 'NO_EM_RESTART': '1', 16:55:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:48 INFO - 'PWD': '/builds/slave/test', 16:55:48 INFO - 'SHELL': '/bin/bash', 16:55:48 INFO - 'SHLVL': '1', 16:55:48 INFO - 'TERM': 'linux', 16:55:48 INFO - 'TMOUT': '86400', 16:55:48 INFO - 'USER': 'cltbld', 16:55:48 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:48 INFO - '_': '/tools/buildbot/bin/python'} 16:55:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:55:49 INFO - Downloading/unpacking pip>=1.5 16:55:49 INFO - Running setup.py egg_info for package pip 16:55:49 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:49 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:49 INFO - Installing collected packages: pip 16:55:49 INFO - Found existing installation: pip 1.1 16:55:49 INFO - Uninstalling pip: 16:55:49 INFO - Successfully uninstalled pip 16:55:49 INFO - Running setup.py install for pip 16:55:49 INFO - warning: no files found matching 'pip/cacert.pem' 16:55:49 INFO - warning: no files found matching '*.html' under directory 'docs' 16:55:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:55:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:55:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:55:49 INFO - Successfully installed pip 16:55:49 INFO - Cleaning up... 16:55:49 INFO - Return code: 0 16:55:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:55:49 INFO - Using env: {'DISPLAY': ':0', 16:55:49 INFO - 'HOME': '/home/cltbld', 16:55:49 INFO - 'LANG': 'en_US.UTF-8', 16:55:49 INFO - 'LANGUAGE': 'en_US:en', 16:55:49 INFO - 'LOGNAME': 'cltbld', 16:55:49 INFO - 'MAIL': '/var/mail/cltbld', 16:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:49 INFO - 'MOZ_NO_REMOTE': '1', 16:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:49 INFO - 'NO_EM_RESTART': '1', 16:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:49 INFO - 'PWD': '/builds/slave/test', 16:55:49 INFO - 'SHELL': '/bin/bash', 16:55:49 INFO - 'SHLVL': '1', 16:55:49 INFO - 'TERM': 'linux', 16:55:49 INFO - 'TMOUT': '86400', 16:55:49 INFO - 'USER': 'cltbld', 16:55:49 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:49 INFO - '_': '/tools/buildbot/bin/python'} 16:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:49 INFO - Downloading/unpacking psutil>=3.1.1 16:55: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 16:55: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 16:55: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 16:55: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 16:55:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:50 INFO - Installing collected packages: psutil 16:55:50 INFO - Running setup.py install for psutil 16:55:50 INFO - building 'psutil._psutil_linux' extension 16:55: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 16:55:51 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 16:55:51 INFO - building 'psutil._psutil_posix' extension 16:55:51 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 16:55:51 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 16:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:55:51 INFO - Successfully installed psutil 16:55:51 INFO - Cleaning up... 16:55:51 INFO - Return code: 0 16:55:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:55:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:55:51 INFO - Using env: {'DISPLAY': ':0', 16:55:51 INFO - 'HOME': '/home/cltbld', 16:55:51 INFO - 'LANG': 'en_US.UTF-8', 16:55:51 INFO - 'LANGUAGE': 'en_US:en', 16:55:51 INFO - 'LOGNAME': 'cltbld', 16:55:51 INFO - 'MAIL': '/var/mail/cltbld', 16:55:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:51 INFO - 'MOZ_NO_REMOTE': '1', 16:55:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:51 INFO - 'NO_EM_RESTART': '1', 16:55:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:51 INFO - 'PWD': '/builds/slave/test', 16:55:51 INFO - 'SHELL': '/bin/bash', 16:55:51 INFO - 'SHLVL': '1', 16:55:51 INFO - 'TERM': 'linux', 16:55:51 INFO - 'TMOUT': '86400', 16:55:51 INFO - 'USER': 'cltbld', 16:55:51 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:51 INFO - '_': '/tools/buildbot/bin/python'} 16:55:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:55: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 16:55: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 16:55: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 16:55: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 16:55:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:55:52 INFO - Installing collected packages: mozsystemmonitor 16:55:52 INFO - Running setup.py install for mozsystemmonitor 16:55:53 INFO - Successfully installed mozsystemmonitor 16:55:53 INFO - Cleaning up... 16:55:53 INFO - Return code: 0 16:55:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:55:53 INFO - Using env: {'DISPLAY': ':0', 16:55:53 INFO - 'HOME': '/home/cltbld', 16:55:53 INFO - 'LANG': 'en_US.UTF-8', 16:55:53 INFO - 'LANGUAGE': 'en_US:en', 16:55:53 INFO - 'LOGNAME': 'cltbld', 16:55:53 INFO - 'MAIL': '/var/mail/cltbld', 16:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:53 INFO - 'MOZ_NO_REMOTE': '1', 16:55:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:53 INFO - 'NO_EM_RESTART': '1', 16:55:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:53 INFO - 'PWD': '/builds/slave/test', 16:55:53 INFO - 'SHELL': '/bin/bash', 16:55:53 INFO - 'SHLVL': '1', 16:55:53 INFO - 'TERM': 'linux', 16:55:53 INFO - 'TMOUT': '86400', 16:55:53 INFO - 'USER': 'cltbld', 16:55:53 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:53 INFO - '_': '/tools/buildbot/bin/python'} 16:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:54 INFO - Downloading/unpacking jsonschema==2.5.1 16:55:54 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 16:55:54 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 16:55:54 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 16:55:54 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 16:55:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:55:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:55: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 16:55: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 16:55: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 16:55: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 16:55:55 INFO - Downloading functools32-3.2.3-2.tar.gz 16:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:55:55 INFO - warning: no files found matching '*.txt' 16:55:55 INFO - no previously-included directories found matching 'build' 16:55:55 INFO - no previously-included directories found matching 'dist' 16:55:55 INFO - no previously-included directories found matching '.git*' 16:55:55 INFO - Installing collected packages: jsonschema, functools32 16:55:55 INFO - Running setup.py install for functools32 16:55:55 INFO - warning: no files found matching '*.txt' 16:55:55 INFO - no previously-included directories found matching 'build' 16:55:55 INFO - no previously-included directories found matching 'dist' 16:55:55 INFO - no previously-included directories found matching '.git*' 16:55:55 INFO - Successfully installed jsonschema functools32 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55: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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55: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 16:55: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 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:55:55 INFO - Cleaning up... 16:55:55 INFO - Return code: 0 16:55:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:55: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')]} 16:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55: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')]} 16:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55: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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55: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 16:55: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 16:55:55 INFO - Using env: {'DISPLAY': ':0', 16:55:55 INFO - 'HOME': '/home/cltbld', 16:55:55 INFO - 'LANG': 'en_US.UTF-8', 16:55:55 INFO - 'LANGUAGE': 'en_US:en', 16:55:55 INFO - 'LOGNAME': 'cltbld', 16:55:55 INFO - 'MAIL': '/var/mail/cltbld', 16:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:55 INFO - 'MOZ_NO_REMOTE': '1', 16:55:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:55 INFO - 'NO_EM_RESTART': '1', 16:55:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:55 INFO - 'PWD': '/builds/slave/test', 16:55:55 INFO - 'SHELL': '/bin/bash', 16:55:55 INFO - 'SHLVL': '1', 16:55:55 INFO - 'TERM': 'linux', 16:55:55 INFO - 'TMOUT': '86400', 16:55:55 INFO - 'USER': 'cltbld', 16:55:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:55 INFO - '_': '/tools/buildbot/bin/python'} 16:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:55: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 16:55: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 16:55: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 16:55: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 16:55:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:55:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:55:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:55:57 INFO - Downloading docopt-0.6.1.tar.gz 16:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:55:57 INFO - Running setup.py install for blobuploader 16:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:55:57 INFO - Running setup.py install for requests 16:55:58 INFO - Running setup.py install for docopt 16:55:58 INFO - Successfully installed blobuploader requests docopt 16:55:58 INFO - Cleaning up... 16:55:58 INFO - Return code: 0 16:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:55:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:55:58 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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:55:58 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 16:55:58 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 16:55:58 INFO - Using env: {'DISPLAY': ':0', 16:55:58 INFO - 'HOME': '/home/cltbld', 16:55:58 INFO - 'LANG': 'en_US.UTF-8', 16:55:58 INFO - 'LANGUAGE': 'en_US:en', 16:55:58 INFO - 'LOGNAME': 'cltbld', 16:55:58 INFO - 'MAIL': '/var/mail/cltbld', 16:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:58 INFO - 'MOZ_NO_REMOTE': '1', 16:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:58 INFO - 'NO_EM_RESTART': '1', 16:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:58 INFO - 'PWD': '/builds/slave/test', 16:55:58 INFO - 'SHELL': '/bin/bash', 16:55:58 INFO - 'SHLVL': '1', 16:55:58 INFO - 'TERM': 'linux', 16:55:58 INFO - 'TMOUT': '86400', 16:55:58 INFO - 'USER': 'cltbld', 16:55:58 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:58 INFO - '_': '/tools/buildbot/bin/python'} 16:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:55:58 INFO - Running setup.py (path:/tmp/pip-U8LYRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:55:58 INFO - Running setup.py (path:/tmp/pip-4I4oOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:55:58 INFO - Running setup.py (path:/tmp/pip-_I22mB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:55:58 INFO - Running setup.py (path:/tmp/pip-3xz6_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:55:58 INFO - Running setup.py (path:/tmp/pip-7HfcID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:55:58 INFO - Running setup.py (path:/tmp/pip-WuxSrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:55:58 INFO - Running setup.py (path:/tmp/pip-0qUvbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:55:58 INFO - Running setup.py (path:/tmp/pip-u_8aXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:55:59 INFO - Running setup.py (path:/tmp/pip-EJMnt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:55:59 INFO - Running setup.py (path:/tmp/pip-xGzQ61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:55:59 INFO - Running setup.py (path:/tmp/pip-bcb28Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:55:59 INFO - Running setup.py (path:/tmp/pip-P7Tpq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:55:59 INFO - Running setup.py (path:/tmp/pip-dOyh6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:55:59 INFO - Running setup.py (path:/tmp/pip-R4mlxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:59 INFO - Running setup.py (path:/tmp/pip-XXDQqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:55:59 INFO - Running setup.py (path:/tmp/pip-wYGB9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:55:59 INFO - Running setup.py (path:/tmp/pip-IG1m82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:55:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:55:59 INFO - Running setup.py install for manifestparser 16:55:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:55:59 INFO - Running setup.py install for mozcrash 16:55:59 INFO - Running setup.py install for mozdebug 16:55:59 INFO - Running setup.py install for mozdevice 16:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozfile 16:56:00 INFO - Running setup.py install for mozhttpd 16:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozinfo 16:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozInstall 16:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozleak 16:56:00 INFO - Running setup.py install for mozlog 16:56:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for moznetwork 16:56:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozprocess 16:56:00 INFO - Running setup.py install for mozprofile 16:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:56:00 INFO - Running setup.py install for mozrunner 16:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Running setup.py install for mozscreenshot 16:56:01 INFO - Running setup.py install for moztest 16:56:01 INFO - Running setup.py install for mozversion 16:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:56:01 INFO - Cleaning up... 16:56:01 INFO - Return code: 0 16:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:01 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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:56:01 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 16:56:01 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 16:56:01 INFO - Using env: {'DISPLAY': ':0', 16:56:01 INFO - 'HOME': '/home/cltbld', 16:56:01 INFO - 'LANG': 'en_US.UTF-8', 16:56:01 INFO - 'LANGUAGE': 'en_US:en', 16:56:01 INFO - 'LOGNAME': 'cltbld', 16:56:01 INFO - 'MAIL': '/var/mail/cltbld', 16:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:01 INFO - 'MOZ_NO_REMOTE': '1', 16:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:01 INFO - 'NO_EM_RESTART': '1', 16:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:01 INFO - 'PWD': '/builds/slave/test', 16:56:01 INFO - 'SHELL': '/bin/bash', 16:56:01 INFO - 'SHLVL': '1', 16:56:01 INFO - 'TERM': 'linux', 16:56:01 INFO - 'TMOUT': '86400', 16:56:01 INFO - 'USER': 'cltbld', 16:56:01 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:01 INFO - '_': '/tools/buildbot/bin/python'} 16:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:56:01 INFO - Running setup.py (path:/tmp/pip-jt04YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:56:01 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)) 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:56:01 INFO - Running setup.py (path:/tmp/pip-sk16nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:56:01 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)) 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:56:01 INFO - Running setup.py (path:/tmp/pip-yFquXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:56:01 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)) 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:56:01 INFO - Running setup.py (path:/tmp/pip-Ffvewf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:56:01 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)) 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:56:01 INFO - Running setup.py (path:/tmp/pip-gwGpR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:56:01 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)) 16:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:56:01 INFO - Running setup.py (path:/tmp/pip-qRxzHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:56:02 INFO - Running setup.py (path:/tmp/pip-oJ81hj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:56:02 INFO - Running setup.py (path:/tmp/pip-Iq6bcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:56:02 INFO - Running setup.py (path:/tmp/pip-HClAJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:56:02 INFO - Running setup.py (path:/tmp/pip-ahmpiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:56:02 INFO - Running setup.py (path:/tmp/pip-5kPewN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:56:02 INFO - Running setup.py (path:/tmp/pip-Zgb6jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:56:02 INFO - Running setup.py (path:/tmp/pip-j253O1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:56:02 INFO - Running setup.py (path:/tmp/pip-NTzsL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:02 INFO - Running setup.py (path:/tmp/pip-RFMDKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:56:02 INFO - Running setup.py (path:/tmp/pip-PzAvH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:56:02 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)) 16:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:56:02 INFO - Running setup.py (path:/tmp/pip-K68UdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:56:02 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)) 16:56:02 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)) 16:56:02 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)) 16:56:02 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)) 16:56:02 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)) 16:56:02 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)) 16:56:02 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)) 16:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:56:03 INFO - Downloading blessings-1.6.tar.gz 16:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:56:04 INFO - Installing collected packages: blessings 16:56:04 INFO - Running setup.py install for blessings 16:56:04 INFO - Successfully installed blessings 16:56:04 INFO - Cleaning up... 16:56:04 INFO - Return code: 0 16:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:04 INFO - Reading from file tmpfile_stdout 16:56:04 INFO - Current package versions: 16:56:04 INFO - argparse == 1.2.1 16:56:04 INFO - blessings == 1.6 16:56:04 INFO - blobuploader == 1.2.4 16:56:04 INFO - docopt == 0.6.1 16:56:04 INFO - functools32 == 3.2.3-2 16:56:04 INFO - jsonschema == 2.5.1 16:56:04 INFO - manifestparser == 1.1 16:56:04 INFO - mozInstall == 1.13 16:56:04 INFO - mozcrash == 1.0 16:56:04 INFO - mozdebug == 0.1 16:56:04 INFO - mozdevice == 0.51 16:56:04 INFO - mozfile == 1.2 16:56:04 INFO - mozhttpd == 0.7 16:56:04 INFO - mozinfo == 0.10 16:56:04 INFO - mozleak == 0.1 16:56:04 INFO - mozlog == 3.5 16:56:04 INFO - moznetwork == 0.27 16:56:04 INFO - mozprocess == 0.25 16:56:04 INFO - mozprofile == 0.28 16:56:04 INFO - mozrunner == 6.13 16:56:04 INFO - mozscreenshot == 0.1 16:56:04 INFO - mozsystemmonitor == 0.3 16:56:04 INFO - moztest == 0.8 16:56:04 INFO - mozversion == 1.4 16:56:04 INFO - psutil == 3.1.1 16:56:04 INFO - requests == 1.2.3 16:56:04 INFO - wsgiref == 0.1.2 16:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:04 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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:56:04 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 16:56:04 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 16:56:04 INFO - Using env: {'DISPLAY': ':0', 16:56:04 INFO - 'HOME': '/home/cltbld', 16:56:04 INFO - 'LANG': 'en_US.UTF-8', 16:56:04 INFO - 'LANGUAGE': 'en_US:en', 16:56:04 INFO - 'LOGNAME': 'cltbld', 16:56:04 INFO - 'MAIL': '/var/mail/cltbld', 16:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:04 INFO - 'MOZ_NO_REMOTE': '1', 16:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:04 INFO - 'NO_EM_RESTART': '1', 16:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:04 INFO - 'PWD': '/builds/slave/test', 16:56:04 INFO - 'SHELL': '/bin/bash', 16:56:04 INFO - 'SHLVL': '1', 16:56:04 INFO - 'TERM': 'linux', 16:56:04 INFO - 'TMOUT': '86400', 16:56:04 INFO - 'USER': 'cltbld', 16:56:04 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:04 INFO - '_': '/tools/buildbot/bin/python'} 16:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 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)) 16:56:04 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:56: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 16:56: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 16:56: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 16:56: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 16:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:56:05 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)) 16:56:05 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)) 16:56:05 INFO - Installing collected packages: simplejson 16:56:05 INFO - Running setup.py install for simplejson 16:56:05 INFO - building 'simplejson._speedups' extension 16:56:05 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 16:56:06 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 16:56:06 INFO - Successfully installed simplejson 16:56:06 INFO - Cleaning up... 16:56:06 INFO - Return code: 0 16:56:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:56:06 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 0x201b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e3b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23889c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, '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': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', '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 16:56:06 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 16:56:06 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 16:56:06 INFO - Using env: {'DISPLAY': ':0', 16:56:06 INFO - 'HOME': '/home/cltbld', 16:56:06 INFO - 'LANG': 'en_US.UTF-8', 16:56:06 INFO - 'LANGUAGE': 'en_US:en', 16:56:06 INFO - 'LOGNAME': 'cltbld', 16:56:06 INFO - 'MAIL': '/var/mail/cltbld', 16:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:06 INFO - 'MOZ_NO_REMOTE': '1', 16:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:06 INFO - 'NO_EM_RESTART': '1', 16:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:06 INFO - 'PWD': '/builds/slave/test', 16:56:06 INFO - 'SHELL': '/bin/bash', 16:56:06 INFO - 'SHLVL': '1', 16:56:06 INFO - 'TERM': 'linux', 16:56:06 INFO - 'TMOUT': '86400', 16:56:06 INFO - 'USER': 'cltbld', 16:56:06 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:06 INFO - '_': '/tools/buildbot/bin/python'} 16:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:56:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:56:07 INFO - Cleaning up... 16:56:07 INFO - Return code: 0 16:56:07 INFO - Running post-action listener: _resource_record_post_action 16:56:07 INFO - Running post-action listener: _start_resource_monitoring 16:56:07 INFO - Starting resource monitoring. 16:56:07 INFO - [mozharness: 2017-10-02 23:56:07.123971Z] Finished create-virtualenv step (success) 16:56:07 INFO - [mozharness: 2017-10-02 23:56:07.124443Z] Running install step. 16:56:07 INFO - Running pre-action listener: _resource_record_pre_action 16:56:07 INFO - Running main action method: install 16:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:56:07 INFO - Reading from file tmpfile_stdout 16:56:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:56:07 INFO - Reading from file tmpfile_stdout 16:56:07 INFO - Output received: 16:56:07 INFO - Usage: mozinstall [options] installer 16:56:07 INFO - Options: 16:56:07 INFO - -h, --help show this help message and exit 16:56:07 INFO - -d DEST, --destination=DEST 16:56:07 INFO - Directory to install application into. [default: 16:56:07 INFO - "/builds/slave/test"] 16:56:07 INFO - --app=APP Application being installed. [default: firefox] 16:56:07 INFO - mkdir: /builds/slave/test/build/application 16:56:07 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'] 16:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:56:25 INFO - Reading from file tmpfile_stdout 16:56:25 INFO - Output received: 16:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 16:56:25 INFO - Running post-action listener: _resource_record_post_action 16:56:25 INFO - [mozharness: 2017-10-02 23:56:25.260088Z] Finished install step (success) 16:56:25 INFO - [mozharness: 2017-10-02 23:56:25.260427Z] Running setup-mitmproxy step. 16:56:25 INFO - Running pre-action listener: _resource_record_pre_action 16:56:25 INFO - Running main action method: setup_mitmproxy 16:56:25 INFO - Skipping: mitmproxy is not required 16:56:25 INFO - Running post-action listener: _resource_record_post_action 16:56:25 INFO - [mozharness: 2017-10-02 23:56:25.262135Z] Finished setup-mitmproxy step (success) 16:56:25 INFO - [mozharness: 2017-10-02 23:56:25.262445Z] Running run-tests step. 16:56:25 INFO - Running pre-action listener: _resource_record_pre_action 16:56:25 INFO - Running pre-action listener: _set_gcov_prefix 16:56:25 INFO - Running main action method: run_tests 16:56:25 WARNING - Try message not found. 16:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:56:25 INFO - Python 2.7.3 16:56:25 INFO - Return code: 0 16:56:25 INFO - grabbing minidump binary from tooltool 16:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:56:25 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 0x2385d60>, '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 0x2386a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:56:25 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 16:56:25 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 16:56:25 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 16:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:56:25 INFO - Return code: 0 16:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:56:25 INFO - ENV: RUST_BACKTRACE is now full 16:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:56:25 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 16:56:25 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 16:56:25 INFO - Using env: {'DISPLAY': ':0', 16:56:25 INFO - 'HOME': '/home/cltbld', 16:56:25 INFO - 'LANG': 'en_US.UTF-8', 16:56:25 INFO - 'LANGUAGE': 'en_US:en', 16:56:25 INFO - 'LOGNAME': 'cltbld', 16:56:25 INFO - 'MAIL': '/var/mail/cltbld', 16:56:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:25 INFO - 'MOZ_NO_REMOTE': '1', 16:56:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:25 INFO - 'NO_EM_RESTART': '1', 16:56:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:25 INFO - 'PWD': '/builds/slave/test', 16:56:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:25 INFO - 'RUST_BACKTRACE': 'full', 16:56:25 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:25 INFO - 'SHELL': '/bin/bash', 16:56:25 INFO - 'SHLVL': '1', 16:56:25 INFO - 'TERM': 'linux', 16:56:25 INFO - 'TMOUT': '86400', 16:56:25 INFO - 'USER': 'cltbld', 16:56:25 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:56:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:25 INFO - '_': '/tools/buildbot/bin/python'} 16:56:25 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/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 16:56:25 INFO - mozversion application_buildid: 20171002230255 16:56:25 INFO - mozversion application_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 16:56:25 INFO - mozversion application_display_name: Nightly 16:56:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:56:25 INFO - mozversion application_name: Firefox 16:56:25 INFO - mozversion application_remotingname: firefox 16:56:25 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:56:25 INFO - mozversion application_vendor: Mozilla 16:56:25 INFO - mozversion application_version: 58.0a1 16:56:25 INFO - mozversion platform_buildid: 20171002230255 16:56:25 INFO - mozversion platform_changeset: 8c6b4fd1d76927cf8b07eb045c5aadd47b77d910 16:56:25 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:56:25 INFO - mozversion platform_version: 58.0a1 16:56:25 INFO - using testdate: 1506988585 16:56:25 INFO - actual date: 1506988585 16:56:25 INFO - starting webserver on 'localhost:41343' 16:56:25 INFO - SUITE-START | Running 2 tests 16:56:25 INFO - TEST-START | dromaeo_css 16:56:25 INFO - Initialising browser for dromaeo_css test... 16:56:25 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41343/getInfo.html -profile /tmp/tmpBMzgvu/profile 16:56:25 INFO - TEST-INFO | started process 7356 (/builds/slave/test/build/application/firefox/firefox http://localhost:41343/getInfo.html) 16:56:30 INFO - TEST-INFO | 7356: exit 0 16:56:31 INFO - Browser initialized. 16:56:31 INFO - Running cycle 1/1 for dromaeo_css test... 16:56:31 INFO - Using env: {'DISPLAY': ':0', 16:56:31 INFO - 'HOME': '/home/cltbld', 16:56:31 INFO - 'JSGC_DISABLE_POISONING': '1', 16:56:31 INFO - 'LANG': 'en_US.UTF-8', 16:56:31 INFO - 'LANGUAGE': 'en_US:en', 16:56:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:56:31 INFO - 'LOGNAME': 'cltbld', 16:56:31 INFO - 'MAIL': '/var/mail/cltbld', 16:56:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:56:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:56:31 INFO - 'MOZ_CRASHREPORTER': '1', 16:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:56:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:56:31 INFO - 'MOZ_NO_REMOTE': '1', 16:56:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:56:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:56:31 INFO - 'NO_EM_RESTART': '1', 16:56:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:56:31 INFO - 'PWD': '/builds/slave/test', 16:56:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:56:31 INFO - 'RUST_BACKTRACE': 'full', 16:56:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:56:31 INFO - 'SHELL': '/bin/bash', 16:56:31 INFO - 'SHLVL': '1', 16:56:31 INFO - 'STYLO_FORCE_DISABLED': '1', 16:56:31 INFO - 'TERM': 'linux', 16:56:31 INFO - 'TMOUT': '86400', 16:56:31 INFO - 'USER': 'cltbld', 16:56:31 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 16:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:56:31 INFO - '_': '/tools/buildbot/bin/python'} 16:56:31 INFO - TEST-INFO | started process 7586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBMzgvu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:56:31 INFO - PID 7586 | 16:56:31 INFO - PID 7586 | (/builds/slave/test/build/application/firefox/firefox:7635): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:56:31 INFO - PID 7586 | 16:56:42 INFO - PID 7586 | RSS: Main: 153849856 16:56:42 INFO - PID 7586 | 16:59:39 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41343/tests/dromaeo/cssquery-ext.html) 16:59:41 INFO - PID 7586 | RSS: Main: 150351872 16:59:41 INFO - PID 7586 | 17:02:43 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-ext.html (next: http://localhost:41343/tests/dromaeo/cssquery-jquery.html) 17:02:43 INFO - PID 7586 | RSS: Main: 151969792 17:02:43 INFO - PID 7586 | 17:05:45 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41343/tests/dromaeo/cssquery-mootools.html) 17:05:46 INFO - PID 7586 | RSS: Main: 152670208 17:05:46 INFO - PID 7586 | 17:08:47 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41343/tests/dromaeo/cssquery-prototype.html) 17:08:48 INFO - PID 7586 | RSS: Main: 152387584 17:08:48 INFO - PID 7586 | 17:11:51 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41343/tests/dromaeo/cssquery-yui.html) 17:11:52 INFO - PID 7586 | RSS: Main: 155631616 17:11:52 INFO - PID 7586 | 17:14:53 INFO - PID 7586 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-yui.html (next: http://localhost:41343/tests/dromaeo/cssquery-dojo.html) 17:14:54 INFO - PID 7586 | RSS: Main: 156811264 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | __start_tp_report 17:14:54 INFO - PID 7586 | _x_x_mozilla_page_load 17:14:54 INFO - PID 7586 | _x_x_mozilla_page_load_details 17:14:54 INFO - PID 7586 | |i|pagename|runs| 17:14:54 INFO - PID 7586 | |0;dojo.html;3159.2575744699993;3199.1522246604645;3244.5944256967878;3248.9512657310142;3249.9925023242813;6249.343818899007;6299.65351905645;6378.425941665255;6418.550701450895;6450.677466126698;6349.206349206349;6379.5853269537565;6433.260175079868;6509.056186852904;6520.282768895429;1236.8918792867248;5951.940480595204;5961.701914904259;6004.369541198177;6025.698715064251;5779.826605201851;5788.421157884199;5908.438698323674;5940.2871655401195;5946.554008449362;5800.406768951283;5866.530677545786;5938.0499120140785;5943.405659434044;5951.2858456985;5864.794732184353;5880.852978675524;5888.5877988540815;5943.70281485924;5969.194158788595;5768.942310576883;5817.941820581782;5865.706714664292;5866.14940833581;5866.706664666793;6218.5025197984505;6345.682715864188;6376.458001069915;6518.348165183491;6522.119513865615;6659.433948114416;6731.528792984493;6739.056532085512;6761.594304341756;6807;6932.549384290055;6971.128608923885;6999.405050570707;7001.754938577176;7007.159140903073;6193.411625895533;6315.936840631581;6316.115743795872;6382;6412.070249813797;6882.965585172042;6927.549709268881;6948.93051069493;6951.061606683134;6979.89530157048;6621.1392518972225;6648.301928297556;6654.767083152066;6656.633885136267;6660.234073081658;6677.265500794909;6759.290274521104;6762.492813039042;6773.93226067733;6779.35596118368;6707.128073350434;6740.359665831738;6803.319668033157;6883.65581720922;6884.345987131314;6836.829079273058;6868.175818901764;6916.135483064617;6941.375276225164;6946.16646002483;5368.677879327252;5382.354117505846;5421.972890135524;5427.565794736412;5445.183222516575;4607.170709272363;4658.976705116453;4687.812487500461;4691.437027556647;4724.291356296583;5791.420857914259;5864.67744274069;5909.379515150933;5911.172435858984;5914.142449344907;6929.133858267716;6976.197737260179;6978.441724662015;6994;6998.580085194904;5863.560232982543;5888.852778680482;5970.76116955317;5977.252843394575;5992.250968628921;5646;5760.36635970043;5878.441548052928;5887.61730487517;5977.402259774075;6706.26231114577;6728.495362847806;6728.529002969843;6731.831704207336;6734.191896972395;6866;6896.000079988474;6934.306569343025;6992.370686638329;6994.160700715946;6638.734450622114;6641.966790166019;6718.496112791462;6728.461723062045;6750.932490675031;6424.196975378078;6519.152510173647;6690.9294512877705;6755.121834161528;6837.9316206839285;6879.793606191823;6882.483813713891;6937.340952609494;6956.79129626112;6957.373836354753;6534.248561415308;6543.901841472477;6606.570572912745;6622.4702023838945;6670.099536562502;6610.603363798187;6623.6688165592495;6624.072629831924;6723.125993620798;6732.596044237362;6376.171097757262;6499.2200935887995;6522.706478208587;6638.20341559016;6639.568428052161;6546.24718157418;6595.901061483985;6598;6620.867582648417;6632.403083722295;6162.22972128484;6301.117843502005;6395.232572091379;6467.353264673495;6518.478521718156 17:14:54 INFO - PID 7586 | |1;ext.html;866.6100254885301;881.5988725130062;885.6634478898018;887.2059506741471;897.9551022448876;39002.41496377553;39670.603293967055;39696.206075878465;42408.57591424085;42525.36211956823;38441;38701;38715.806420967856;38788.61211387885;39038.219235615274;7295.70817167314;7434.591097489636;7447.106347238312;7452.813679657997;7466.664000120008;7803.60981950903;8031.116577176506;8046.195380461965;8049.798755031113;8072.878906816373;8022.839543209132;8062.07286162093;8066.475679080841;8072.313853322475;8083.838323233532;7930.841383172362;7978.281954624083;8012.799680008017;8090.959545202295;8099.676012959475;7982.121966583672;8058.4359094863385;8066.556339401331;8077.555734434603;8079.798005049862;39157.21685566301;39593.20813583741;39638;39648.405273920915;39774.60225397767;3564.7148228141946;3599.928001439983;3602.513660655804;3605.1167463971233;3610.873619423334;32749;32788.83605581957;32809.835950820096;32839.50740738891;32918.6708132918;5252.080885844962;5252.1596544552685;5254.92117618236;5271.393789714193;5343.572514198855;191695;191814;192526;192722;192749;42988.355174672404;49753;49836.25245621319;49861;49932;45581.54418455839;45585.316220256726;53231.73384133055;53812.461875380744;53870.46129538733;14863.70272594542;14904.478343257933;14962.925185374004;14987.925060374628;15048.247587620794;11806.46870890812;11845.822312665317;11847.644570662895;11858.051355891508;11892.405379731152;14508.129512229089;14682.63293417673;14755.188464634548;14764.261786910827;14897.925510372379;5680.375158732536;5732.914006289909;5742.54059675225;5845.181674565564;5965.850853728692;989.2975987049132;1020.4744556553381;1021.6373187518473;1023.2888142740724;1023.5854478936043;23140.53718925612;23154.65268020981;23412.180573679838;23425.648615270784;23485.88257058738;1132.9150313726504;1133.7675776465805;1135.03522006294;1139.6353166986485;1146.39241202163;12342.691432714253;12419.44112514939;12486.188397754117;12512.124151309321;12583.622491325275;226602;227945;228360;228451;228482;54192.45807541874;54209.45790542123;54361;54436;54669.453305466435;1419.7586410310273;1454.7236025155187;1458.6134674311315;1462.656275775192;1470.1913947328926;23098.30705078783;23218.76781232166;23277.883610581837;23300.06799727992;23584.410389740395;38574.035649109;38638.2272354557;38763.2247355057;38782.22435551217;38828.22343553056;195180;195651;196061;197272;197704;34965.300693986486;36617.633823661425;37073.629263707015;37380.25239495141;37427.625723742414;44528.33207501955;46043;46064;46072.539274606825;46238.53761462343;34318.828405857814;34841.65158348384;34865.47701784425;34920.47619285662;34920.82539587286;33833.83083084569;33956.66043339634;34007.659923400446;34320.48519272263;34972.47541286832;38093.42859857049;38129.809350953066;38355.424668629435;38359.61640383561;38489.23021539609;32244.35511289808;32940;33191;33367.49948750722;33643.49534756932;23809;24274.85721994924;24511.142110026063;24758.25725228174;25047.373815654755 17:14:54 INFO - PID 7586 | |2;jquery.html;580.9868804592088;581.75857019337;587.087079591236;589.2075158911263;595.9433853783889;22063.66904496434;22826;22853.885730571346;22894.88552557235;22915.885420572875;24052.8797356013;24230;24582.50834983299;25589.872050639766;25834.48331033378;6687.832804179886;6867.759628413007;6873.037774711544;6883.070785443976;6883.5869847809045;6755.324467553254;6843.589384636913;6848.486363522731;6863.4852386071;7005.579665220103;7286.708531658727;7295;7349.522281051714;7353;7354.227806080365;6955.721771129149;7248.601326927017;7266.309700578463;7268.491205615609;7317.5609463432365;7078.469114816357;7085.822854428629;7087.964560177218;7099.574025558483;7103.786886393416;30830;31491.527627085612;31534.36931261385;31583.368332633447;31586.36827263442;2047.2732180076007;2064.2671851492655;2065.349414934291;2080.032784755096;2080.3030984620173;19892.80107198924;21489;21632;21707.348779536638;21887;2630.5659566171557;2651.058874099686;2704.5537486314734;2726.086760935089;2729.1676038808155;119557;125641;126983.99999999908;138625;145007.99999999895;21503;21586;22030.779692203192;22115.668264976037;22595.322140335815;44167.55832441699;44256.3361549577;44330;44455.77772111119;44603;10360;10512.632057877938;10739.248252622241;10769.784604308026;10911.345319280868;8642.95678521616;8678.522681252593;8681.262092722189;8763.298936085097;8819.911800882037;11008.944955275172;11349.659510214708;11446.656600302003;11540.24988375753;11893.70265743346;3857.498525191707;3900.656101141454;4074.022234663659;4187.413762073312;4381.100820269962;947.9572470282634;972.7859870828406;973.4256788494822;977.7213494154132;992.5831150916632;19360.70958935617;19466.90266548658;19819.801801981797;19969.800301997086;20033.198672052953;1023.9846402303972;1024.4365598920565;1028.6348346337093;1032.3547782635853;1041.671873359889;10763.515641796137;10827.67516974492;10830.241883068109;10835;10851.348919064882;455205;463858;465361;466700;468294;111706;114579.42710286562;116001.4199928995;118965.40517297358;118980.40509797395;1025.5795123999123;1060.5068643081004;1115.8716747573972;1148.8678801937883;1184.236167671847;20360.89819550893;20515.281965131147;20553.177872884917;20569;20718.585628287652;57779.71110144423;57825.71087144537;57897.71051144717;58924.70537647284;59931.70034149801;73293;75216.24783752092;75289.24710753042;75307;75953.6202319007;19798.70301945443;20514;20573.48566285795;20581;20621.175152993714;23047.88476057609;23210.53578928446;23253.651195231745;23433.765662343158;23500;17851.732224016392;18631.254749809857;18793.624127517647;18847.24611015544;18859.434216973514;16178.757318640466;16521.33914643449;16751.497455076365;16933.915330423268;17314.04772737461;19103.61792764109;19471;19560.119794608992;19595.11821967986;19599.216031358585;19074.23703051918;19841.40475785671;19881.403557893285;20064.49838754043;20104.69842952386;18482;18631.5094792419;18638.627227455105;18644.161012754186;18767.71848422302 17:14:54 INFO - PID 7586 | |3;mootools.html;1366.6378409721422;1392.2760164714348;1420.1266221273906;1422.0969684250501;1438.5828109848144;14941.17823519706;15761;15773.447929322461;15796.842031579681;15803.604909877231;15354.769678454832;15488.225588720576;15497.147656878895;15505;15531.84468155318;2697.204324724211;2735.3435175557825;2791.7208279172023;2792.1623512946035;2800.075974928279;2614.3856193794445;2640.8811603477793;2654.2568080937367;2655.283073570135;2655.3759866431374;2603.934901627465;2723.101376545745;2787.707290734474;2808.5365914624163;2810.227187523427;2692.08469120499;2707.1201859395774;2722.469118521889;2723;2724.0738149029326;2557.6035714464288;2588.4564241509306;2591.3003489058037;2644.867756612181;2668.239551727768;14085.295735213198;14195.929020354935;14200.147991120462;14201.78697319541;14216.289185540785;7970.123286438487;8287.171282871725;8288.917110828876;8289.41974061816;8291.046529649107;5186.870328241824;5210.166373380279;5467.097928841737;5536.141898005815;5576.414476479952;2000.4098790856733;2002.3792624286373;2007.9598408031904;2035.6030574038068;2050.4053824390908;27384.178474645592;27613.86193069042;27623.723762762518;27729.861350693318;27737.722622773716;6905.861882762317;6940.201876784134;7015.719371225094;7110.928890711027;7284.38082762971;17710.114494275236;17725.202365893565;17749.55626109332;17771.644567108844;17816.55458613545;7755.883661745078;8023.919760802317;8092.109867914524;8092.231238032377;8094.878576821352;7259.564426134343;7383.2616738326815;7405.962970185223;7416.035915330973;7441.702331906771;5397.325334333208;5449;5454.263674403984;5500.4499550044675;5505.6696598204235;1500.9699806003819;1504.458394977807;1515.613518552762;1519.058183925951;1546.5051183621358;884.1203003012045;896.0636135238561;898.2095755734912;901.0583939782942;905.6830109461636;7367.2264412235945;7394.334509894135;7402.33378995893;7432.070991126109;7457.254274572608;725.5465334166146;731.2212493694199;733.9266073392617;735.4079965627722;740.5001623903844;4643.721376717408;4964.652474326763;4990.675606085665;5016.2224855147515;5048.823291184791;21597.892010539847;21823.345299641038;21940.232091876707;22799.88600056989;22878.885605571864;21659;21906.561868762536;22638;22821.429464263525;22824.31527054191;11169.664910052712;11383.772324553462;11413.315201087962;11509.712257193805;11519.48162332697;7995.320397766255;8042.396820238622;8107;8124.593770311342;8248.216419440143;18587.44237672872;18764.43706688747;18991.810081899002;19047.714284286023;19269.036548172815;19414.514637134183;19425.902870485555;19509.51226219356;20210.59578808386;20273.087711053333;11471.885281147082;11554.075673945896;11554.364509952033;11555.306681599131;11586.652400428;14120;14140.292985350485;14340.856591433952;14348.784768228275;14397.928010359881;10990.780184396428;10995.285306455055;11012.229143959847;11164.553417863195;11274.7745045097;11105.611303604335;11125;11133.888661113286;11134.33194008362;11328.886711132784;10126.493675316353;10186.185105191715;10201.183905287708;10341.63804266847;10355.119814815826;6910.95917796168;6988.091548098715;7088.929110709033;7173.856522869618;7266.564006159648;6932.410745086724;7004.15950085993;7039.331263529956;7076.2923707628825;7085.964570177116 17:14:54 INFO - PID 7586 | |4;prototype.html;495.04468070592566;503.6273737427441;509.3887335197762;523.4843678976208;523.7093413155698;6283.937160628392;6314.526410519212;6366.777162799303;6369.140166077578;6375.872482550346;6221.40896614822;6224.502039836813;6279.084879111881;6308.842278943029;6341.873162536746;5187.766550505217;5199.012187684338;5201.193814958669;5208.088584497697;5218.79124835008;4974.228994505839;5147.6654017488745;5150.819721309755;5193.50661687141;5206.479352064801;5148.3564554430695;5197.116490196657;5199.480051994789;5202.8699282518055;5227.712475813829;5164.406093299281;5191.506806853343;5198.740062996872;5228.738563071869;5228.862682390554;4751.287306903992;4797.688150270221;4798.928016079762;4839.225723884197;4848.587870031051;6110.327863935008;6136.693165341715;6144.692765361714;6181.9690901545655;6186.381361863822;5975.701214939236;5977.043673012341;5988.19159413478;6038.4263494968345;6056.757729690807;6655.367740064686;6665.800025999228;6665.833354166136;6677.799666009979;6678.465722742169;5077.898442031175;5269.394019687708;5286.973565132188;5338.893222135535;5355.5272300117385;6759.290274521154;6834.9658251708925;6896.2069362023;6913.688884000182;6948.6178260196175;5437.918431223535;5439.619226654176;5469.288992431038;5470.56235501159;5488.231647569343;5554.083841074823;5562.860928476821;5567.888642227133;5578.693171875586;5608.298962629671;6049.758009679564;6051.57638965277;6064.4541991221;6074.019304170626;6095.299040610298;6641.833954151089;6666.933330666729;6680.162955187362;6688.230853451915;6808.795736127924;1858.7546343949587;1884.8020957799233;1884.981150188508;1908.7900330963582;1921.5772530043369;1355.4645914863574;1394.1286695815115;1416.4263473293333;1419.425132821209;1430.3706369197728;5562.527185189304;5581.860453488614;5641.548676105984;5672.914906276409;5722.570807189478;6609.735610575523;6643.933560664332;6753.223379311344;6777.271795692067;6829.351211634887;5693.772249109989;5704.714764261853;5756.625819321731;5756.769729210869;5765.913511297334;3532.823358832048;3562.1272788167066;3577.731670124751;3588.407912694376;3622.619624939396;6489.967550162313;6500.024996250506;6523.217213934358;6560.770373036921;6581.638009909501;6685.231198412245;6733.4857393857055;6768.593884366954;6784.491163162684;6856.714553404123;6422.839429014312;6461.903071453932;6465.450436712932;6489.5753204327375;6513.2184137902805;6560.573562718408;6635.502337324623;6681.46548276127;6689.364510371507;6742.190937087581;6580.243272023778;6715.690440364082;6742.460603151638;6779.118714567075;6783.796486105227;6573.553818159997;6623.370779775913;6623.602583844985;6626.304238054935;6643.368879956396;5059.5952323814745;5061.9493805061475;5079.339685840817;5079.415867175322;5096.210087436453;6411.807645770635;6583.901241481477;6607.47140228771;6640.203175618956;6713.597184168965;6156.569040167145;6503.804885853432;6523.445507131757;6523.967380163069;6603.853747532167;6345.555811093179;6375.585586936834;6524.478041756743;6531.183602049744;6537.215534135934;6381.202349706286;6389.393007664265;6425.357464253537;6452.935470645233;6481.8703625928165;6529;6560.179977502812;6566;6619.966900165468;6648.7340506379205;6352.809415717536;6380.904286435614;6382.20222472191;6394.392532709385;6424 17:14:54 INFO - PID 7586 | |5;yui.html;921.6589861751152;929.251952178496;936.1621348892742;937.1752857485412;945.2343601682635;19709.40871773847;20369;20438.591228175428;20463;20492.28277010305;18697.439076827715;18712;18831.340903068394;18872.33946811862;18875.62248755024;956.110816940247;975.9951200243988;979.148141117229;982.6167794560128;982.6855406269997;992.473988785941;994.3834822410116;994.8010397920409;997.1424574865609;1000.8598796168505;988.6490295944944;1018.8267994440926;1032.0969151992008;1034.7154532503585;1037.3101887244973;1019.694091772469;1019.9184065274798;1020.9846852297221;1021.2544842265114;1022.5500779656927;730.5762657658545;743.6542007966268;753.7964749517599;754.0122439604136;754.0235395163277;20635.69046464304;20705;20918.372448826558;20926.267580634605;21012.894935525226;21476.677849832264;21553.35339939804;22553.54892902149;22689.319320420247;22710.772892271198;17619.647607047915;17689.38087166943;17720.20259088344;17757.733633995373;17874;3829.0618798394294;3843.2121415109837;3844.7693138411787;3851.2490064437447;3855.61443855615;108086;138404.30797845946;138517;141818;146002;17318.82681173172;17563.73654395185;17772.200250988735;17899.642007160044;17903.552411189823;30760.69239307623;30851.537226941615;31213.68786312108;31223.687763122078;31228.531572026437;8998.01021887592;9050.683226087056;9054.547272636342;9127.817443651222;9204.539773011322;4308.375285583573;4404.427424434803;4421.646268298528;4434.068845542408;4439.955600443955;5354.9464505354445;5401.432849550819;5405.324334458192;5432.972835135799;5435.755391007414;1018.9032041956002;1103.2938919091787;1117.8882111788919;1117.9049780768562;1118.2172479264548;640.9935900641027;657.1260223902199;658.236445722959;670.4401824476616;673.3939454490998;12714.427850746739;12877.613671589866;12888.548900788428;13019.609411717664;13131.803022954664;687.340153452691;690.4717890813532;690.5511417578614;710.4139085254685;715.2739968931538;5757.222774925415;5771.971140144273;5784.681842498703;5836.241288632451;5843.678597677169;125941.37029314795;126916;126960;129666;132772.3361383187;109416;111824;114909;115238;118905.40547297208;96725;99443.50278248708;99681.50159249158;101264;101756;10696.679099627023;10754.892451075702;10821.242513024014;10857.511411986321;11002.614908478165;45961.770191150164;46118.99999999866;47514.524854752395;47780.7610961943;47935;58420.415795841494;59133;59396.10905836502;59906;60030;15560.766588501408;15688.137152456724;15718.056916585041;15817.446389376317;15865.603359916095;17628.29486820513;17637.559061023578;17666;17707.20317585686;17909.552261193574;16072.276747546623;16522.917385413475;16570.254338554554;16629.667406652043;16661.916690416954;16472.588185295463;16773.27150252826;16776.412825551048;16930.153492325582;16954.660906782043;16402.75395869039;16619.418320359215;16790.32838686439;16893.32426702918;16911.746323804906;10465.47672616351;10823.729406764578;10923.453827308444;11044.006039456488;11266.436678165896;12266.202696824677;12299.815502767287;12375.562559627877;12383.876161238271;12525 17:14:54 INFO - PID 7586 | __end_tp_report 17:14:54 INFO - PID 7586 | __start_cc_report 17:14:54 INFO - PID 7586 | _x_x_mozilla_cycle_collect,272 17:14:54 INFO - PID 7586 | __end_cc_report 17:14:54 INFO - PID 7586 | __startTimestamp1506989694170__endTimestamp 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | ------- Summary: start ------- 17:14:54 INFO - PID 7586 | Number of tests: 6 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#0] dojo.html Cycles:165 Average:6256.07 Median:6520.28 stddev:847.42 (13.0%) stddev-sans-first:814.45 17:14:54 INFO - PID 7586 | Values: 3159.3 3199.2 3244.6 3249.0 3250.0 6249.3 6299.7 6378.4 6418.6 6450.7 6349.2 6379.6 6433.3 6509.1 6520.3 1236.9 5951.9 5961.7 6004.4 6025.7 5779.8 5788.4 5908.4 5940.3 5946.6 5800.4 5866.5 5938.0 5943.4 5951.3 5864.8 5880.9 5888.6 5943.7 5969.2 5768.9 5817.9 5865.7 5866.1 5866.7 6218.5 6345.7 6376.5 6518.3 6522.1 6659.4 6731.5 6739.1 6761.6 6807.0 6932.5 6971.1 6999.4 7001.8 7007.2 6193.4 6315.9 6316.1 6382.0 6412.1 6883.0 6927.5 6948.9 6951.1 6979.9 6621.1 6648.3 6654.8 6656.6 6660.2 6677.3 6759.3 6762.5 6773.9 6779.4 6707.1 6740.4 6803.3 6883.7 6884.3 6836.8 6868.2 6916.1 6941.4 6946.2 5368.7 5382.4 5422.0 5427.6 5445.2 4607.2 4659.0 4687.8 4691.4 4724.3 5791.4 5864.7 5909.4 5911.2 5914.1 6929.1 6976.2 6978.4 6994.0 6998.6 5863.6 5888.9 5970.8 5977.3 5992.3 5646.0 5760.4 5878.4 5887.6 5977.4 6706.3 6728.5 6728.5 6731.8 6734.2 6866.0 6896.0 6934.3 6992.4 6994.2 6638.7 6642.0 6718.5 6728.5 6750.9 6424.2 6519.2 6690.9 6755.1 6837.9 6879.8 6882.5 6937.3 6956.8 6957.4 6534.2 6543.9 6606.6 6622.5 6670.1 6610.6 6623.7 6624.1 6723.1 6732.6 6376.2 6499.2 6522.7 6638.2 6639.6 6546.2 6595.9 6598.0 6620.9 6632.4 6162.2 6301.1 6395.2 6467.4 6518.5 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#1] ext.html Cycles:180 Average:37973.54 Median:36845.63 stddev:53369.83 (144.8%) stddev-sans-first:53446.82 17:14:54 INFO - PID 7586 | Values: 866.6 881.6 885.7 887.2 898.0 39002.4 39670.6 39696.2 42408.6 42525.4 38441.0 38701.0 38715.8 38788.6 39038.2 7295.7 7434.6 7447.1 7452.8 7466.7 7803.6 8031.1 8046.2 8049.8 8072.9 8022.8 8062.1 8066.5 8072.3 8083.8 7930.8 7978.3 8012.8 8091.0 8099.7 7982.1 8058.4 8066.6 8077.6 8079.8 39157.2 39593.2 39638.0 39648.4 39774.6 3564.7 3599.9 3602.5 3605.1 3610.9 32749.0 32788.8 32809.8 32839.5 32918.7 5252.1 5252.2 5254.9 5271.4 5343.6 191695.0 191814.0 192526.0 192722.0 192749.0 42988.4 49753.0 49836.3 49861.0 49932.0 45581.5 45585.3 53231.7 53812.5 53870.5 14863.7 14904.5 14962.9 14987.9 15048.2 11806.5 11845.8 11847.6 11858.1 11892.4 14508.1 14682.6 14755.2 14764.3 14897.9 5680.4 5732.9 5742.5 5845.2 5965.9 989.3 1020.5 1021.6 1023.3 1023.6 23140.5 23154.7 23412.2 23425.6 23485.9 1132.9 1133.8 1135.0 1139.6 1146.4 12342.7 12419.4 12486.2 12512.1 12583.6 226602.0 227945.0 228360.0 228451.0 228482.0 54192.5 54209.5 54361.0 54436.0 54669.5 1419.8 1454.7 1458.6 1462.7 1470.2 23098.3 23218.8 23277.9 23300.1 23584.4 38574.0 38638.2 38763.2 38782.2 38828.2 195180.0 195651.0 196061.0 197272.0 197704.0 34965.3 36617.6 37073.6 37380.3 37427.6 44528.3 46043.0 46064.0 46072.5 46238.5 34318.8 34841.7 34865.5 34920.5 34920.8 33833.8 33956.7 34007.7 34320.5 34972.5 38093.4 38129.8 38355.4 38359.6 38489.2 32244.4 32940.0 33191.0 33367.5 33643.5 23809.0 24274.9 24511.1 24758.3 25047.4 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#2] jquery.html Cycles:180 Average:35497.79 Median:22710.66 stddev:78198.70 (344.3%) stddev-sans-first:78374.12 17:14:54 INFO - PID 7586 | Values: 581.0 581.8 587.1 589.2 595.9 22063.7 22826.0 22853.9 22894.9 22915.9 24052.9 24230.0 24582.5 25589.9 25834.5 6687.8 6867.8 6873.0 6883.1 6883.6 6755.3 6843.6 6848.5 6863.5 7005.6 7286.7 7295.0 7349.5 7353.0 7354.2 6955.7 7248.6 7266.3 7268.5 7317.6 7078.5 7085.8 7088.0 7099.6 7103.8 30830.0 31491.5 31534.4 31583.4 31586.4 2047.3 2064.3 2065.3 2080.0 2080.3 19892.8 21489.0 21632.0 21707.3 21887.0 2630.6 2651.1 2704.6 2726.1 2729.2 119557.0 125641.0 126984.0 138625.0 145008.0 21503.0 21586.0 22030.8 22115.7 22595.3 44167.6 44256.3 44330.0 44455.8 44603.0 10360.0 10512.6 10739.2 10769.8 10911.3 8643.0 8678.5 8681.3 8763.3 8819.9 11008.9 11349.7 11446.7 11540.2 11893.7 3857.5 3900.7 4074.0 4187.4 4381.1 948.0 972.8 973.4 977.7 992.6 19360.7 19466.9 19819.8 19969.8 20033.2 1024.0 1024.4 1028.6 1032.4 1041.7 10763.5 10827.7 10830.2 10835.0 10851.3 455205.0 463858.0 465361.0 466700.0 468294.0 111706.0 114579.4 116001.4 118965.4 118980.4 1025.6 1060.5 1115.9 1148.9 1184.2 20360.9 20515.3 20553.2 20569.0 20718.6 57779.7 57825.7 57897.7 58924.7 59931.7 73293.0 75216.2 75289.2 75307.0 75953.6 19798.7 20514.0 20573.5 20581.0 20621.2 23047.9 23210.5 23253.7 23433.8 23500.0 17851.7 18631.3 18793.6 18847.2 18859.4 16178.8 16521.3 16751.5 16933.9 17314.0 19103.6 19471.0 19560.1 19595.1 19599.2 19074.2 19841.4 19881.4 20064.5 20104.7 18482.0 18631.5 18638.6 18644.2 18767.7 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#3] mootools.html Cycles:180 Average:9437.99 Median:2642.87 stddev:6899.83 (261.1%) stddev-sans-first:6892.54 17:14:54 INFO - PID 7586 | Values: 1366.6 1392.3 1420.1 1422.1 1438.6 14941.2 15761.0 15773.4 15796.8 15803.6 15354.8 15488.2 15497.1 15505.0 15531.8 2697.2 2735.3 2791.7 2792.2 2800.1 2614.4 2640.9 2654.3 2655.3 2655.4 2603.9 2723.1 2787.7 2808.5 2810.2 2692.1 2707.1 2722.5 2723.0 2724.1 2557.6 2588.5 2591.3 2644.9 2668.2 14085.3 14195.9 14200.1 14201.8 14216.3 7970.1 8287.2 8288.9 8289.4 8291.0 5186.9 5210.2 5467.1 5536.1 5576.4 2000.4 2002.4 2008.0 2035.6 2050.4 27384.2 27613.9 27623.7 27729.9 27737.7 6905.9 6940.2 7015.7 7110.9 7284.4 17710.1 17725.2 17749.6 17771.6 17816.6 7755.9 8023.9 8092.1 8092.2 8094.9 7259.6 7383.3 7406.0 7416.0 7441.7 5397.3 5449.0 5454.3 5500.4 5505.7 1501.0 1504.5 1515.6 1519.1 1546.5 884.1 896.1 898.2 901.1 905.7 7367.2 7394.3 7402.3 7432.1 7457.3 725.5 731.2 733.9 735.4 740.5 4643.7 4964.7 4990.7 5016.2 5048.8 21597.9 21823.3 21940.2 22799.9 22878.9 21659.0 21906.6 22638.0 22821.4 22824.3 11169.7 11383.8 11413.3 11509.7 11519.5 7995.3 8042.4 8107.0 8124.6 8248.2 18587.4 18764.4 18991.8 19047.7 19269.0 19414.5 19425.9 19509.5 20210.6 20273.1 11471.9 11554.1 11554.4 11555.3 11586.7 14120.0 14140.3 14340.9 14348.8 14397.9 10990.8 10995.3 11012.2 11164.6 11274.8 11105.6 11125.0 11133.9 11134.3 11328.9 10126.5 10186.2 10201.2 10341.6 10355.1 6911.0 6988.1 7088.9 7173.9 7266.6 6932.4 7004.2 7039.3 7076.3 7086.0 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#4] prototype.html Cycles:180 Average:5615.49 Median:6203.90 stddev:1506.66 (24.3%) stddev-sans-first:1461.05 17:14:54 INFO - PID 7586 | Values: 495.0 503.6 509.4 523.5 523.7 6283.9 6314.5 6366.8 6369.1 6375.9 6221.4 6224.5 6279.1 6308.8 6341.9 5187.8 5199.0 5201.2 5208.1 5218.8 4974.2 5147.7 5150.8 5193.5 5206.5 5148.4 5197.1 5199.5 5202.9 5227.7 5164.4 5191.5 5198.7 5228.7 5228.9 4751.3 4797.7 4798.9 4839.2 4848.6 6110.3 6136.7 6144.7 6182.0 6186.4 5975.7 5977.0 5988.2 6038.4 6056.8 6655.4 6665.8 6665.8 6677.8 6678.5 5077.9 5269.4 5287.0 5338.9 5355.5 6759.3 6835.0 6896.2 6913.7 6948.6 5437.9 5439.6 5469.3 5470.6 5488.2 5554.1 5562.9 5567.9 5578.7 5608.3 6049.8 6051.6 6064.5 6074.0 6095.3 6641.8 6666.9 6680.2 6688.2 6808.8 1858.8 1884.8 1885.0 1908.8 1921.6 1355.5 1394.1 1416.4 1419.4 1430.4 5562.5 5581.9 5641.5 5672.9 5722.6 6609.7 6643.9 6753.2 6777.3 6829.4 5693.8 5704.7 5756.6 5756.8 5765.9 3532.8 3562.1 3577.7 3588.4 3622.6 6490.0 6500.0 6523.2 6560.8 6581.6 6685.2 6733.5 6768.6 6784.5 6856.7 6422.8 6461.9 6465.5 6489.6 6513.2 6560.6 6635.5 6681.5 6689.4 6742.2 6580.2 6715.7 6742.5 6779.1 6783.8 6573.6 6623.4 6623.6 6626.3 6643.4 5059.6 5061.9 5079.3 5079.4 5096.2 6411.8 6583.9 6607.5 6640.2 6713.6 6156.6 6503.8 6523.4 6524.0 6603.9 6345.6 6375.6 6524.5 6531.2 6537.2 6381.2 6389.4 6425.4 6452.9 6481.9 6529.0 6560.2 6566.0 6620.0 6648.7 6352.8 6380.9 6382.2 6394.4 6424.0 17:14:54 INFO - PID 7586 | 17:14:54 INFO - PID 7586 | [#5] yui.html Cycles:180 Average:24973.56 Median:18873.98 stddev:36034.66 (190.9%) stddev-sans-first:36090.49 17:14:54 INFO - PID 7586 | Values: 921.7 929.3 936.2 937.2 945.2 19709.4 20369.0 20438.6 20463.0 20492.3 18697.4 18712.0 18831.3 18872.3 18875.6 956.1 976.0 979.1 982.6 982.7 992.5 994.4 994.8 997.1 1000.9 988.6 1018.8 1032.1 1034.7 1037.3 1019.7 1019.9 1021.0 1021.3 1022.6 730.6 743.7 753.8 754.0 754.0 20635.7 20705.0 20918.4 20926.3 21012.9 21476.7 21553.4 22553.5 22689.3 22710.8 17619.6 17689.4 17720.2 17757.7 17874.0 3829.1 3843.2 3844.8 3851.2 3855.6 108086.0 138404.3 138517.0 141818.0 146002.0 17318.8 17563.7 17772.2 17899.6 17903.6 30760.7 30851.5 31213.7 31223.7 31228.5 8998.0 9050.7 9054.5 9127.8 9204.5 4308.4 4404.4 4421.6 4434.1 4440.0 5354.9 5401.4 5405.3 5433.0 5435.8 1018.9 1103.3 1117.9 1117.9 1118.2 641.0 657.1 658.2 670.4 673.4 12714.4 12877.6 12888.5 13019.6 13131.8 687.3 690.5 690.6 710.4 715.3 5757.2 5772.0 5784.7 5836.2 5843.7 125941.4 126916.0 126960.0 129666.0 132772.3 109416.0 111824.0 114909.0 115238.0 118905.4 96725.0 99443.5 99681.5 101264.0 101756.0 10696.7 10754.9 10821.2 10857.5 11002.6 45961.8 46119.0 47514.5 47780.8 47935.0 58420.4 59133.0 59396.1 59906.0 60030.0 15560.8 15688.1 15718.1 15817.4 15865.6 17628.3 17637.6 17666.0 17707.2 17909.6 16072.3 16522.9 16570.3 16629.7 16661.9 16472.6 16773.3 16776.4 16930.2 16954.7 16402.8 16619.4 16790.3 16893.3 16911.7 10465.5 10823.7 10923.5 11044.0 11266.4 12266.2 12299.8 12375.6 12383.9 12525.0 17:14:54 INFO - PID 7586 | -------- Summary: end -------- 17:14:54 INFO - PID 7586 | 17:14:54 INFO - TEST-INFO | 7586: exit 0 17:14:54 INFO - TEST-OK | dromaeo_css | took 1109127ms 17:14:54 INFO - TEST-START | kraken 17:14:54 INFO - Initialising browser for kraken test... 17:14:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:41343/getInfo.html -profile /tmp/tmpF1GJXR/profile 17:14:54 INFO - TEST-INFO | started process 7945 (/builds/slave/test/build/application/firefox/firefox http://localhost:41343/getInfo.html) 17:14:59 INFO - TEST-INFO | 7945: exit 0 17:14:59 INFO - Browser initialized. 17:14:59 INFO - Running cycle 1/1 for kraken test... 17:14:59 INFO - Using env: {'DISPLAY': ':0', 17:14:59 INFO - 'HOME': '/home/cltbld', 17:14:59 INFO - 'JSGC_DISABLE_POISONING': '1', 17:14:59 INFO - 'LANG': 'en_US.UTF-8', 17:14:59 INFO - 'LANGUAGE': 'en_US:en', 17:14:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:14:59 INFO - 'LOGNAME': 'cltbld', 17:14:59 INFO - 'MAIL': '/var/mail/cltbld', 17:14:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:14:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:14:59 INFO - 'MOZ_CRASHREPORTER': '1', 17:14:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:14:59 INFO - 'MOZ_NO_REMOTE': '1', 17:14:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:14:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:59 INFO - 'NO_EM_RESTART': '1', 17:14:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:59 INFO - 'PWD': '/builds/slave/test', 17:14:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:14:59 INFO - 'RUST_BACKTRACE': 'full', 17:14:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:14:59 INFO - 'SHELL': '/bin/bash', 17:14:59 INFO - 'SHLVL': '1', 17:14:59 INFO - 'STYLO_FORCE_DISABLED': '1', 17:14:59 INFO - 'TERM': 'linux', 17:14:59 INFO - 'TMOUT': '86400', 17:14:59 INFO - 'USER': 'cltbld', 17:14:59 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422', 17:14:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:59 INFO - '_': '/tools/buildbot/bin/python'} 17:14:59 INFO - TEST-INFO | started process 8178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF1GJXR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:15:00 INFO - PID 8178 | 17:15:00 INFO - PID 8178 | (/builds/slave/test/build/application/firefox/firefox:8227): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:15:00 INFO - PID 8178 | 17:15:10 INFO - PID 8178 | RSS: Main: 154128384 17:15:10 INFO - PID 8178 | 17:15:13 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-beat-detection) 17:15:14 INFO - PID 8178 | RSS: Main: 159490048 17:15:14 INFO - PID 8178 | 17:15:17 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-dft) 17:15:17 INFO - PID 8178 | RSS: Main: 160198656 17:15:17 INFO - PID 8178 | 17:15:20 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-fft) 17:15:21 INFO - PID 8178 | RSS: Main: 156479488 17:15:21 INFO - PID 8178 | 17:15:23 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-oscillator) 17:15:23 INFO - PID 8178 | RSS: Main: 157270016 17:15:23 INFO - PID 8178 | 17:15:26 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:15:26 INFO - PID 8178 | RSS: Main: 157077504 17:15:26 INFO - PID 8178 | 17:15:29 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-darkroom) 17:15:30 INFO - PID 8178 | RSS: Main: 159797248 17:15:30 INFO - PID 8178 | 17:15:34 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-desaturate) 17:15:34 INFO - PID 8178 | RSS: Main: 159797248 17:15:34 INFO - PID 8178 | 17:15:37 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41343/tests/kraken/driver.html?testName=json-parse-financial) 17:15:38 INFO - PID 8178 | RSS: Main: 160284672 17:15:38 INFO - PID 8178 | 17:15:39 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:15:40 INFO - PID 8178 | RSS: Main: 160018432 17:15:40 INFO - PID 8178 | 17:15:42 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:15:42 INFO - PID 8178 | RSS: Main: 160092160 17:15:42 INFO - PID 8178 | 17:15:44 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:15:45 INFO - PID 8178 | RSS: Main: 156807168 17:15:45 INFO - PID 8178 | 17:15:48 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:15:48 INFO - PID 8178 | RSS: Main: 156983296 17:15:48 INFO - PID 8178 | 17:15:51 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:52 INFO - PID 8178 | RSS: Main: 157499392 17:15:52 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41343/tests/kraken/driver.html?testName=ai-astar) 17:15:54 INFO - PID 8178 | RSS: Main: 158924800 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | __start_tp_report 17:15:54 INFO - PID 8178 | _x_x_mozilla_page_load 17:15:54 INFO - PID 8178 | _x_x_mozilla_page_load_details 17:15:54 INFO - PID 8178 | |i|pagename|runs| 17:15:54 INFO - PID 8178 | |0;ai-astar;109;107;108;108;108;108;109;107;106;107 17:15:54 INFO - PID 8178 | |1;audio-beat-detection;119;121;115;127;119;116;120;118;143;123 17:15:54 INFO - PID 8178 | |2;audio-dft;163;163;161;162;163;162;163;162;166;168 17:15:54 INFO - PID 8178 | |3;audio-fft;75;77;74;74;81;74;75;73;74;76 17:15:54 INFO - PID 8178 | |4;audio-oscillator;80;80;79;78;79;78;78;78;79;79 17:15:54 INFO - PID 8178 | |5;imaging-gaussian-blur;110;113;116;114;113;114;114;114;114;114 17:15:54 INFO - PID 8178 | |6;imaging-darkroom;163;147;147;148;148;149;150;154;149;149 17:15:54 INFO - PID 8178 | |7;imaging-desaturate;94;94;94;94;93;95;94;95;95;94 17:15:54 INFO - PID 8178 | |8;json-parse-financial;88;55;50;52;53;53;52;52;52;53 17:15:54 INFO - PID 8178 | |9;json-stringify-tinderbox;37;38;37;37;38;37;47;38;37;39 17:15:54 INFO - PID 8178 | |10;stanford-crypto-aes;74;73;72;72;75;74;72;73;73;72 17:15:54 INFO - PID 8178 | |11;stanford-crypto-ccm;120;106;112;113;110;118;110;110;114;110 17:15:54 INFO - PID 8178 | |12;stanford-crypto-pbkdf2;170;166;163;161;164;161;160;168;177;172 17:15:54 INFO - PID 8178 | |13;stanford-crypto-sha256-iterative;65;63;62;62;66;63;62;64;67;63 17:15:54 INFO - PID 8178 | __end_tp_report 17:15:54 INFO - PID 8178 | __start_cc_report 17:15:54 INFO - PID 8178 | _x_x_mozilla_cycle_collect,739 17:15:54 INFO - PID 8178 | __end_cc_report 17:15:54 INFO - PID 8178 | __startTimestamp1506989754244__endTimestamp 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | ------- Summary: start ------- 17:15:54 INFO - PID 8178 | Number of tests: 14 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:0.95 (0.9%) stddev-sans-first:0.88 17:15:54 INFO - PID 8178 | Values: 109.0 107.0 108.0 108.0 108.0 108.0 109.0 107.0 106.0 107.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:120.50 stddev:8.10 (6.7%) stddev-sans-first:8.52 17:15:54 INFO - PID 8178 | Values: 119.0 121.0 115.0 127.0 119.0 116.0 120.0 118.0 143.0 123.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.11 (1.3%) stddev-sans-first:2.24 17:15:54 INFO - PID 8178 | Values: 163.0 163.0 161.0 162.0 163.0 162.0 163.0 162.0 166.0 168.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#3] audio-fft Cycles:10 Average:75.30 Median:75.00 stddev:2.31 (3.1%) stddev-sans-first:2.45 17:15:54 INFO - PID 8178 | Values: 75.0 77.0 74.0 74.0 81.0 74.0 75.0 73.0 74.0 76.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 17:15:54 INFO - PID 8178 | Values: 80.0 80.0 79.0 78.0 79.0 78.0 78.0 78.0 79.0 79.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:1.51 (1.3%) stddev-sans-first:0.87 17:15:54 INFO - PID 8178 | Values: 110.0 113.0 116.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:149.00 stddev:4.86 (3.3%) stddev-sans-first:2.12 17:15:54 INFO - PID 8178 | Values: 163.0 147.0 147.0 148.0 148.0 149.0 150.0 154.0 149.0 149.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:15:54 INFO - PID 8178 | Values: 94.0 94.0 94.0 94.0 93.0 95.0 94.0 95.0 95.0 94.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:53.00 stddev:11.31 (21.3%) stddev-sans-first:1.33 17:15:54 INFO - PID 8178 | Values: 88.0 55.0 50.0 52.0 53.0 53.0 52.0 52.0 52.0 53.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#9] json-stringify-tinderbox Cycles:10 Average:38.50 Median:38.00 stddev:3.06 (8.1%) stddev-sans-first:3.20 17:15:54 INFO - PID 8178 | Values: 37.0 38.0 37.0 37.0 38.0 37.0 47.0 38.0 37.0 39.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.00 stddev:1.05 (1.4%) stddev-sans-first:1.05 17:15:54 INFO - PID 8178 | Values: 74.0 73.0 72.0 72.0 75.0 74.0 72.0 73.0 73.0 72.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#11] stanford-crypto-ccm Cycles:10 Average:112.30 Median:112.50 stddev:4.16 (3.7%) stddev-sans-first:3.36 17:15:54 INFO - PID 8178 | Values: 120.0 106.0 112.0 113.0 110.0 118.0 110.0 110.0 114.0 110.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:167.00 stddev:5.53 (3.3%) stddev-sans-first:5.70 17:15:54 INFO - PID 8178 | Values: 170.0 166.0 163.0 161.0 164.0 161.0 160.0 168.0 177.0 172.0 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:1.77 (2.8%) stddev-sans-first:1.81 17:15:54 INFO - PID 8178 | Values: 65.0 63.0 62.0 62.0 66.0 63.0 62.0 64.0 67.0 63.0 17:15:54 INFO - PID 8178 | -------- Summary: end -------- 17:15:54 INFO - PID 8178 | 17:15:54 INFO - PID 8178 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:15:54 INFO - TEST-INFO | 8178: exit 0 17:15:54 INFO - TEST-OK | kraken | took 60178ms 17:15:54 INFO - SUITE-END | took 1169s 17:15:55 INFO - Completed test suite (00:19:29) 17:15:55 INFO - javascript benchmark 17:15:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8738.541051367803, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3159.2575744699993, 3199.1522246604645, 3244.5944256967878, 3248.9512657310142, 3249.9925023242813, 6249.343818899007, 6299.65351905645, 6378.425941665255, 6418.550701450895, 6450.677466126698, 6349.206349206349, 6379.5853269537565, 6433.260175079868, 6509.056186852904, 6520.282768895429, 1236.8918792867248, 5951.940480595204, 5961.701914904259, 6004.369541198177, 6025.698715064251, 5779.826605201851, 5788.421157884199, 5908.438698323674, 5940.2871655401195, 5946.554008449362, 5800.406768951283, 5866.530677545786, 5938.0499120140785, 5943.405659434044, 5951.2858456985, 5864.794732184353, 5880.852978675524, 5888.5877988540815, 5943.70281485924, 5969.194158788595, 5768.942310576883, 5817.941820581782, 5865.706714664292, 5866.14940833581, 5866.706664666793, 6218.5025197984505, 6345.682715864188, 6376.458001069915, 6518.348165183491, 6522.119513865615, 6659.433948114416, 6731.528792984493, 6739.056532085512, 6761.594304341756, 6807.0, 6932.549384290055, 6971.128608923885, 6999.405050570707, 7001.754938577176, 7007.159140903073, 6193.411625895533, 6315.936840631581, 6316.115743795872, 6382.0, 6412.070249813797, 6882.965585172042, 6927.549709268881, 6948.93051069493, 6951.061606683134, 6979.89530157048, 6621.1392518972225, 6648.301928297556, 6654.767083152066, 6656.633885136267, 6660.234073081658, 6677.265500794909, 6759.290274521104, 6762.492813039042, 6773.93226067733, 6779.35596118368, 6707.128073350434, 6740.359665831738, 6803.319668033157, 6883.65581720922, 6884.345987131314, 6836.829079273058, 6868.175818901764, 6916.135483064617, 6941.375276225164, 6946.16646002483, 5368.677879327252, 5382.354117505846, 5421.972890135524, 5427.565794736412, 5445.183222516575, 4607.170709272363, 4658.976705116453, 4687.812487500461, 4691.437027556647, 4724.291356296583, 5791.420857914259, 5864.67744274069, 5909.379515150933, 5911.172435858984, 5914.142449344907, 6929.133858267716, 6976.197737260179, 6978.441724662015, 6994.0, 6998.580085194904, 5863.560232982543, 5888.852778680482, 5970.76116955317, 5977.252843394575, 5992.250968628921, 5646.0, 5760.36635970043, 5878.441548052928, 5887.61730487517, 5977.402259774075, 6706.26231114577, 6728.495362847806, 6728.529002969843, 6731.831704207336, 6734.191896972395, 6866.0, 6896.000079988474, 6934.306569343025, 6992.370686638329, 6994.160700715946, 6638.734450622114, 6641.966790166019, 6718.496112791462, 6728.461723062045, 6750.932490675031, 6424.196975378078, 6519.152510173647, 6690.9294512877705, 6755.121834161528, 6837.9316206839285, 6879.793606191823, 6882.483813713891, 6937.340952609494, 6956.79129626112, 6957.373836354753, 6534.248561415308, 6543.901841472477, 6606.570572912745, 6622.4702023838945, 6670.099536562502, 6610.603363798187, 6623.6688165592495, 6624.072629831924, 6723.125993620798, 6732.596044237362, 6376.171097757262, 6499.2200935887995, 6522.706478208587, 6638.20341559016, 6639.568428052161, 6546.24718157418, 6595.901061483985, 6598.0, 6620.867582648417, 6632.403083722295, 6162.22972128484, 6301.117843502005, 6395.232572091379, 6467.353264673495, 6518.478521718156], "value": 6195.412895151368, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [866.6100254885301, 881.5988725130062, 885.6634478898018, 887.2059506741471, 897.9551022448876, 39002.41496377553, 39670.603293967055, 39696.206075878465, 42408.57591424085, 42525.36211956823, 38441.0, 38701.0, 38715.806420967856, 38788.61211387885, 39038.219235615274, 7295.70817167314, 7434.591097489636, 7447.106347238312, 7452.813679657997, 7466.664000120008, 7803.60981950903, 8031.116577176506, 8046.195380461965, 8049.798755031113, 8072.878906816373, 8022.839543209132, 8062.07286162093, 8066.475679080841, 8072.313853322475, 8083.838323233532, 7930.841383172362, 7978.281954624083, 8012.799680008017, 8090.959545202295, 8099.676012959475, 7982.121966583672, 8058.4359094863385, 8066.556339401331, 8077.555734434603, 8079.798005049862, 39157.21685566301, 39593.20813583741, 39638.0, 39648.405273920915, 39774.60225397767, 3564.7148228141946, 3599.928001439983, 3602.513660655804, 3605.1167463971233, 3610.873619423334, 32749.0, 32788.83605581957, 32809.835950820096, 32839.50740738891, 32918.6708132918, 5252.080885844962, 5252.1596544552685, 5254.92117618236, 5271.393789714193, 5343.572514198855, 191695.0, 191814.0, 192526.0, 192722.0, 192749.0, 42988.355174672404, 49753.0, 49836.25245621319, 49861.0, 49932.0, 45581.54418455839, 45585.316220256726, 53231.73384133055, 53812.461875380744, 53870.46129538733, 14863.70272594542, 14904.478343257933, 14962.925185374004, 14987.925060374628, 15048.247587620794, 11806.46870890812, 11845.822312665317, 11847.644570662895, 11858.051355891508, 11892.405379731152, 14508.129512229089, 14682.63293417673, 14755.188464634548, 14764.261786910827, 14897.925510372379, 5680.375158732536, 5732.914006289909, 5742.54059675225, 5845.181674565564, 5965.850853728692, 989.2975987049132, 1020.4744556553381, 1021.6373187518473, 1023.2888142740724, 1023.5854478936043, 23140.53718925612, 23154.65268020981, 23412.180573679838, 23425.648615270784, 23485.88257058738, 1132.9150313726504, 1133.7675776465805, 1135.03522006294, 1139.6353166986485, 1146.39241202163, 12342.691432714253, 12419.44112514939, 12486.188397754117, 12512.124151309321, 12583.622491325275, 226602.0, 227945.0, 228360.0, 228451.0, 228482.0, 54192.45807541874, 54209.45790542123, 54361.0, 54436.0, 54669.453305466435, 1419.7586410310273, 1454.7236025155187, 1458.6134674311315, 1462.656275775192, 1470.1913947328926, 23098.30705078783, 23218.76781232166, 23277.883610581837, 23300.06799727992, 23584.410389740395, 38574.035649109, 38638.2272354557, 38763.2247355057, 38782.22435551217, 38828.22343553056, 195180.0, 195651.0, 196061.0, 197272.0, 197704.0, 34965.300693986486, 36617.633823661425, 37073.629263707015, 37380.25239495141, 37427.625723742414, 44528.33207501955, 46043.0, 46064.0, 46072.539274606825, 46238.53761462343, 34318.828405857814, 34841.65158348384, 34865.47701784425, 34920.47619285662, 34920.82539587286, 33833.83083084569, 33956.66043339634, 34007.659923400446, 34320.48519272263, 34972.47541286832, 38093.42859857049, 38129.809350953066, 38355.424668629435, 38359.61640383561, 38489.23021539609, 32244.35511289808, 32940.0, 33191.0, 33367.49948750722, 33643.49534756932, 23809.0, 24274.85721994924, 24511.142110026063, 24758.25725228174, 25047.373815654755], "value": 17445.72541828593, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.9868804592088, 581.75857019337, 587.087079591236, 589.2075158911263, 595.9433853783889, 22063.66904496434, 22826.0, 22853.885730571346, 22894.88552557235, 22915.885420572875, 24052.8797356013, 24230.0, 24582.50834983299, 25589.872050639766, 25834.48331033378, 6687.832804179886, 6867.759628413007, 6873.037774711544, 6883.070785443976, 6883.5869847809045, 6755.324467553254, 6843.589384636913, 6848.486363522731, 6863.4852386071, 7005.579665220103, 7286.708531658727, 7295.0, 7349.522281051714, 7353.0, 7354.227806080365, 6955.721771129149, 7248.601326927017, 7266.309700578463, 7268.491205615609, 7317.5609463432365, 7078.469114816357, 7085.822854428629, 7087.964560177218, 7099.574025558483, 7103.786886393416, 30830.0, 31491.527627085612, 31534.36931261385, 31583.368332633447, 31586.36827263442, 2047.2732180076007, 2064.2671851492655, 2065.349414934291, 2080.032784755096, 2080.3030984620173, 19892.80107198924, 21489.0, 21632.0, 21707.348779536638, 21887.0, 2630.5659566171557, 2651.058874099686, 2704.5537486314734, 2726.086760935089, 2729.1676038808155, 119557.0, 125641.0, 126983.99999999908, 138625.0, 145007.99999999895, 21503.0, 21586.0, 22030.779692203192, 22115.668264976037, 22595.322140335815, 44167.55832441699, 44256.3361549577, 44330.0, 44455.77772111119, 44603.0, 10360.0, 10512.632057877938, 10739.248252622241, 10769.784604308026, 10911.345319280868, 8642.95678521616, 8678.522681252593, 8681.262092722189, 8763.298936085097, 8819.911800882037, 11008.944955275172, 11349.659510214708, 11446.656600302003, 11540.24988375753, 11893.70265743346, 3857.498525191707, 3900.656101141454, 4074.022234663659, 4187.413762073312, 4381.100820269962, 947.9572470282634, 972.7859870828406, 973.4256788494822, 977.7213494154132, 992.5831150916632, 19360.70958935617, 19466.90266548658, 19819.801801981797, 19969.800301997086, 20033.198672052953, 1023.9846402303972, 1024.4365598920565, 1028.6348346337093, 1032.3547782635853, 1041.671873359889, 10763.515641796137, 10827.67516974492, 10830.241883068109, 10835.0, 10851.348919064882, 455205.0, 463858.0, 465361.0, 466700.0, 468294.0, 111706.0, 114579.42710286562, 116001.4199928995, 118965.40517297358, 118980.40509797395, 1025.5795123999123, 1060.5068643081004, 1115.8716747573972, 1148.8678801937883, 1184.236167671847, 20360.89819550893, 20515.281965131147, 20553.177872884917, 20569.0, 20718.585628287652, 57779.71110144423, 57825.71087144537, 57897.71051144717, 58924.70537647284, 59931.70034149801, 73293.0, 75216.24783752092, 75289.24710753042, 75307.0, 75953.6202319007, 19798.70301945443, 20514.0, 20573.48566285795, 20581.0, 20621.175152993714, 23047.88476057609, 23210.53578928446, 23253.651195231745, 23433.765662343158, 23500.0, 17851.732224016392, 18631.254749809857, 18793.624127517647, 18847.24611015544, 18859.434216973514, 16178.757318640466, 16521.33914643449, 16751.497455076365, 16933.915330423268, 17314.04772737461, 19103.61792764109, 19471.0, 19560.119794608992, 19595.11821967986, 19599.216031358585, 19074.23703051918, 19841.40475785671, 19881.403557893285, 20064.49838754043, 20104.69842952386, 18482.0, 18631.5094792419, 18638.627227455105, 18644.161012754186, 18767.71848422302], "value": 13056.0273300932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.6378409721422, 1392.2760164714348, 1420.1266221273906, 1422.0969684250501, 1438.5828109848144, 14941.17823519706, 15761.0, 15773.447929322461, 15796.842031579681, 15803.604909877231, 15354.769678454832, 15488.225588720576, 15497.147656878895, 15505.0, 15531.84468155318, 2697.204324724211, 2735.3435175557825, 2791.7208279172023, 2792.1623512946035, 2800.075974928279, 2614.3856193794445, 2640.8811603477793, 2654.2568080937367, 2655.283073570135, 2655.3759866431374, 2603.934901627465, 2723.101376545745, 2787.707290734474, 2808.5365914624163, 2810.227187523427, 2692.08469120499, 2707.1201859395774, 2722.469118521889, 2723.0, 2724.0738149029326, 2557.6035714464288, 2588.4564241509306, 2591.3003489058037, 2644.867756612181, 2668.239551727768, 14085.295735213198, 14195.929020354935, 14200.147991120462, 14201.78697319541, 14216.289185540785, 7970.123286438487, 8287.171282871725, 8288.917110828876, 8289.41974061816, 8291.046529649107, 5186.870328241824, 5210.166373380279, 5467.097928841737, 5536.141898005815, 5576.414476479952, 2000.4098790856733, 2002.3792624286373, 2007.9598408031904, 2035.6030574038068, 2050.4053824390908, 27384.178474645592, 27613.86193069042, 27623.723762762518, 27729.861350693318, 27737.722622773716, 6905.861882762317, 6940.201876784134, 7015.719371225094, 7110.928890711027, 7284.38082762971, 17710.114494275236, 17725.202365893565, 17749.55626109332, 17771.644567108844, 17816.55458613545, 7755.883661745078, 8023.919760802317, 8092.109867914524, 8092.231238032377, 8094.878576821352, 7259.564426134343, 7383.2616738326815, 7405.962970185223, 7416.035915330973, 7441.702331906771, 5397.325334333208, 5449.0, 5454.263674403984, 5500.4499550044675, 5505.6696598204235, 1500.9699806003819, 1504.458394977807, 1515.613518552762, 1519.058183925951, 1546.5051183621358, 884.1203003012045, 896.0636135238561, 898.2095755734912, 901.0583939782942, 905.6830109461636, 7367.2264412235945, 7394.334509894135, 7402.33378995893, 7432.070991126109, 7457.254274572608, 725.5465334166146, 731.2212493694199, 733.9266073392617, 735.4079965627722, 740.5001623903844, 4643.721376717408, 4964.652474326763, 4990.675606085665, 5016.2224855147515, 5048.823291184791, 21597.892010539847, 21823.345299641038, 21940.232091876707, 22799.88600056989, 22878.885605571864, 21659.0, 21906.561868762536, 22638.0, 22821.429464263525, 22824.31527054191, 11169.664910052712, 11383.772324553462, 11413.315201087962, 11509.712257193805, 11519.48162332697, 7995.320397766255, 8042.396820238622, 8107.0, 8124.593770311342, 8248.216419440143, 18587.44237672872, 18764.43706688747, 18991.810081899002, 19047.714284286023, 19269.036548172815, 19414.514637134183, 19425.902870485555, 19509.51226219356, 20210.59578808386, 20273.087711053333, 11471.885281147082, 11554.075673945896, 11554.364509952033, 11555.306681599131, 11586.652400428, 14120.0, 14140.292985350485, 14340.856591433952, 14348.784768228275, 14397.928010359881, 10990.780184396428, 10995.285306455055, 11012.229143959847, 11164.553417863195, 11274.7745045097, 11105.611303604335, 11125.0, 11133.888661113286, 11134.33194008362, 11328.886711132784, 10126.493675316353, 10186.185105191715, 10201.183905287708, 10341.63804266847, 10355.119814815826, 6910.95917796168, 6988.091548098715, 7088.929110709033, 7173.856522869618, 7266.564006159648, 6932.410745086724, 7004.15950085993, 7039.331263529956, 7076.2923707628825, 7085.964570177116], "value": 6662.977233485357, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.04468070592566, 503.6273737427441, 509.3887335197762, 523.4843678976208, 523.7093413155698, 6283.937160628392, 6314.526410519212, 6366.777162799303, 6369.140166077578, 6375.872482550346, 6221.40896614822, 6224.502039836813, 6279.084879111881, 6308.842278943029, 6341.873162536746, 5187.766550505217, 5199.012187684338, 5201.193814958669, 5208.088584497697, 5218.79124835008, 4974.228994505839, 5147.6654017488745, 5150.819721309755, 5193.50661687141, 5206.479352064801, 5148.3564554430695, 5197.116490196657, 5199.480051994789, 5202.8699282518055, 5227.712475813829, 5164.406093299281, 5191.506806853343, 5198.740062996872, 5228.738563071869, 5228.862682390554, 4751.287306903992, 4797.688150270221, 4798.928016079762, 4839.225723884197, 4848.587870031051, 6110.327863935008, 6136.693165341715, 6144.692765361714, 6181.9690901545655, 6186.381361863822, 5975.701214939236, 5977.043673012341, 5988.19159413478, 6038.4263494968345, 6056.757729690807, 6655.367740064686, 6665.800025999228, 6665.833354166136, 6677.799666009979, 6678.465722742169, 5077.898442031175, 5269.394019687708, 5286.973565132188, 5338.893222135535, 5355.5272300117385, 6759.290274521154, 6834.9658251708925, 6896.2069362023, 6913.688884000182, 6948.6178260196175, 5437.918431223535, 5439.619226654176, 5469.288992431038, 5470.56235501159, 5488.231647569343, 5554.083841074823, 5562.860928476821, 5567.888642227133, 5578.693171875586, 5608.298962629671, 6049.758009679564, 6051.57638965277, 6064.4541991221, 6074.019304170626, 6095.299040610298, 6641.833954151089, 6666.933330666729, 6680.162955187362, 6688.230853451915, 6808.795736127924, 1858.7546343949587, 1884.8020957799233, 1884.981150188508, 1908.7900330963582, 1921.5772530043369, 1355.4645914863574, 1394.1286695815115, 1416.4263473293333, 1419.425132821209, 1430.3706369197728, 5562.527185189304, 5581.860453488614, 5641.548676105984, 5672.914906276409, 5722.570807189478, 6609.735610575523, 6643.933560664332, 6753.223379311344, 6777.271795692067, 6829.351211634887, 5693.772249109989, 5704.714764261853, 5756.625819321731, 5756.769729210869, 5765.913511297334, 3532.823358832048, 3562.1272788167066, 3577.731670124751, 3588.407912694376, 3622.619624939396, 6489.967550162313, 6500.024996250506, 6523.217213934358, 6560.770373036921, 6581.638009909501, 6685.231198412245, 6733.4857393857055, 6768.593884366954, 6784.491163162684, 6856.714553404123, 6422.839429014312, 6461.903071453932, 6465.450436712932, 6489.5753204327375, 6513.2184137902805, 6560.573562718408, 6635.502337324623, 6681.46548276127, 6689.364510371507, 6742.190937087581, 6580.243272023778, 6715.690440364082, 6742.460603151638, 6779.118714567075, 6783.796486105227, 6573.553818159997, 6623.370779775913, 6623.602583844985, 6626.304238054935, 6643.368879956396, 5059.5952323814745, 5061.9493805061475, 5079.339685840817, 5079.415867175322, 5096.210087436453, 6411.807645770635, 6583.901241481477, 6607.47140228771, 6640.203175618956, 6713.597184168965, 6156.569040167145, 6503.804885853432, 6523.445507131757, 6523.967380163069, 6603.853747532167, 6345.555811093179, 6375.585586936834, 6524.478041756743, 6531.183602049744, 6537.215534135934, 6381.202349706286, 6389.393007664265, 6425.357464253537, 6452.935470645233, 6481.8703625928165, 6529.0, 6560.179977502812, 6566.0, 6619.966900165468, 6648.7340506379205, 6352.809415717536, 6380.904286435614, 6382.20222472191, 6394.392532709385, 6424.0], "value": 5178.600421466451, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.6589861751152, 929.251952178496, 936.1621348892742, 937.1752857485412, 945.2343601682635, 19709.40871773847, 20369.0, 20438.591228175428, 20463.0, 20492.28277010305, 18697.439076827715, 18712.0, 18831.340903068394, 18872.33946811862, 18875.62248755024, 956.110816940247, 975.9951200243988, 979.148141117229, 982.6167794560128, 982.6855406269997, 992.473988785941, 994.3834822410116, 994.8010397920409, 997.1424574865609, 1000.8598796168505, 988.6490295944944, 1018.8267994440926, 1032.0969151992008, 1034.7154532503585, 1037.3101887244973, 1019.694091772469, 1019.9184065274798, 1020.9846852297221, 1021.2544842265114, 1022.5500779656927, 730.5762657658545, 743.6542007966268, 753.7964749517599, 754.0122439604136, 754.0235395163277, 20635.69046464304, 20705.0, 20918.372448826558, 20926.267580634605, 21012.894935525226, 21476.677849832264, 21553.35339939804, 22553.54892902149, 22689.319320420247, 22710.772892271198, 17619.647607047915, 17689.38087166943, 17720.20259088344, 17757.733633995373, 17874.0, 3829.0618798394294, 3843.2121415109837, 3844.7693138411787, 3851.2490064437447, 3855.61443855615, 108086.0, 138404.30797845946, 138517.0, 141818.0, 146002.0, 17318.82681173172, 17563.73654395185, 17772.200250988735, 17899.642007160044, 17903.552411189823, 30760.69239307623, 30851.537226941615, 31213.68786312108, 31223.687763122078, 31228.531572026437, 8998.01021887592, 9050.683226087056, 9054.547272636342, 9127.817443651222, 9204.539773011322, 4308.375285583573, 4404.427424434803, 4421.646268298528, 4434.068845542408, 4439.955600443955, 5354.9464505354445, 5401.432849550819, 5405.324334458192, 5432.972835135799, 5435.755391007414, 1018.9032041956002, 1103.2938919091787, 1117.8882111788919, 1117.9049780768562, 1118.2172479264548, 640.9935900641027, 657.1260223902199, 658.236445722959, 670.4401824476616, 673.3939454490998, 12714.427850746739, 12877.613671589866, 12888.548900788428, 13019.609411717664, 13131.803022954664, 687.340153452691, 690.4717890813532, 690.5511417578614, 710.4139085254685, 715.2739968931538, 5757.222774925415, 5771.971140144273, 5784.681842498703, 5836.241288632451, 5843.678597677169, 125941.37029314795, 126916.0, 126960.0, 129666.0, 132772.3361383187, 109416.0, 111824.0, 114909.0, 115238.0, 118905.40547297208, 96725.0, 99443.50278248708, 99681.50159249158, 101264.0, 101756.0, 10696.679099627023, 10754.892451075702, 10821.242513024014, 10857.511411986321, 11002.614908478165, 45961.770191150164, 46118.99999999866, 47514.524854752395, 47780.7610961943, 47935.0, 58420.415795841494, 59133.0, 59396.10905836502, 59906.0, 60030.0, 15560.766588501408, 15688.137152456724, 15718.056916585041, 15817.446389376317, 15865.603359916095, 17628.29486820513, 17637.559061023578, 17666.0, 17707.20317585686, 17909.552261193574, 16072.276747546623, 16522.917385413475, 16570.254338554554, 16629.667406652043, 16661.916690416954, 16472.588185295463, 16773.27150252826, 16776.412825551048, 16930.153492325582, 16954.660906782043, 16402.75395869039, 16619.418320359215, 16790.32838686439, 16893.32426702918, 16911.746323804906, 10465.47672616351, 10823.729406764578, 10923.453827308444, 11044.006039456488, 11266.436678165896, 12266.202696824677, 12299.815502767287, 12375.562559627877, 12383.876161238271, 12525.0], "value": 9144.414829109917, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1415.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 108.0, 108.0, 108.0, 108.0, 109.0, 107.0, 106.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 121.0, 115.0, 127.0, 119.0, 116.0, 120.0, 118.0, 143.0, 123.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 163.0, 162.0, 163.0, 162.0, 166.0, 168.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 74.0, 74.0, 81.0, 74.0, 75.0, 73.0, 74.0, 76.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 78.0, 79.0, 78.0, 78.0, 78.0, 79.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 116.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 147.0, 147.0, 148.0, 148.0, 149.0, 150.0, 154.0, 149.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 55.0, 50.0, 52.0, 53.0, 53.0, 52.0, 52.0, 52.0, 53.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 38.0, 37.0, 37.0, 38.0, 37.0, 47.0, 38.0, 37.0, 39.0], "value": 38.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 72.0, 75.0, 74.0, 72.0, 73.0, 73.0, 72.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 106.0, 112.0, 113.0, 110.0, 118.0, 110.0, 110.0, 114.0, 110.0], "value": 112.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 163.0, 161.0, 164.0, 161.0, 160.0, 168.0, 177.0, 172.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 62.0, 66.0, 63.0, 62.0, 64.0, 67.0, 63.0], "value": 63.7, "unit": "score"}]}]} 17:15:55 INFO - Return code: 0 17:15:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:15:55 INFO - # TBPL SUCCESS # 17:15:55 INFO - Running post-action listener: _package_coverage_data 17:15:55 INFO - Running post-action listener: _resource_record_post_action 17:15:55 INFO - [mozharness: 2017-10-03 00:15:55.544216Z] Finished run-tests step (success) 17:15:55 INFO - Running post-run listener: _resource_record_post_run 17:15:55 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 139264; Write bytes: 337821696; Read time: 36; Write time: 201640 17:15:55 INFO - TinderboxPrint: CPU usage
13.1% 17:15:55 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 36 17:15:55 INFO - TinderboxPrint: I/O write bytes / time
337,821,696 / 201,640 17:15:55 INFO - TinderboxPrint: CPU idle
8,230.8 (86.9%) 17:15:55 INFO - TinderboxPrint: CPU user
1,192.1 (12.6%) 17:15:55 INFO - TinderboxPrint: Swap in / out
0 / 0 17:15:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13123584; Read time: 0; Write time: 1956 17:15:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:15:55 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 139264; Write bytes: 324153344; Read time: 36; Write time: 199680 17:15:56 INFO - Running post-run listener: _upload_blobber_files 17:15:56 INFO - Blob upload gear active. 17:15:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:56 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 17:15:56 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'] 17:15:56 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 17:15:56 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 17:15:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 17:15:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:57 INFO - (blobuploader) - INFO - Done attempting. 17:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:16:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:04 INFO - (blobuploader) - INFO - Done attempting. 17:16:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 17:16:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 17:16:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:05 INFO - (blobuploader) - INFO - Done attempting. 17:16:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:16:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:16:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:16:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:16:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:16:06 INFO - (blobuploader) - INFO - Done attempting. 17:16:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:16:06 INFO - Return code: 0 17:16:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:16:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:16:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea5c32b7807075379c59cc9cc5e292b90212acb818acbf16ae7ded7b3ad4326c7544cf9771b3b2a1bf0cff540e5e60a330a44b798095a56cc962509adc06364", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f14c0d59fa8e3a62a268a8148166e1174eeddd4f8f39df3e2725553e303437ae0f751fae1ddec1a32003c4f4df803d57566205a045440659b41ac5a1a66cbdd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60b06fd25b74773a682d3836d29ac0be732d56964dfd0b0ddd3c44bfaa470111cb6ac5d30888b06600d6d09b959370fe62d63b5ab3271e0a5ad1b82f2fa8f2c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa413d85056d074604c0afa8b97e2bb75a683862cad5c2319e153d5bf6be7dbd006d38c246951fc5a54ad60e6b0ac5567f26507c1044d36736e1e674fad48959"} 17:16:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:16:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:16:06 INFO - Contents: 17:16:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea5c32b7807075379c59cc9cc5e292b90212acb818acbf16ae7ded7b3ad4326c7544cf9771b3b2a1bf0cff540e5e60a330a44b798095a56cc962509adc06364", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f14c0d59fa8e3a62a268a8148166e1174eeddd4f8f39df3e2725553e303437ae0f751fae1ddec1a32003c4f4df803d57566205a045440659b41ac5a1a66cbdd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60b06fd25b74773a682d3836d29ac0be732d56964dfd0b0ddd3c44bfaa470111cb6ac5d30888b06600d6d09b959370fe62d63b5ab3271e0a5ad1b82f2fa8f2c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa413d85056d074604c0afa8b97e2bb75a683862cad5c2319e153d5bf6be7dbd006d38c246951fc5a54ad60e6b0ac5567f26507c1044d36736e1e674fad48959"} 17:16:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:16:06 INFO - Copying logs to upload dir... 17:16:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:16:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.651371 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-10-02 17:16:06.564405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:06.569035) ========= 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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 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/1ea5c32b7807075379c59cc9cc5e292b90212acb818acbf16ae7ded7b3ad4326c7544cf9771b3b2a1bf0cff540e5e60a330a44b798095a56cc962509adc06364", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f14c0d59fa8e3a62a268a8148166e1174eeddd4f8f39df3e2725553e303437ae0f751fae1ddec1a32003c4f4df803d57566205a045440659b41ac5a1a66cbdd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60b06fd25b74773a682d3836d29ac0be732d56964dfd0b0ddd3c44bfaa470111cb6ac5d30888b06600d6d09b959370fe62d63b5ab3271e0a5ad1b82f2fa8f2c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa413d85056d074604c0afa8b97e2bb75a683862cad5c2319e153d5bf6be7dbd006d38c246951fc5a54ad60e6b0ac5567f26507c1044d36736e1e674fad48959"} build_url:https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/YAgzs5MDS5qLhHYHYdDeDQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1ea5c32b7807075379c59cc9cc5e292b90212acb818acbf16ae7ded7b3ad4326c7544cf9771b3b2a1bf0cff540e5e60a330a44b798095a56cc962509adc06364", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9f14c0d59fa8e3a62a268a8148166e1174eeddd4f8f39df3e2725553e303437ae0f751fae1ddec1a32003c4f4df803d57566205a045440659b41ac5a1a66cbdd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/60b06fd25b74773a682d3836d29ac0be732d56964dfd0b0ddd3c44bfaa470111cb6ac5d30888b06600d6d09b959370fe62d63b5ab3271e0a5ad1b82f2fa8f2c6", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa413d85056d074604c0afa8b97e2bb75a683862cad5c2319e153d5bf6be7dbd006d38c246951fc5a54ad60e6b0ac5567f26507c1044d36736e1e674fad48959"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:06.600367) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:06.600715) ========= 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=51fc86400edbde9650d2781a000001d0-1506986981.188674-1825065422 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 17:16:06.683632) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:16:06.683942) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 17:16:06.684231) ========= ========= Total master_lag: 0.23 =========