builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-010 starttime: 1506292945.31 results: success (0) revision: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.313114) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.313913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.314665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.528610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.528894) ========= 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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-24 15:42: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-09-24 15:42:25 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.095077 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.698045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.698354) ========= 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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021388 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.781395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:25.781749) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 --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 d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 --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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-24 15:42:25,749 truncating revision to first 12 chars 2017-09-24 15:42:25,749 Setting DEBUG logging. 2017-09-24 15:42:25,749 attempt 1/10 2017-09-24 15:42:25,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d9cfaad3b11e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-24 15:42:26,374 unpacking tar archive at: mozilla-central-d9cfaad3b11e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.910515 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:26.729819) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:26.730087) ========= script_repo_revision: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:26.730427) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:26.733712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-24 15:42:26.755962) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-24 15:42:26.756224) ========= /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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:42:26 INFO - MultiFileLogger online at 20170924 15:42:26 in /builds/slave/test 15:42:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:42:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:42:26 INFO - {'append_to_log': False, 15:42:26 INFO - 'base_work_dir': '/builds/slave/test', 15:42:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:42:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:42:26 INFO - 'branch': 'Firefox-Non-PGO', 15:42:26 INFO - 'buildbot_json_path': 'buildprops.json', 15:42:26 INFO - 'code_coverage': False, 15:42:26 INFO - 'config_files': ('talos/linux_config.py',), 15:42:26 INFO - 'default_actions': ('clobber', 15:42:26 INFO - 'read-buildbot-config', 15:42:26 INFO - 'download-and-extract', 15:42:26 INFO - 'populate-webroot', 15:42:26 INFO - 'create-virtualenv', 15:42:26 INFO - 'install', 15:42:26 INFO - 'setup-mitmproxy', 15:42:26 INFO - 'run-tests'), 15:42:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:42:26 INFO - 'disable_ccov_upload': False, 15:42:26 INFO - 'disable_stylo': False, 15:42:26 INFO - 'download_minidump_stackwalk': True, 15:42:26 INFO - 'download_symbols': 'ondemand', 15:42:26 INFO - 'enable_stylo': False, 15:42:26 INFO - 'enable_webrender': False, 15:42:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:42:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:42:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:42:26 INFO - 'gecko_profile': False, 15:42:26 INFO - 'gecko_profile_interval': 0, 15:42:26 INFO - 'installer_path': 'installer.exe', 15:42:26 INFO - 'log_level': 'info', 15:42:26 INFO - 'log_name': 'talos', 15:42:26 INFO - 'log_to_console': True, 15:42:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:42:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:42:26 INFO - 'opt_config_files': (), 15:42:26 INFO - 'pip_index': False, 15:42:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:42:26 INFO - 'system_bits': '32', 15:42:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:42:26 INFO - 'title': 'talos-linux64-ix-010', 15:42:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:42:26 INFO - 'use_talos_json': True, 15:42:26 INFO - 'verify': 'False', 15:42:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:42:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:42:26 INFO - 'work_dir': 'build'} 15:42:26 INFO - [mozharness: 2017-09-24 22:42:26.850505Z] Running clobber step. 15:42:26 INFO - Running pre-action listener: _resource_record_pre_action 15:42:26 INFO - Running main action method: clobber 15:42:26 INFO - rmtree: /builds/slave/test/build 15:42:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:42:27 INFO - Running post-action listener: _resource_record_post_action 15:42:27 INFO - [mozharness: 2017-09-24 22:42:27.846332Z] Finished clobber step (success) 15:42:27 INFO - [mozharness: 2017-09-24 22:42:27.846429Z] Running read-buildbot-config step. 15:42:27 INFO - Running pre-action listener: _resource_record_pre_action 15:42:27 INFO - Running main action method: read_buildbot_config 15:42:27 INFO - Using buildbot properties: 15:42:27 INFO - { 15:42:27 INFO - "project": "", 15:42:27 INFO - "product": "firefox", 15:42:27 INFO - "who": "archaeopteryx@coole-files.de", 15:42:27 INFO - "installer_path": "public/build/target.tar.bz2", 15:42:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:42:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:42:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:42:27 INFO - "stage_platform": "linux64", 15:42:27 INFO - "basedir": "/builds/slave/test", 15:42:27 INFO - "buildnumber": 67, 15:42:27 INFO - "platform": "ubuntu64_hw", 15:42:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:42:27 INFO - "slavebuilddir": "test", 15:42:27 INFO - "taskId": "b1aCKvrBSbq6YtM9xRvbDw", 15:42:27 INFO - "branch": "mozilla-central", 15:42:27 INFO - "script_repo_revision": "production", 15:42:27 INFO - "revision": "d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4", 15:42:27 INFO - "slavename": "talos-linux64-ix-010", 15:42:27 INFO - "repo_path": "mozilla-central" 15:42:27 INFO - } 15:42:27 INFO - Finding installer, test and symbols from parent task. 15:42:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1aCKvrBSbq6YtM9xRvbDw'}, attempt #1 15:42:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b1aCKvrBSbq6YtM9xRvbDw'}, attempt #1 15:42:28 INFO - Task dependencies: fh1savD2Q1aQeqxvlInuLA 15:42:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA'}, attempt #1 15:42:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 15:42:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.test_packages.json 15:42:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.crashreporter-symbols.zip 15:42:29 INFO - Running post-action listener: _resource_record_post_action 15:42:29 INFO - [mozharness: 2017-09-24 22:42:29.232016Z] Finished read-buildbot-config step (success) 15:42:29 INFO - [mozharness: 2017-09-24 22:42:29.232232Z] Running download-and-extract step. 15:42:29 INFO - Running pre-action listener: _resource_record_pre_action 15:42:29 INFO - Running main action method: download_and_extract 15:42:29 INFO - mkdir: /builds/slave/test/build/tests 15:42: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')]} 15:42:29 INFO - trying https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.test_packages.json 15:42:29 INFO - Downloading https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:42:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:42:29 INFO - Downloaded 989 bytes. 15:42:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:42:29 INFO - Using the following test package requirements: 15:42:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:42:29 INFO - u'common': [u'target.common.tests.zip'], 15:42:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:42:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:42:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:42:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:42:29 INFO - u'mozbase': [u'target.common.tests.zip'], 15:42:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:42:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:42:29 INFO - u'web-platform': [u'target.common.tests.zip', 15:42:29 INFO - u'target.web-platform.tests.tar.gz'], 15:42:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:42:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:42:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.common.tests.zip 15:42:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:42:29 INFO - Fetch https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.common.tests.zip into memory 15:42:31 INFO - Content-Length response header: 54944009 15:42:31 INFO - Bytes received: 54944009 15:42:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.talos.tests.zip 15:42:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:42:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.talos.tests.zip into memory 15:42:42 INFO - Content-Length response header: 14513823 15:42:42 INFO - Bytes received: 14513823 15:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:42 INFO - trying https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 15:42:42 INFO - Downloading https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:42:44 INFO - Downloaded 61624893 bytes. 15:42:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 15:42:44 INFO - mkdir: /builds/slave/test/properties 15:42:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:42:44 INFO - Writing to file /builds/slave/test/properties/build_url 15:42:44 INFO - Contents: 15:42:44 INFO - build_url:https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 15:42:44 INFO - Running post-action listener: _resource_record_post_action 15:42:44 INFO - Running post-action listener: find_tests_for_verification 15:42:44 INFO - Running post-action listener: set_extra_try_arguments 15:42:44 INFO - [mozharness: 2017-09-24 22:42:44.022376Z] Finished download-and-extract step (success) 15:42:44 INFO - [mozharness: 2017-09-24 22:42:44.022472Z] Running populate-webroot step. 15:42:44 INFO - Running pre-action listener: _resource_record_pre_action 15:42:44 INFO - Running main action method: populate_webroot 15:42:44 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:42:44 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['tresize', 15:42:44 INFO - 'tcanvasmark']}, 15:42:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:42:44 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['dromaeo_css', 15:42:44 INFO - 'kraken']}, 15:42:44 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:44 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:42:44 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'tests': ['damp', 'tps']}, 15:42:44 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['damp', 'tps']}, 15:42:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:42:44 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['dromaeo_dom']}, 15:42:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:42:44 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['basic_compositor_video', 15:42:44 INFO - 'glvideo']}, 15:42:44 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:42:44 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['ts_paint_webext', 15:42:44 INFO - 'tp5o_webext']}, 15:42:44 INFO - 'other-e10s': {'tests': ['a11yr', 15:42:44 INFO - 'ts_paint', 15:42:44 INFO - 'tpaint', 15:42:44 INFO - 'sessionrestore', 15:42:44 INFO - 'sessionrestore_many_windows', 15:42:44 INFO - 'sessionrestore_no_auto_restore', 15:42:44 INFO - 'tabpaint']}, 15:42:44 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['a11yr', 15:42:44 INFO - 'ts_paint', 15:42:44 INFO - 'tpaint', 15:42:44 INFO - 'sessionrestore', 15:42:44 INFO - 'sessionrestore_many_windows', 15:42:44 INFO - 'sessionrestore_no_auto_restore', 15:42:44 INFO - 'tabpaint']}, 15:42:44 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 15:42:44 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:42:44 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['perf_reftest_singletons']}, 15:42:44 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['perf_reftest']}, 15:42:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:42:44 INFO - 'tsvgr_opacity', 15:42:44 INFO - 'tart', 15:42:44 INFO - 'tscrollx', 15:42:44 INFO - 'tsvg_static']}, 15:42:44 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['tsvgx', 15:42:44 INFO - 'tsvgr_opacity', 15:42:44 INFO - 'tart', 15:42:44 INFO - 'tscrollx', 15:42:44 INFO - 'tsvg_static']}, 15:42:44 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:42:44 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--disable-stylo'], 15:42:44 INFO - 'tests': ['tp5o']}, 15:42:44 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:42:44 INFO - 'talos_options': ['--mitmproxy', 15:42:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:44 INFO - '--firstNonBlankPaint'], 15:42:44 INFO - 'tests': ['tp6_google', 15:42:44 INFO - 'tp6_youtube', 15:42:44 INFO - 'tp6_amazon', 15:42:44 INFO - 'tp6_facebook']}, 15:42:44 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:42:44 INFO - 'talos_options': ['--disable-stylo', 15:42:44 INFO - '--mitmproxy', 15:42:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:44 INFO - '--firstNonBlankPaint'], 15:42:44 INFO - 'tests': ['tp6_google', 15:42:44 INFO - 'tp6_youtube', 15:42:44 INFO - 'tp6_amazon', 15:42:44 INFO - 'tp6_facebook']}, 15:42:44 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:42:44 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 15:42:44 INFO - 'talos_options': ['--stylo-threads=1', 15:42:44 INFO - '--mitmproxy', 15:42:44 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:42:44 INFO - '--firstNonBlankPaint'], 15:42:44 INFO - 'tests': ['tp6_google', 15:42:44 INFO - 'tp6_youtube', 15:42:44 INFO - 'tp6_amazon', 15:42:44 INFO - 'tp6_facebook']}, 15:42:44 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--xperf_path', 15:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:44 INFO - 'tests': ['tp5n']}, 15:42:44 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:42:44 INFO - 'talos_options': ['--disable-stylo', 15:42:44 INFO - '--xperf_path', 15:42:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:42:44 INFO - 'tests': ['tp5n']}}} 15:42:44 INFO - Running post-action listener: _resource_record_post_action 15:42:44 INFO - [mozharness: 2017-09-24 22:42:44.037719Z] Finished populate-webroot step (success) 15:42:44 INFO - [mozharness: 2017-09-24 22:42:44.037808Z] Running create-virtualenv step. 15:42:44 INFO - Running pre-action listener: _resource_record_pre_action 15:42:44 INFO - Running main action method: create_virtualenv 15:42:44 INFO - Creating virtualenv /builds/slave/test/build/venv 15:42:44 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:42:44 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:42:44 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:42:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:42:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:42:44 INFO - Installing distribute.............................................................................................................................................................................................done. 15:42:44 INFO - Installing pip...............done. 15:42:44 INFO - Return code: 0 15:42:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:42:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:42:45 INFO - Reading from file tmpfile_stdout 15:42:45 INFO - Output received: 15:42:45 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:42:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:45 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:42:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:42:45 INFO - Using env: {'DISPLAY': ':0', 15:42:45 INFO - 'HOME': '/home/cltbld', 15:42:45 INFO - 'LANG': 'en_US.UTF-8', 15:42:45 INFO - 'LANGUAGE': 'en_US:en', 15:42:45 INFO - 'LOGNAME': 'cltbld', 15:42:45 INFO - 'MAIL': '/var/mail/cltbld', 15:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:45 INFO - 'MOZ_NO_REMOTE': '1', 15:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:45 INFO - 'NO_EM_RESTART': '1', 15:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:45 INFO - 'PWD': '/builds/slave/test', 15:42:45 INFO - 'SHELL': '/bin/bash', 15:42:45 INFO - 'SHLVL': '1', 15:42:45 INFO - 'TERM': 'linux', 15:42:45 INFO - 'TMOUT': '86400', 15:42:45 INFO - 'USER': 'cltbld', 15:42:45 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:45 INFO - '_': '/tools/buildbot/bin/python'} 15:42:46 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:42:46 INFO - Downloading/unpacking pip>=1.5 15:42:46 INFO - Running setup.py egg_info for package pip 15:42:46 INFO - warning: no files found matching 'pip/cacert.pem' 15:42:46 INFO - warning: no files found matching '*.html' under directory 'docs' 15:42:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:42:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:42:46 INFO - Installing collected packages: pip 15:42:46 INFO - Found existing installation: pip 1.1 15:42:46 INFO - Uninstalling pip: 15:42:46 INFO - Successfully uninstalled pip 15:42:46 INFO - Running setup.py install for pip 15:42:46 INFO - warning: no files found matching 'pip/cacert.pem' 15:42:46 INFO - warning: no files found matching '*.html' under directory 'docs' 15:42:46 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:42:46 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:42:46 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:42:46 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:42:46 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:42:46 INFO - Successfully installed pip 15:42:46 INFO - Cleaning up... 15:42:46 INFO - Return code: 0 15:42:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:46 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:42:46 INFO - Using env: {'DISPLAY': ':0', 15:42:46 INFO - 'HOME': '/home/cltbld', 15:42:46 INFO - 'LANG': 'en_US.UTF-8', 15:42:46 INFO - 'LANGUAGE': 'en_US:en', 15:42:46 INFO - 'LOGNAME': 'cltbld', 15:42:46 INFO - 'MAIL': '/var/mail/cltbld', 15:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:46 INFO - 'MOZ_NO_REMOTE': '1', 15:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:46 INFO - 'NO_EM_RESTART': '1', 15:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:46 INFO - 'PWD': '/builds/slave/test', 15:42:46 INFO - 'SHELL': '/bin/bash', 15:42:46 INFO - 'SHLVL': '1', 15:42:46 INFO - 'TERM': 'linux', 15:42:46 INFO - 'TMOUT': '86400', 15:42:46 INFO - 'USER': 'cltbld', 15:42:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:46 INFO - '_': '/tools/buildbot/bin/python'} 15:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:46 INFO - Downloading/unpacking psutil>=3.1.1 15:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:42:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:47 INFO - Installing collected packages: psutil 15:42:47 INFO - Running setup.py install for psutil 15:42:47 INFO - building 'psutil._psutil_linux' extension 15:42:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:42:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:42:47 INFO - building 'psutil._psutil_posix' extension 15:42:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:42:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:42:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:42:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:42:48 INFO - Successfully installed psutil 15:42:48 INFO - Cleaning up... 15:42:48 INFO - Return code: 0 15:42:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:42: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')]} 15:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42: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')]} 15:42:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:42: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 mozsystemmonitor==0.3 15:42:48 INFO - Using env: {'DISPLAY': ':0', 15:42:48 INFO - 'HOME': '/home/cltbld', 15:42:48 INFO - 'LANG': 'en_US.UTF-8', 15:42:48 INFO - 'LANGUAGE': 'en_US:en', 15:42:48 INFO - 'LOGNAME': 'cltbld', 15:42:48 INFO - 'MAIL': '/var/mail/cltbld', 15:42:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:48 INFO - 'MOZ_NO_REMOTE': '1', 15:42:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:48 INFO - 'NO_EM_RESTART': '1', 15:42:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:48 INFO - 'PWD': '/builds/slave/test', 15:42:48 INFO - 'SHELL': '/bin/bash', 15:42:48 INFO - 'SHLVL': '1', 15:42:48 INFO - 'TERM': 'linux', 15:42:48 INFO - 'TMOUT': '86400', 15:42:48 INFO - 'USER': 'cltbld', 15:42:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:48 INFO - '_': '/tools/buildbot/bin/python'} 15:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:42:49 INFO - Installing collected packages: mozsystemmonitor 15:42:49 INFO - Running setup.py install for mozsystemmonitor 15:42:49 INFO - Successfully installed mozsystemmonitor 15:42:49 INFO - Cleaning up... 15:42:50 INFO - Return code: 0 15:42:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:42:50 INFO - Using env: {'DISPLAY': ':0', 15:42:50 INFO - 'HOME': '/home/cltbld', 15:42:50 INFO - 'LANG': 'en_US.UTF-8', 15:42:50 INFO - 'LANGUAGE': 'en_US:en', 15:42:50 INFO - 'LOGNAME': 'cltbld', 15:42:50 INFO - 'MAIL': '/var/mail/cltbld', 15:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:50 INFO - 'MOZ_NO_REMOTE': '1', 15:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:50 INFO - 'NO_EM_RESTART': '1', 15:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:50 INFO - 'PWD': '/builds/slave/test', 15:42:50 INFO - 'SHELL': '/bin/bash', 15:42:50 INFO - 'SHLVL': '1', 15:42:50 INFO - 'TERM': 'linux', 15:42:50 INFO - 'TMOUT': '86400', 15:42:50 INFO - 'USER': 'cltbld', 15:42:50 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:50 INFO - '_': '/tools/buildbot/bin/python'} 15:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:51 INFO - Downloading/unpacking jsonschema==2.5.1 15:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:42:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:42:52 INFO - warning: no files found matching '*.txt' 15:42:52 INFO - no previously-included directories found matching 'build' 15:42:52 INFO - no previously-included directories found matching 'dist' 15:42:52 INFO - no previously-included directories found matching '.git*' 15:42:52 INFO - Installing collected packages: jsonschema, functools32 15:42:53 INFO - Running setup.py install for functools32 15:42:54 INFO - warning: no files found matching '*.txt' 15:42:54 INFO - no previously-included directories found matching 'build' 15:42:54 INFO - no previously-included directories found matching 'dist' 15:42:54 INFO - no previously-included directories found matching '.git*' 15:42:54 INFO - Successfully installed jsonschema functools32 15:42:54 INFO - Cleaning up... 15:42:54 INFO - Return code: 0 15:42:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:54 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:42:54 INFO - Using env: {'DISPLAY': ':0', 15:42:54 INFO - 'HOME': '/home/cltbld', 15:42:54 INFO - 'LANG': 'en_US.UTF-8', 15:42:54 INFO - 'LANGUAGE': 'en_US:en', 15:42:54 INFO - 'LOGNAME': 'cltbld', 15:42:54 INFO - 'MAIL': '/var/mail/cltbld', 15:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:54 INFO - 'MOZ_NO_REMOTE': '1', 15:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:54 INFO - 'NO_EM_RESTART': '1', 15:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:54 INFO - 'PWD': '/builds/slave/test', 15:42:54 INFO - 'SHELL': '/bin/bash', 15:42:54 INFO - 'SHLVL': '1', 15:42:54 INFO - 'TERM': 'linux', 15:42:54 INFO - 'TMOUT': '86400', 15:42:54 INFO - 'USER': 'cltbld', 15:42:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:54 INFO - '_': '/tools/buildbot/bin/python'} 15:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:42:54 INFO - Cleaning up... 15:42:54 INFO - Return code: 0 15:42:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:54 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:42:54 INFO - Using env: {'DISPLAY': ':0', 15:42:54 INFO - 'HOME': '/home/cltbld', 15:42:54 INFO - 'LANG': 'en_US.UTF-8', 15:42:54 INFO - 'LANGUAGE': 'en_US:en', 15:42:54 INFO - 'LOGNAME': 'cltbld', 15:42:54 INFO - 'MAIL': '/var/mail/cltbld', 15:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:54 INFO - 'MOZ_NO_REMOTE': '1', 15:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:54 INFO - 'NO_EM_RESTART': '1', 15:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:54 INFO - 'PWD': '/builds/slave/test', 15:42:54 INFO - 'SHELL': '/bin/bash', 15:42:54 INFO - 'SHLVL': '1', 15:42:54 INFO - 'TERM': 'linux', 15:42:54 INFO - 'TMOUT': '86400', 15:42:54 INFO - 'USER': 'cltbld', 15:42:54 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:54 INFO - '_': '/tools/buildbot/bin/python'} 15:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:42:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:42:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:42:56 INFO - Downloading docopt-0.6.1.tar.gz 15:42:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:42:56 INFO - Installing collected packages: blobuploader, requests, docopt 15:42:56 INFO - Running setup.py install for blobuploader 15:42:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:42:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:42:56 INFO - Running setup.py install for requests 15:42:57 INFO - Running setup.py install for docopt 15:42:57 INFO - Successfully installed blobuploader requests docopt 15:42:57 INFO - Cleaning up... 15:42:57 INFO - Return code: 0 15:42:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:42:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:42:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:42:57 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:42:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:42:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:42:57 INFO - Using env: {'DISPLAY': ':0', 15:42:57 INFO - 'HOME': '/home/cltbld', 15:42:57 INFO - 'LANG': 'en_US.UTF-8', 15:42:57 INFO - 'LANGUAGE': 'en_US:en', 15:42:57 INFO - 'LOGNAME': 'cltbld', 15:42:57 INFO - 'MAIL': '/var/mail/cltbld', 15:42:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:42:57 INFO - 'MOZ_NO_REMOTE': '1', 15:42:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:42:57 INFO - 'NO_EM_RESTART': '1', 15:42:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:42:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:42:57 INFO - 'PWD': '/builds/slave/test', 15:42:57 INFO - 'SHELL': '/bin/bash', 15:42:57 INFO - 'SHLVL': '1', 15:42:57 INFO - 'TERM': 'linux', 15:42:57 INFO - 'TMOUT': '86400', 15:42:57 INFO - 'USER': 'cltbld', 15:42:57 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:42:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:42:57 INFO - '_': '/tools/buildbot/bin/python'} 15:42:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:42:57 INFO - Running setup.py (path:/tmp/pip-28zAFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:42:57 INFO - Running setup.py (path:/tmp/pip-Qyh1XD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:42:57 INFO - Running setup.py (path:/tmp/pip-Wtcpqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:42:57 INFO - Running setup.py (path:/tmp/pip-tOnjBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:42:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:42:57 INFO - Running setup.py (path:/tmp/pip-UVXib8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:42:58 INFO - Running setup.py (path:/tmp/pip-ApxZim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:42:58 INFO - Running setup.py (path:/tmp/pip-_7rq3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:42:58 INFO - Running setup.py (path:/tmp/pip-aRUnLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:42:58 INFO - Running setup.py (path:/tmp/pip-eEGLWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:42:58 INFO - Running setup.py (path:/tmp/pip-OMfPko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:42:58 INFO - Running setup.py (path:/tmp/pip-mhLpRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:42:58 INFO - Running setup.py (path:/tmp/pip-w3Saxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:42:58 INFO - Running setup.py (path:/tmp/pip-OkUafb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:42:58 INFO - Running setup.py (path:/tmp/pip-8sFYEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:58 INFO - Running setup.py (path:/tmp/pip-yn0zg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:42:58 INFO - Running setup.py (path:/tmp/pip-w0ahzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:42:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:42:58 INFO - Running setup.py (path:/tmp/pip-rbSieu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:42:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:42:58 INFO - Running setup.py install for manifestparser 15:42:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:42:58 INFO - Running setup.py install for mozcrash 15:42:59 INFO - Running setup.py install for mozdebug 15:42:59 INFO - Running setup.py install for mozdevice 15:42:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for mozfile 15:42:59 INFO - Running setup.py install for mozhttpd 15:42:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for mozinfo 15:42:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for mozInstall 15:42:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for mozleak 15:42:59 INFO - Running setup.py install for mozlog 15:42:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for moznetwork 15:42:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:42:59 INFO - Running setup.py install for mozprocess 15:43:00 INFO - Running setup.py install for mozprofile 15:43:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:43:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:43:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:43:00 INFO - Running setup.py install for mozrunner 15:43:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:43:00 INFO - Running setup.py install for mozscreenshot 15:43:00 INFO - Running setup.py install for moztest 15:43:00 INFO - Running setup.py install for mozversion 15:43:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:43:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:43:00 INFO - Cleaning up... 15:43:00 INFO - Return code: 0 15:43:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:00 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:43:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:43:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:43:00 INFO - Using env: {'DISPLAY': ':0', 15:43:00 INFO - 'HOME': '/home/cltbld', 15:43:00 INFO - 'LANG': 'en_US.UTF-8', 15:43:00 INFO - 'LANGUAGE': 'en_US:en', 15:43:00 INFO - 'LOGNAME': 'cltbld', 15:43:00 INFO - 'MAIL': '/var/mail/cltbld', 15:43:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:00 INFO - 'MOZ_NO_REMOTE': '1', 15:43:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:00 INFO - 'NO_EM_RESTART': '1', 15:43:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:00 INFO - 'PWD': '/builds/slave/test', 15:43:00 INFO - 'SHELL': '/bin/bash', 15:43:00 INFO - 'SHLVL': '1', 15:43:00 INFO - 'TERM': 'linux', 15:43:00 INFO - 'TMOUT': '86400', 15:43:00 INFO - 'USER': 'cltbld', 15:43:00 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:43:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:00 INFO - '_': '/tools/buildbot/bin/python'} 15:43:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:43:00 INFO - Running setup.py (path:/tmp/pip-pyw7Op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:43:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:43:00 INFO - Running setup.py (path:/tmp/pip-g3t6fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:43:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:43:01 INFO - Running setup.py (path:/tmp/pip-ejtTEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:43: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)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:43:01 INFO - Running setup.py (path:/tmp/pip-qqyHpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:43: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)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:43:01 INFO - Running setup.py (path:/tmp/pip-tUDT5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:43: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)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:43:01 INFO - Running setup.py (path:/tmp/pip-W84703-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:43:01 INFO - Running setup.py (path:/tmp/pip-fXa55Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:43:01 INFO - Running setup.py (path:/tmp/pip-AOa9tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:43:01 INFO - Running setup.py (path:/tmp/pip-jJRjNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:43:01 INFO - Running setup.py (path:/tmp/pip-Xz5AMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:43:01 INFO - Running setup.py (path:/tmp/pip-qaZHvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:43:01 INFO - Running setup.py (path:/tmp/pip-kvYY2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:43:01 INFO - Running setup.py (path:/tmp/pip-1DQlTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:43:01 INFO - Running setup.py (path:/tmp/pip-FHRjZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:01 INFO - Running setup.py (path:/tmp/pip-SySKzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:43:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:43:02 INFO - Running setup.py (path:/tmp/pip-xFweL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:43: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)) 15:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:43:02 INFO - Running setup.py (path:/tmp/pip-VRd0XT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:43: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)) 15:43: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)) 15:43: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)) 15:43: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)) 15:43: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)) 15:43: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)) 15:43: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)) 15:43:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:03 INFO - Downloading blessings-1.6.tar.gz 15:43:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:43:03 INFO - Installing collected packages: blessings 15:43:03 INFO - Running setup.py install for blessings 15:43:03 INFO - Successfully installed blessings 15:43:03 INFO - Cleaning up... 15:43:03 INFO - Return code: 0 15:43:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:43:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:03 INFO - Reading from file tmpfile_stdout 15:43:03 INFO - Current package versions: 15:43:03 INFO - argparse == 1.2.1 15:43:03 INFO - blessings == 1.6 15:43:03 INFO - blobuploader == 1.2.4 15:43:03 INFO - docopt == 0.6.1 15:43:03 INFO - functools32 == 3.2.3-2 15:43:03 INFO - jsonschema == 2.5.1 15:43:03 INFO - manifestparser == 1.1 15:43:03 INFO - mozInstall == 1.13 15:43:03 INFO - mozcrash == 1.0 15:43:03 INFO - mozdebug == 0.1 15:43:03 INFO - mozdevice == 0.51 15:43:03 INFO - mozfile == 1.2 15:43:03 INFO - mozhttpd == 0.7 15:43:03 INFO - mozinfo == 0.10 15:43:03 INFO - mozleak == 0.1 15:43:03 INFO - mozlog == 3.5 15:43:03 INFO - moznetwork == 0.27 15:43:03 INFO - mozprocess == 0.25 15:43:03 INFO - mozprofile == 0.28 15:43:03 INFO - mozrunner == 6.13 15:43:03 INFO - mozscreenshot == 0.1 15:43:03 INFO - mozsystemmonitor == 0.3 15:43:03 INFO - moztest == 0.8 15:43:03 INFO - mozversion == 1.4 15:43:03 INFO - psutil == 3.1.1 15:43:03 INFO - requests == 1.2.3 15:43:03 INFO - wsgiref == 0.1.2 15:43:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43:03 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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:43:03 INFO - Using env: {'DISPLAY': ':0', 15:43:03 INFO - 'HOME': '/home/cltbld', 15:43:03 INFO - 'LANG': 'en_US.UTF-8', 15:43:03 INFO - 'LANGUAGE': 'en_US:en', 15:43:03 INFO - 'LOGNAME': 'cltbld', 15:43:03 INFO - 'MAIL': '/var/mail/cltbld', 15:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:03 INFO - 'MOZ_NO_REMOTE': '1', 15:43:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:03 INFO - 'NO_EM_RESTART': '1', 15:43:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:03 INFO - 'PWD': '/builds/slave/test', 15:43:03 INFO - 'SHELL': '/bin/bash', 15:43:03 INFO - 'SHLVL': '1', 15:43:03 INFO - 'TERM': 'linux', 15:43:03 INFO - 'TMOUT': '86400', 15:43:03 INFO - 'USER': 'cltbld', 15:43:03 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:03 INFO - '_': '/tools/buildbot/bin/python'} 15:43:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:43:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:43:03 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:43:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:43:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:43: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)) 15:43: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)) 15:43:05 INFO - Installing collected packages: simplejson 15:43:05 INFO - Running setup.py install for simplejson 15:43:05 INFO - building 'simplejson._speedups' extension 15:43: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 15:43: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 15:43:06 INFO - Successfully installed simplejson 15:43:06 INFO - Cleaning up... 15:43:06 INFO - Return code: 0 15:43:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:43:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:43: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 0x23701f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2538b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26dd9c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, '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': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:43: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 15:43: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 15:43:06 INFO - Using env: {'DISPLAY': ':0', 15:43:06 INFO - 'HOME': '/home/cltbld', 15:43:06 INFO - 'LANG': 'en_US.UTF-8', 15:43:06 INFO - 'LANGUAGE': 'en_US:en', 15:43:06 INFO - 'LOGNAME': 'cltbld', 15:43:06 INFO - 'MAIL': '/var/mail/cltbld', 15:43:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:06 INFO - 'MOZ_NO_REMOTE': '1', 15:43:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:06 INFO - 'NO_EM_RESTART': '1', 15:43:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:06 INFO - 'PWD': '/builds/slave/test', 15:43:06 INFO - 'SHELL': '/bin/bash', 15:43:06 INFO - 'SHLVL': '1', 15:43:06 INFO - 'TERM': 'linux', 15:43:06 INFO - 'TMOUT': '86400', 15:43:06 INFO - 'USER': 'cltbld', 15:43:06 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:43:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:06 INFO - '_': '/tools/buildbot/bin/python'} 15:43:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:43:06 INFO - Cleaning up... 15:43:06 INFO - Return code: 0 15:43:06 INFO - Running post-action listener: _resource_record_post_action 15:43:06 INFO - Running post-action listener: _start_resource_monitoring 15:43:06 INFO - Starting resource monitoring. 15:43:06 INFO - [mozharness: 2017-09-24 22:43:06.428867Z] Finished create-virtualenv step (success) 15:43:06 INFO - [mozharness: 2017-09-24 22:43:06.429384Z] Running install step. 15:43:06 INFO - Running pre-action listener: _resource_record_pre_action 15:43:06 INFO - Running main action method: install 15:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:43:06 INFO - Reading from file tmpfile_stdout 15:43:06 INFO - Detecting whether we're running mozinstall >=1.0... 15:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:43:06 INFO - Reading from file tmpfile_stdout 15:43:06 INFO - Output received: 15:43:06 INFO - Usage: mozinstall [options] installer 15:43:06 INFO - Options: 15:43:06 INFO - -h, --help show this help message and exit 15:43:06 INFO - -d DEST, --destination=DEST 15:43:06 INFO - Directory to install application into. [default: 15:43:06 INFO - "/builds/slave/test"] 15:43:06 INFO - --app=APP Application being installed. [default: firefox] 15:43:06 INFO - mkdir: /builds/slave/test/build/application 15:43:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:43:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:43:24 INFO - Reading from file tmpfile_stdout 15:43:24 INFO - Output received: 15:43:24 INFO - /builds/slave/test/build/application/firefox/firefox 15:43:24 INFO - Running post-action listener: _resource_record_post_action 15:43:24 INFO - [mozharness: 2017-09-24 22:43:24.589747Z] Finished install step (success) 15:43:24 INFO - [mozharness: 2017-09-24 22:43:24.589998Z] Running setup-mitmproxy step. 15:43:24 INFO - Running pre-action listener: _resource_record_pre_action 15:43:24 INFO - Running main action method: setup_mitmproxy 15:43:24 INFO - Skipping: mitmproxy is not required 15:43:24 INFO - Running post-action listener: _resource_record_post_action 15:43:24 INFO - [mozharness: 2017-09-24 22:43:24.591128Z] Finished setup-mitmproxy step (success) 15:43:24 INFO - [mozharness: 2017-09-24 22:43:24.591362Z] Running run-tests step. 15:43:24 INFO - Running pre-action listener: _resource_record_pre_action 15:43:24 INFO - Running pre-action listener: _set_gcov_prefix 15:43:24 INFO - Running main action method: run_tests 15:43:24 WARNING - Try message not found. 15:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:43:24 INFO - Python 2.7.3 15:43:24 INFO - Return code: 0 15:43:24 INFO - grabbing minidump binary from tooltool 15:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:43:24 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 0x26dad60>, '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 0x26dba60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26dbef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:43:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:43:24 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:43:24 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:43:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:43:24 INFO - Return code: 0 15:43:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:43:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:43:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:43:24 INFO - ENV: RUST_BACKTRACE is now full 15:43:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:43:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:43:24 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/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 15:43:24 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/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 15:43:24 INFO - Using env: {'DISPLAY': ':0', 15:43:24 INFO - 'HOME': '/home/cltbld', 15:43:24 INFO - 'LANG': 'en_US.UTF-8', 15:43:24 INFO - 'LANGUAGE': 'en_US:en', 15:43:24 INFO - 'LOGNAME': 'cltbld', 15:43:24 INFO - 'MAIL': '/var/mail/cltbld', 15:43:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:24 INFO - 'MOZ_NO_REMOTE': '1', 15:43:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:24 INFO - 'NO_EM_RESTART': '1', 15:43:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:24 INFO - 'PWD': '/builds/slave/test', 15:43:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:24 INFO - 'RUST_BACKTRACE': 'full', 15:43:24 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:24 INFO - 'SHELL': '/bin/bash', 15:43:24 INFO - 'SHLVL': '1', 15:43:24 INFO - 'TERM': 'linux', 15:43:24 INFO - 'TMOUT': '86400', 15:43:24 INFO - 'USER': 'cltbld', 15:43:24 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:24 INFO - '_': '/tools/buildbot/bin/python'} 15:43:24 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/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 15:43:24 INFO - mozversion application_buildid: 20170924215115 15:43:24 INFO - mozversion application_changeset: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 15:43:24 INFO - mozversion application_display_name: Nightly 15:43:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:43:24 INFO - mozversion application_name: Firefox 15:43:24 INFO - mozversion application_remotingname: firefox 15:43:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:43:24 INFO - mozversion application_vendor: Mozilla 15:43:24 INFO - mozversion application_version: 58.0a1 15:43:24 INFO - mozversion platform_buildid: 20170924215115 15:43:24 INFO - mozversion platform_changeset: d9cfaad3b11ef5cde2a55782ad67aa7eb5fd55e4 15:43:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:43:24 INFO - mozversion platform_version: 58.0a1 15:43:24 INFO - using testdate: 1506293004 15:43:24 INFO - actual date: 1506293004 15:43:24 INFO - starting webserver on 'localhost:36105' 15:43:24 INFO - SUITE-START | Running 2 tests 15:43:24 INFO - TEST-START | dromaeo_css 15:43:24 INFO - Initialising browser for dromaeo_css test... 15:43:24 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36105/getInfo.html -profile /tmp/tmpBKp6L_/profile 15:43:24 INFO - TEST-INFO | started process 6520 (/builds/slave/test/build/application/firefox/firefox http://localhost:36105/getInfo.html) 15:43:31 INFO - TEST-INFO | 6520: exit 0 15:43:31 INFO - Browser initialized. 15:43:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:43:31 INFO - Using env: {'DISPLAY': ':0', 15:43:31 INFO - 'HOME': '/home/cltbld', 15:43:31 INFO - 'JSGC_DISABLE_POISONING': '1', 15:43:31 INFO - 'LANG': 'en_US.UTF-8', 15:43:31 INFO - 'LANGUAGE': 'en_US:en', 15:43:31 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:43:31 INFO - 'LOGNAME': 'cltbld', 15:43:31 INFO - 'MAIL': '/var/mail/cltbld', 15:43:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:43:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:43:31 INFO - 'MOZ_CRASHREPORTER': '1', 15:43:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:43:31 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:43:31 INFO - 'MOZ_NO_REMOTE': '1', 15:43:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:43:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:43:31 INFO - 'NO_EM_RESTART': '1', 15:43:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:43:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:43:31 INFO - 'PWD': '/builds/slave/test', 15:43:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:43:31 INFO - 'RUST_BACKTRACE': 'full', 15:43:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:43:31 INFO - 'SHELL': '/bin/bash', 15:43:31 INFO - 'SHLVL': '1', 15:43:31 INFO - 'STYLO_FORCE_DISABLED': '1', 15:43:31 INFO - 'TERM': 'linux', 15:43:31 INFO - 'TMOUT': '86400', 15:43:31 INFO - 'USER': 'cltbld', 15:43:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 15:43:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:43:31 INFO - '_': '/tools/buildbot/bin/python'} 15:43:31 INFO - TEST-INFO | started process 6755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBKp6L_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:32 INFO - PID 6755 | 15:43:32 INFO - PID 6755 | (/builds/slave/test/build/application/firefox/firefox:6805): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:43:32 INFO - PID 6755 | 15:43:42 INFO - PID 6755 | RSS: Main: 151842816 15:43:42 INFO - PID 6755 | 15:46:39 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36105/tests/dromaeo/cssquery-ext.html) 15:46:40 INFO - PID 6755 | RSS: Main: 153141248 15:46:40 INFO - PID 6755 | 15:49:42 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-ext.html (next: http://localhost:36105/tests/dromaeo/cssquery-jquery.html) 15:49:42 INFO - PID 6755 | RSS: Main: 151511040 15:49:42 INFO - PID 6755 | 15:52:44 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36105/tests/dromaeo/cssquery-mootools.html) 15:52:45 INFO - PID 6755 | RSS: Main: 155435008 15:52:45 INFO - PID 6755 | 15:55:46 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36105/tests/dromaeo/cssquery-prototype.html) 15:55:47 INFO - PID 6755 | RSS: Main: 153702400 15:55:47 INFO - PID 6755 | 15:58:50 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36105/tests/dromaeo/cssquery-yui.html) 15:58:51 INFO - PID 6755 | RSS: Main: 154509312 15:58:51 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | Cycle 1(1): loaded http://localhost:36105/tests/dromaeo/cssquery-yui.html (next: http://localhost:36105/tests/dromaeo/cssquery-dojo.html) 16:01:52 INFO - PID 6755 | RSS: Main: 157913088 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | __start_tp_report 16:01:52 INFO - PID 6755 | _x_x_mozilla_page_load 16:01:52 INFO - PID 6755 | _x_x_mozilla_page_load_details 16:01:52 INFO - PID 6755 | |i|pagename|runs| 16:01:52 INFO - PID 6755 | |0;dojo.html;3103.767217458691;3123.1411361875466;3123.437781199384;3125.687431256875;3149.2599239178794;6198.78304259351;6213.689315534222;6256.56204065715;6259.155014073111;6353.1105645209645;6255.718492667829;6265.310815810257;6273.153124328214;6312.305646378894;6312.589681670688;5762.4525670061275;5767.33675627304;5828.1549175369755;5852.473277405033;5953;5868;5869.178315035877;5897.41025897409;5912.9704351478185;5953.047512397996;54.911052810487135;5672.517835983905;5779.537636989031;5831.212786273863;5864.853378665546;5350.625456218067;5685.914711279334;5737.942620573783;5833.591648584601;5837;5759.452851979056;5766.279215098113;5823.737931793079;5824.592278540504;5837.766489340422;6212.565120441571;6319.968400158015;6321.209848768904;6396.392342727433;6398.29618741938;6711.731530738764;6770.356816102462;6834;6844.760433384808;6862.965685171542;6642.867142657168;6745.494087943423;6773.830654233634;6841.486888483384;6906.965465172692;6317.93682063178;6321.968390158066;6338.144350512668;6339.36606339367;6341.682915854235;6935.445164386887;6983;7076.363127318566;7078;7084.964575177194;6668.766593169313;6680.632565208863;6746.0892779475125;6749.5612785168805;6753.797386078426;6611.173603299588;6709.161354830646;6714.093597364391;6779.017042528904;6875.5874647521305;6682.599044057372;6690.13028306317;6697.933020669829;6724.092247546617;6839.794806155824;6758.391744742997;6871.244163142051;6876.793696189123;6894.345037221456;6901.585904845725;5282.630215884851;5292.153255479182;5359.3032905722785;5360.892782144335;5366.6243362964215;4510.887227819265;4607.285870690049;4616.330632058332;4619.630429565626;4623.075384922961;5734.971325143431;5737.139429085671;5802.94197058024;5812.680302583314;5837.474627283565;6824.078749368871;6826.692798824065;6859.07402500666;6928.61892595902;6944.479164062715;5786.04530252512;5806.4193580641595;5856.795012174553;5887.175795388649;5887.470127688529;5720.799772008043;5772.249607550992;5819.70901454934;5845.561582881301;5899.882002360015;6497.317781632955;6596.274409814917;6600.1089852869245;6601.900971485432;6602.207735071726;6810.62541560219;6819.045333653293;6927.064846245692;6927.134108236471;6927.6882540286815;6538.574992625464;6575.210974683068;6580.243272023587;6660.10088638047;6686.732530698718;6492.220933488012;6586.637734924625;6690.632015239208;6773.322667733188;6785.253622101466;6791.0832037676255;6844.657767111724;6874.312568743286;6878.7248510059035;6883.449324053963;6578.506612004023;6607.240167380813;6673.733050677918;6681.899771503528;6683.966580167263;6578.24350199714;6599.373059559334;6611.272759996493;6680.565763225375;6695.163104611924;6376.521760868046;6540.607563546202;6608.4052435281055;6634.668266586555;6635.767748128792;6582.407583317525;6642.501812363996;6661.433778128913;6705.161854768154;6738.393544581011;6227.688615569294;6357.8728425432155;6375.968120159369;6454.548181627241;6461.8061458156335 16:01:52 INFO - PID 6755 | |1;ext.html;851.7444766570028;858.3347905373339;864.9783755406114;875.5709702245902;884.6770928611058;39383.80308098459;39898.20203595934;39948.20103597926;39996.800015999914;40062.59937400625;38439.807800961025;38516.61483385165;38752.224955500875;38837;38892;7144.07127073481;7255.782326530212;7257.165425976001;7262.946872703455;7263.963680181591;6997.580145191305;7027.47293952953;7074.186468556105;7080.716771329141;7081.114860642419;7044.154701435835;7861.21387861215;8047.275745182932;8054.556999365032;8055.395845311625;7952.960235198845;7953.681852725884;7997.440179187459;7999.360051195919;8000.439969202187;7824.882626760603;7917.366610671133;7922.04935407749;7930.1276859545405;7934.127246002935;36370;36540.81729591335;36859.815700921325;36948.815255923546;36966.445503317475;3499.230169362736;3559.039059453933;3560.3769340365334;3562.87529936451;3563.9109022274392;30520.084397468112;30585.08244752661;30637.693623063707;30678;30688;5075.492450754932;5106.4638212987475;5110.437851836295;5121.948780512184;5166.948330516684;185327;185625;186171;186225;186522;42831.357529637084;43234.351484727755;47921.28118078232;48726.756366217945;48727;50473;50560.494395055575;50654.24018639723;50756.23865642018;50852;15878.364865405485;16001.119938403266;16058.678826423406;16062.357505699874;16076.678466430605;12916.41876115577;13108.475660973645;13110.278934658685;13166.539171129156;13204.075714699879;13854.653633659038;13901.16593004423;13996.650083747987;14033.368498417596;14088.577342679737;5637.267155269788;5705.5720820938595;5749;5810.82567522975;5833.562482813806;988.2884323287221;995.2038369304528;998.0418797954045;1002.5538635307219;1007.5717819926502;22116.889415552818;22748.20381286647;22754.886225568767;23007.769922300897;23097.53804923892;1088.3089238333557;1092.5138313450598;1096.1011970184531;1106.6126855600637;1116.776644671069;11910.46402911871;11911.642650720492;12163.474709237204;12195.19495550147;12240.204386714835;206604;208704;218477;219272;220040;51255.487445125815;51453.228201577;51692.22461663078;51729.48270517322;51792.22311665328;1424.3519198764536;1465.1136062682137;1485.1089346392293;1485.532057401915;1486.5688950204535;22669.546609067398;22934.31197064091;22970.885145574164;23021.769782302632;23080.884595576914;36678;36763.816180918926;36838.63161368352;36881;36924.44613330749;192659;193258;193901;194416;195338;30393.24016899595;30941.381172376878;32573.837130814194;33573.16067098244;34320.31359372848;43206.351904720825;43315.133697326506;43321.56678433175;43988.78005609952;44020.33969490524;32213.677863221066;32290;32563.674363256065;32671.509927350635;32792.836035819666;30795.69204308018;31735.84132079325;31801.522977155822;32043.679563205;32432.189195270308;35664.28671426609;35750.46374304336;35845.28309433849;36085.27829443344;36162.276754464234;31200;31259.84370078135;31557.211069723442;31571.842140789147;31740.841295793372;23139.3058208254;23208.883955580113;23599.29202123939;24048.87975560181;24066 16:01:52 INFO - PID 6755 | |2;jquery.html;589.6049646736686;592.3543337761839;599.6671847124844;601.5157797972631;628.1488582970077;22450.775492245073;23228.535429291405;23259.953302101403;23260.18589349373;23282.18512352068;23088.191913283037;25684.486310273784;25946.48107037858;25950;25988;6756.729730810774;6868.587884726932;6906.274841141683;6912.792616221496;6920.930790692079;6545.869082618345;6734.730610775563;6811.693473793691;6840.828979275509;6844.212915514705;6790.5925644461495;6795.830104247384;6799.082123913283;6801.93198068018;6803.931960680379;6728.966355168192;6750.257471678112;6794.286599906988;6803.523753337268;6813.284605116441;6296.685165741695;6700.93299067008;6960.9651951740425;6987.371136597731;7006.474514411389;30341.634626441864;31142.688573114207;31148;31172.688273117434;31173.064808055795;2042.2749923776994;2061.9690704639443;2069.98965005174;2080.916763329465;2090.2997495838913;20984.580308393746;21167.894160529253;21643.78356216449;21804.781952180594;21933;2436.719777225624;2444.1201167579834;2499.9500009999697;2523.2808649534977;2537.0739680016845;122927;128627;139817.30091349478;142840.28579857034;149144.254278729;19554.413367598994;21402.464938376666;21691.566168676854;22347.888260558593;23093.653595196087;43695.78152109219;43987.120257594666;44022.559774402485;44029.33955990663;44100.55899441029;11232.550697972152;11419.828702569468;11476.19666623345;11487.597934072435;11489.253198542068;9388.295877809192;9425.38734982224;9434.528273586293;9446.244300455946;9603.47180905043;11654.892785185393;11663.59177428786;11885.88114118865;12053.0960177987;12081.275123492618;3971.8283106483655;4287.849925252601;4306.267934451088;4343.739375637472;4401.559844015637;954.117441366733;974.1622204903778;978.9853152202722;992.2954702161402;995.3679413572289;19661.90169049174;19690;20107.899460502606;20440.977951102384;20550.691739623617;1037.7613148975627;1049.41757324684;1049.7270709615402;1051.8264486359817;1055.4300677633992;11133.332000080021;11185.66443006711;11273.492692828842;11306.208565400508;11434.199606027498;427639;436296;439607;443735;447458;112136;113969;115537.4223128879;115575.42212289052;115910;1144.6909334479644;1160.1356989043047;1183.230899915062;1185.5613423033533;1185.6680129563736;17881.642367152843;18285.26858925681;18350.541236469195;18354.63290734151;18375.26498940081;54753.726231368586;54943;56004.43995559992;56651.58371040757;58202.708986454796;70495;70836;70859.64570177117;70913;71362;20101.195952162336;20593;20660.173593056712;20749.066292016592;20756.06597703077;22637;22877.542449151257;22935.541289174456;23040.769592303863;23121.537569248183;15900.204989750697;16238.188090595188;16268.430604928772;18473.630527389647;18556.2577496904;16050.197490125214;16072.839271607134;16321.265543050355;16586.08776517303;17447.214875330388;18118.09409529492;18510;18780;18824.96462694565;18869.339573114874;20185.09167087514;20198;20296.59406811885;20344.186232551125;20357;18173;18208.81791182071;18260.634787303912;18735.156917938453;18747.343842965976 16:01:52 INFO - PID 6755 | |3;mootools.html;1313.730685209532;1388.2156581531428;1413.9151650900947;1415.7522433574122;1417.6739349949512;15063.472778452757;15692.058476491418;15702.293396797142;15711.45009924653;15732;15300.464483743071;15351.232438378065;15370.154641494713;15404.306806193721;15411.306491207895;2807.564827451738;2861.399106187703;2878.1077865861544;2904.244896326949;2910.8253504789673;2806.424682939992;2815.6621205455376;2825.2654309879476;2834.376437183816;2836.8297902125837;2779.207925741164;2786.2477131174674;2794.5109605818902;2886.177439429763;2895.666998295202;2806.7193280671872;2856.1146044726097;2856.11460447262;2857.0714517781803;2857.628508293919;2705.391286960438;2708.1469337158733;2739;2751.3534319435116;2763.9723602763916;15021.098734075991;15085.849141508554;15105.39578416862;15122.470713524974;15156.1664108474;8054.073781515142;8171.836563268761;8227.506349619041;8299.419040667155;8299.875501867476;5201;5429;5546.334439867202;5558.666480011212;5559.138333558264;1835.8898466092078;1838.108517369075;1860.3302810988034;1898.0509745127436;1932.062949469506;26798.866005670043;26892.59661105085;27047.59428608553;27069.458610827674;27154.049608263616;6902.482313826483;7031.718731250795;7055.541389809646;7215.963920180366;7232.349088581947;17333;17442.040687762295;17508.037057961934;17575.296988120586;17622.647547048986;8126.065502467174;8273.255407013277;8274.544900030556;8295.336373090138;8299.460535065202;7268;7528.661210245552;7608.429367797326;7640.388768898475;7665.6550455228535;5216.21756736485;5336.573074154058;5411.648242864201;5471.7264136793;5480.479354461319;1557.392616879418;1557.5015994881755;1561.7813506109153;1574.480421460915;1597.0657165558046;876.5748611923212;881.4006475596527;892.6563273139758;898.3307435960252;900.2348004196381;7209.711611535585;8341.499510029418;8362.163783621589;8427.030891447563;8534.829303413897;715.6636380900968;718.192033961793;721.1706537481938;725.992740072603;726.5931078596003;4778.593819525379;5220.504052115043;5313.256144139824;5320.414754377015;5519.116941289374;21483;22506;22535;22748.65877011846;22837.657435138488;21438.356849294545;21616.43808249016;22115.447113822283;22522;22595.322140335815;11339.546418143347;11459.025982791389;11468.655940321803;11553.595624153115;11597.18819682614;8236.052853921636;8308.916910830814;8382.245597896219;8411.11683273272;8562.443441176303;18184.90907545454;18935.810641893957;19000.23999040023;19229.8077019228;19263.51841203981;19045.809541904404;19489.317873874345;19518;19606.60786784285;19694.606107878048;10871.836922446328;11095.833562496407;11120.888791111985;11137;11147.55409783632;13559.389827457986;13655.658608534866;13670.863291366959;13747.931260343634;13779.517716879862;10823.188260880308;11225.214235003798;11321.09431245482;11361.943190283995;11457.427128643702;10965;11002.064824490008;11183.832242516532;11301.830472542753;11445.599404020819;10002.599896004078;10043.497825108861;10061;10233.181345492194;10236.027577380137;7277.199508054004;7420.146683131293;7447.292507211806;7493.250674932681;7499.550026998398;7157.606331651601;7195.820104497429;7274.818129546804;7320.487565870338;7324.267573242846 16:01:52 INFO - PID 6755 | |4;prototype.html;504.6240845098076;524.3707550938874;532.9382696409131;533.5115029068895;535.290739769805;6361.618302901829;6382.5532212745065;6406.03909413587;6421.29365769765;6477.643729594871;6250.749970001206;6280.85463594028;6288.8742225155465;6293.370662933716;6329.525285603575;5195.714235717034;5214.8696282592955;5230.189320655286;5239.161734122541;5270.288511050997;4881.170201065809;4977.50224977503;5219.817306394277;5221.608379371543;5233.162693968966;5006.949930500703;5030.446650868402;5058.924116138242;5065.924011139836;5073.568746656539;4945.67853089548;4987.401511818569;5019.3976722793495;5045.293658887758;5062.772175252123;4447.177272204653;4478.664100192498;4493.618042466394;4511.300748384006;4522.977385113087;6049.939500604982;6067.635941843503;6154.446099851035;6163.537734669872;6182.752689892399;5694.971525142348;5757.568182386296;5764.8847023059725;5795.565332600029;5801.854953626151;6566.441852442548;6627.105340778981;6681.832954176184;6685.899711504331;6688.799336019927;4872.537108974641;4983.800647974077;4986.700797952134;4989.875253118665;4990.0269447457395;6631.204255489372;6694.397504224595;6878.8624227515165;6883.074693255347;6892.758753443655;5082.237664350377;5098.770555325019;5106.4382917879;5120.743962801845;5128.461511541309;5162.896742065138;5169.224616307584;5179.171332586843;5182;5189.55888749453;5785.247917770663;5839.854003649858;5844.298684157843;5852.180694702745;5854.912176317359;6620.933790662032;6636.601803891782;6645.102911107036;6668.433183179484;6711.295313992058;1755.859531237498;1773.5300145461463;1776.4049043570549;1778.968198444899;1784.3933062758724;1216.7701416688776;1252.9310887901254;1257.2959142880015;1261.962141135749;1263.7472505498938;5610.747516361774;5645.266115404971;5656.660600363992;5691;5695.886082278331;6614.404703576702;6745;6753.898691519631;6798.898016529756;6829.863402731918;5649.6327738696855;5737.88524229513;5773.538116950718;5813.854653633608;5822.650640961471;3508.210652603144;3586.336527742376;3608.530890984155;3621.8370173342264;3646.507721457622;6480.708368123445;6507.772227971998;6560.245571759213;6585.440237579764;6596.437923521341;6862.725490980305;6997.370236678723;6998.915168148945;7005.50961432705;7051.400630946427;6544.640044797582;6573.704183311763;6580.243272023683;6584.1440612721;6608.372204640552;6738.764143254963;6788;6803;6856.9314306856295;6859.828504287433;6605.933940660532;6657.667116644052;6770.255271919987;6778.423833974168;6790.72837086511;6418.326075761977;6508.642024688687;6521.5108866834225;6568.901466477911;6592;4977.950220497749;5018.874528136826;5052.343195384577;5086.21163719624;5114.232865070269;6559.6064236145985;6752.831179220559;6779.8983015253825;6815.318468153145;6848.589084654936;6219.315875253628;6540.117084193763;6608.339166083353;6632.30360812127;6654.900176497454;6482.481401487776;6506.316836732075;6539.574927629689;6597.736090556324;6609.239937407067;6301.873962520815;6458.38645328693;6474.320196379313;6542;6620.404163625297;6440.420362167428;6696.464282857262;6696.497762667722;6704.765333213314;6708.396244337838;6284.4344009039405;6312.274088479883;6380.712867920862;6388.4569811566535;6430.3891130342545 16:01:52 INFO - PID 6755 | |5;yui.html;867;903.6701603914573;908.0964440381821;915.3546749541574;921.5069937583394;17944.820551794495;18658.906705466452;18677.719834202482;18706.06469676514;18756.62486750264;18457.2617095316;18622.162002709876;19029.333973310902;19342.12960416781;19513.609727805437;952.8951815300329;964.0985678390728;967.7580604848788;968.1867231525517;968.7190714692766;961.4952150121172;975.9560819763128;985.8767654043245;985.9950700246488;986.6694657289817;1028.4703377760422;1029.6653587584028;1030.6804890483936;1031.0617338222219;1031.7162780235458;1013.8023085498331;1022.6983040003217;1026.856240126383;1027.681418760183;1030.9947800894142;727.287258486686;738.7635956493924;749.9062617172854;750.2572453271222;752.5785560086315;20457;20502.282420115225;20557.177712891465;20699.379018629465;20709.27517536894;21857.234996775038;22029.779702202934;22594.774052259432;22809.657855132187;22864.085436582518;17592;17853.7321940171;17861.196246168824;18084.819151808446;18086.728699069394;3757.135858752475;3770.3590389633555;3777.2067865748227;3780.017195529182;3781.5084039074745;130541.08376748807;139765;140059;141024;146013;16530.0908450034;16636.251368688438;16863.91568042152;16872.325106995828;16884;29691.85154074216;29839;29940.550891736642;29949.700502995125;30005.849970750005;8392.832143357098;8510.872336914952;8529.147085291544;8538.829223415496;8543.444676096035;3838.616138386139;3859.498265225559;3892.8832135035996;3921.8823435296986;3933.0757272041046;5371.516563509303;5472.425395333512;5474.042042642522;5486.533644640171;5494.066008778517;989.5151375825793;1021.7139201023725;1028.8456731490187;1031.1132426113536;1033.0857191385678;675;703.855709579535;705.5731282574071;708.7342246657504;718.8706032914125;11806.704832379088;11972;12052;12503.937480312541;13094.869051309555;694.191267173737;697.9828296223917;698.769406095987;698.8951657251453;710.7512370670328;5656.8868622627315;5707.828765136969;5708.115242137475;5785.363610002896;5789.768409263583;120435;123609.38195309146;124829;126941.36529317294;127232;111358.44320778507;112528;115424.42287788675;116030;116719;89984.5500772505;92361;92580.53709731543;96493.51753241329;96659;10745.355278683304;10760.139188864716;10888.61889833852;11051.392173430217;11075.944620276847;44843.55156448524;45035.32447013363;45627.54372456233;47778.522214777404;47957;58166.4183358161;58196;58701.412985869596;59351;60828.391716082275;15262.923685381502;15497.690046199239;15600.453984110502;15663.216839158224;15679.686406271583;17089.31642734277;17392.739108913123;17447.738283925497;17592.29630814804;17593.472195834147;16211.918940405223;16419.753703694216;16503.09232992149;16670;16674.16629168561;15373.923130384277;15684.41207200799;15714.9214253928;15850.207489625704;15928;15267.618309541906;15508.5347439577;15535.300911458786;15641.765373519635;15660.451884184455;10567.260291779809;10585.100266477435;10769.569217231536;10876.456177191267;10885.23803333759;11148.888511114785;11154.72113197144;11158.386288754196;11171.888281117084;11453.167493201048 16:01:52 INFO - PID 6755 | __end_tp_report 16:01:52 INFO - PID 6755 | __start_cc_report 16:01:52 INFO - PID 6755 | _x_x_mozilla_cycle_collect,287 16:01:52 INFO - PID 6755 | __end_cc_report 16:01:52 INFO - PID 6755 | __startTimestamp1506294112915__endTimestamp 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | ------- Summary: start ------- 16:01:52 INFO - PID 6755 | Number of tests: 6 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#0] dojo.html Cycles:165 Average:6199.08 Median:6497.32 stddev:908.29 (14.0%) stddev-sans-first:878.02 16:01:52 INFO - PID 6755 | Values: 3103.8 3123.1 3123.4 3125.7 3149.3 6198.8 6213.7 6256.6 6259.2 6353.1 6255.7 6265.3 6273.2 6312.3 6312.6 5762.5 5767.3 5828.2 5852.5 5953.0 5868.0 5869.2 5897.4 5913.0 5953.0 54.9 5672.5 5779.5 5831.2 5864.9 5350.6 5685.9 5737.9 5833.6 5837.0 5759.5 5766.3 5823.7 5824.6 5837.8 6212.6 6320.0 6321.2 6396.4 6398.3 6711.7 6770.4 6834.0 6844.8 6863.0 6642.9 6745.5 6773.8 6841.5 6907.0 6317.9 6322.0 6338.1 6339.4 6341.7 6935.4 6983.0 7076.4 7078.0 7085.0 6668.8 6680.6 6746.1 6749.6 6753.8 6611.2 6709.2 6714.1 6779.0 6875.6 6682.6 6690.1 6697.9 6724.1 6839.8 6758.4 6871.2 6876.8 6894.3 6901.6 5282.6 5292.2 5359.3 5360.9 5366.6 4510.9 4607.3 4616.3 4619.6 4623.1 5735.0 5737.1 5802.9 5812.7 5837.5 6824.1 6826.7 6859.1 6928.6 6944.5 5786.0 5806.4 5856.8 5887.2 5887.5 5720.8 5772.2 5819.7 5845.6 5899.9 6497.3 6596.3 6600.1 6601.9 6602.2 6810.6 6819.0 6927.1 6927.1 6927.7 6538.6 6575.2 6580.2 6660.1 6686.7 6492.2 6586.6 6690.6 6773.3 6785.3 6791.1 6844.7 6874.3 6878.7 6883.4 6578.5 6607.2 6673.7 6681.9 6684.0 6578.2 6599.4 6611.3 6680.6 6695.2 6376.5 6540.6 6608.4 6634.7 6635.8 6582.4 6642.5 6661.4 6705.2 6738.4 6227.7 6357.9 6376.0 6454.5 6461.8 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#1] ext.html Cycles:180 Average:36517.55 Median:3563.39 stddev:51354.03 (1441.2%) stddev-sans-first:51428.26 16:01:52 INFO - PID 6755 | Values: 851.7 858.3 865.0 875.6 884.7 39383.8 39898.2 39948.2 39996.8 40062.6 38439.8 38516.6 38752.2 38837.0 38892.0 7144.1 7255.8 7257.2 7262.9 7264.0 6997.6 7027.5 7074.2 7080.7 7081.1 7044.2 7861.2 8047.3 8054.6 8055.4 7953.0 7953.7 7997.4 7999.4 8000.4 7824.9 7917.4 7922.0 7930.1 7934.1 36370.0 36540.8 36859.8 36948.8 36966.4 3499.2 3559.0 3560.4 3562.9 3563.9 30520.1 30585.1 30637.7 30678.0 30688.0 5075.5 5106.5 5110.4 5121.9 5166.9 185327.0 185625.0 186171.0 186225.0 186522.0 42831.4 43234.4 47921.3 48726.8 48727.0 50473.0 50560.5 50654.2 50756.2 50852.0 15878.4 16001.1 16058.7 16062.4 16076.7 12916.4 13108.5 13110.3 13166.5 13204.1 13854.7 13901.2 13996.7 14033.4 14088.6 5637.3 5705.6 5749.0 5810.8 5833.6 988.3 995.2 998.0 1002.6 1007.6 22116.9 22748.2 22754.9 23007.8 23097.5 1088.3 1092.5 1096.1 1106.6 1116.8 11910.5 11911.6 12163.5 12195.2 12240.2 206604.0 208704.0 218477.0 219272.0 220040.0 51255.5 51453.2 51692.2 51729.5 51792.2 1424.4 1465.1 1485.1 1485.5 1486.6 22669.5 22934.3 22970.9 23021.8 23080.9 36678.0 36763.8 36838.6 36881.0 36924.4 192659.0 193258.0 193901.0 194416.0 195338.0 30393.2 30941.4 32573.8 33573.2 34320.3 43206.4 43315.1 43321.6 43988.8 44020.3 32213.7 32290.0 32563.7 32671.5 32792.8 30795.7 31735.8 31801.5 32043.7 32432.2 35664.3 35750.5 35845.3 36085.3 36162.3 31200.0 31259.8 31557.2 31571.8 31740.8 23139.3 23208.9 23599.3 24048.9 24066.0 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#2] jquery.html Cycles:180 Average:34642.60 Median:22757.27 stddev:74501.35 (327.4%) stddev-sans-first:74666.47 16:01:52 INFO - PID 6755 | Values: 589.6 592.4 599.7 601.5 628.1 22450.8 23228.5 23260.0 23260.2 23282.2 23088.2 25684.5 25946.5 25950.0 25988.0 6756.7 6868.6 6906.3 6912.8 6920.9 6545.9 6734.7 6811.7 6840.8 6844.2 6790.6 6795.8 6799.1 6801.9 6803.9 6729.0 6750.3 6794.3 6803.5 6813.3 6296.7 6700.9 6961.0 6987.4 7006.5 30341.6 31142.7 31148.0 31172.7 31173.1 2042.3 2062.0 2070.0 2080.9 2090.3 20984.6 21167.9 21643.8 21804.8 21933.0 2436.7 2444.1 2500.0 2523.3 2537.1 122927.0 128627.0 139817.3 142840.3 149144.3 19554.4 21402.5 21691.6 22347.9 23093.7 43695.8 43987.1 44022.6 44029.3 44100.6 11232.6 11419.8 11476.2 11487.6 11489.3 9388.3 9425.4 9434.5 9446.2 9603.5 11654.9 11663.6 11885.9 12053.1 12081.3 3971.8 4287.8 4306.3 4343.7 4401.6 954.1 974.2 979.0 992.3 995.4 19661.9 19690.0 20107.9 20441.0 20550.7 1037.8 1049.4 1049.7 1051.8 1055.4 11133.3 11185.7 11273.5 11306.2 11434.2 427639.0 436296.0 439607.0 443735.0 447458.0 112136.0 113969.0 115537.4 115575.4 115910.0 1144.7 1160.1 1183.2 1185.6 1185.7 17881.6 18285.3 18350.5 18354.6 18375.3 54753.7 54943.0 56004.4 56651.6 58202.7 70495.0 70836.0 70859.6 70913.0 71362.0 20101.2 20593.0 20660.2 20749.1 20756.1 22637.0 22877.5 22935.5 23040.8 23121.5 15900.2 16238.2 16268.4 18473.6 18556.3 16050.2 16072.8 16321.3 16586.1 17447.2 18118.1 18510.0 18780.0 18825.0 18869.3 20185.1 20198.0 20296.6 20344.2 20357.0 18173.0 18208.8 18260.6 18735.2 18747.3 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#3] mootools.html Cycles:180 Average:9475.95 Median:14931.10 stddev:6798.67 (45.5%) stddev-sans-first:6790.08 16:01:52 INFO - PID 6755 | Values: 1313.7 1388.2 1413.9 1415.8 1417.7 15063.5 15692.1 15702.3 15711.5 15732.0 15300.5 15351.2 15370.2 15404.3 15411.3 2807.6 2861.4 2878.1 2904.2 2910.8 2806.4 2815.7 2825.3 2834.4 2836.8 2779.2 2786.2 2794.5 2886.2 2895.7 2806.7 2856.1 2856.1 2857.1 2857.6 2705.4 2708.1 2739.0 2751.4 2764.0 15021.1 15085.8 15105.4 15122.5 15156.2 8054.1 8171.8 8227.5 8299.4 8299.9 5201.0 5429.0 5546.3 5558.7 5559.1 1835.9 1838.1 1860.3 1898.1 1932.1 26798.9 26892.6 27047.6 27069.5 27154.0 6902.5 7031.7 7055.5 7216.0 7232.3 17333.0 17442.0 17508.0 17575.3 17622.6 8126.1 8273.3 8274.5 8295.3 8299.5 7268.0 7528.7 7608.4 7640.4 7665.7 5216.2 5336.6 5411.6 5471.7 5480.5 1557.4 1557.5 1561.8 1574.5 1597.1 876.6 881.4 892.7 898.3 900.2 7209.7 8341.5 8362.2 8427.0 8534.8 715.7 718.2 721.2 726.0 726.6 4778.6 5220.5 5313.3 5320.4 5519.1 21483.0 22506.0 22535.0 22748.7 22837.7 21438.4 21616.4 22115.4 22522.0 22595.3 11339.5 11459.0 11468.7 11553.6 11597.2 8236.1 8308.9 8382.2 8411.1 8562.4 18184.9 18935.8 19000.2 19229.8 19263.5 19045.8 19489.3 19518.0 19606.6 19694.6 10871.8 11095.8 11120.9 11137.0 11147.6 13559.4 13655.7 13670.9 13747.9 13779.5 10823.2 11225.2 11321.1 11361.9 11457.4 10965.0 11002.1 11183.8 11301.8 11445.6 10002.6 10043.5 10061.0 10233.2 10236.0 7277.2 7420.1 7447.3 7493.3 7499.6 7157.6 7195.8 7274.8 7320.5 7324.3 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#4] prototype.html Cycles:180 Average:5569.37 Median:6235.03 stddev:1551.58 (24.9%) stddev-sans-first:1508.64 16:01:52 INFO - PID 6755 | Values: 504.6 524.4 532.9 533.5 535.3 6361.6 6382.6 6406.0 6421.3 6477.6 6250.7 6280.9 6288.9 6293.4 6329.5 5195.7 5214.9 5230.2 5239.2 5270.3 4881.2 4977.5 5219.8 5221.6 5233.2 5006.9 5030.4 5058.9 5065.9 5073.6 4945.7 4987.4 5019.4 5045.3 5062.8 4447.2 4478.7 4493.6 4511.3 4523.0 6049.9 6067.6 6154.4 6163.5 6182.8 5695.0 5757.6 5764.9 5795.6 5801.9 6566.4 6627.1 6681.8 6685.9 6688.8 4872.5 4983.8 4986.7 4989.9 4990.0 6631.2 6694.4 6878.9 6883.1 6892.8 5082.2 5098.8 5106.4 5120.7 5128.5 5162.9 5169.2 5179.2 5182.0 5189.6 5785.2 5839.9 5844.3 5852.2 5854.9 6620.9 6636.6 6645.1 6668.4 6711.3 1755.9 1773.5 1776.4 1779.0 1784.4 1216.8 1252.9 1257.3 1262.0 1263.7 5610.7 5645.3 5656.7 5691.0 5695.9 6614.4 6745.0 6753.9 6798.9 6829.9 5649.6 5737.9 5773.5 5813.9 5822.7 3508.2 3586.3 3608.5 3621.8 3646.5 6480.7 6507.8 6560.2 6585.4 6596.4 6862.7 6997.4 6998.9 7005.5 7051.4 6544.6 6573.7 6580.2 6584.1 6608.4 6738.8 6788.0 6803.0 6856.9 6859.8 6605.9 6657.7 6770.3 6778.4 6790.7 6418.3 6508.6 6521.5 6568.9 6592.0 4978.0 5018.9 5052.3 5086.2 5114.2 6559.6 6752.8 6779.9 6815.3 6848.6 6219.3 6540.1 6608.3 6632.3 6654.9 6482.5 6506.3 6539.6 6597.7 6609.2 6301.9 6458.4 6474.3 6542.0 6620.4 6440.4 6696.5 6696.5 6704.8 6708.4 6284.4 6312.3 6380.7 6388.5 6430.4 16:01:52 INFO - PID 6755 | 16:01:52 INFO - PID 6755 | [#5] yui.html Cycles:180 Average:24549.20 Median:18892.98 stddev:35816.71 (189.6%) stddev-sans-first:35873.05 16:01:52 INFO - PID 6755 | Values: 867.0 903.7 908.1 915.4 921.5 17944.8 18658.9 18677.7 18706.1 18756.6 18457.3 18622.2 19029.3 19342.1 19513.6 952.9 964.1 967.8 968.2 968.7 961.5 976.0 985.9 986.0 986.7 1028.5 1029.7 1030.7 1031.1 1031.7 1013.8 1022.7 1026.9 1027.7 1031.0 727.3 738.8 749.9 750.3 752.6 20457.0 20502.3 20557.2 20699.4 20709.3 21857.2 22029.8 22594.8 22809.7 22864.1 17592.0 17853.7 17861.2 18084.8 18086.7 3757.1 3770.4 3777.2 3780.0 3781.5 130541.1 139765.0 140059.0 141024.0 146013.0 16530.1 16636.3 16863.9 16872.3 16884.0 29691.9 29839.0 29940.6 29949.7 30005.8 8392.8 8510.9 8529.1 8538.8 8543.4 3838.6 3859.5 3892.9 3921.9 3933.1 5371.5 5472.4 5474.0 5486.5 5494.1 989.5 1021.7 1028.8 1031.1 1033.1 675.0 703.9 705.6 708.7 718.9 11806.7 11972.0 12052.0 12503.9 13094.9 694.2 698.0 698.8 698.9 710.8 5656.9 5707.8 5708.1 5785.4 5789.8 120435.0 123609.4 124829.0 126941.4 127232.0 111358.4 112528.0 115424.4 116030.0 116719.0 89984.6 92361.0 92580.5 96493.5 96659.0 10745.4 10760.1 10888.6 11051.4 11075.9 44843.6 45035.3 45627.5 47778.5 47957.0 58166.4 58196.0 58701.4 59351.0 60828.4 15262.9 15497.7 15600.5 15663.2 15679.7 17089.3 17392.7 17447.7 17592.3 17593.5 16211.9 16419.8 16503.1 16670.0 16674.2 15373.9 15684.4 15714.9 15850.2 15928.0 15267.6 15508.5 15535.3 15641.8 15660.5 10567.3 10585.1 10769.6 10876.5 10885.2 11148.9 11154.7 11158.4 11171.9 11453.2 16:01:52 INFO - PID 6755 | -------- Summary: end -------- 16:01:52 INFO - PID 6755 | 16:01:53 INFO - TEST-INFO | 6755: exit 0 16:01:53 INFO - TEST-OK | dromaeo_css | took 1108658ms 16:01:53 INFO - TEST-START | kraken 16:01:53 INFO - Initialising browser for kraken test... 16:01:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36105/getInfo.html -profile /tmp/tmpszxtSn/profile 16:01:53 INFO - TEST-INFO | started process 7123 (/builds/slave/test/build/application/firefox/firefox http://localhost:36105/getInfo.html) 16:01:59 INFO - TEST-INFO | 7123: exit 0 16:01:59 INFO - Browser initialized. 16:01:59 INFO - Running cycle 1/1 for kraken test... 16:01:59 INFO - Using env: {'DISPLAY': ':0', 16:01:59 INFO - 'HOME': '/home/cltbld', 16:01:59 INFO - 'JSGC_DISABLE_POISONING': '1', 16:01:59 INFO - 'LANG': 'en_US.UTF-8', 16:01:59 INFO - 'LANGUAGE': 'en_US:en', 16:01:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:01:59 INFO - 'LOGNAME': 'cltbld', 16:01:59 INFO - 'MAIL': '/var/mail/cltbld', 16:01:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:01:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:01:59 INFO - 'MOZ_CRASHREPORTER': '1', 16:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:01:59 INFO - 'MOZ_NO_REMOTE': '1', 16:01:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:59 INFO - 'NO_EM_RESTART': '1', 16:01:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:59 INFO - 'PWD': '/builds/slave/test', 16:01:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:01:59 INFO - 'RUST_BACKTRACE': 'full', 16:01:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:01:59 INFO - 'SHELL': '/bin/bash', 16:01:59 INFO - 'SHLVL': '1', 16:01:59 INFO - 'STYLO_FORCE_DISABLED': '1', 16:01:59 INFO - 'TERM': 'linux', 16:01:59 INFO - 'TMOUT': '86400', 16:01:59 INFO - 'USER': 'cltbld', 16:01:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594', 16:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:59 INFO - '_': '/tools/buildbot/bin/python'} 16:01:59 INFO - TEST-INFO | started process 7362 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpszxtSn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:00 INFO - PID 7362 | 16:02:00 INFO - PID 7362 | (/builds/slave/test/build/application/firefox/firefox:7411): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:02:00 INFO - PID 7362 | 16:02:11 INFO - PID 7362 | RSS: Main: 151748608 16:02:11 INFO - PID 7362 | 16:02:13 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36105/tests/kraken/driver.html?testName=audio-beat-detection) 16:02:14 INFO - PID 7362 | RSS: Main: 157769728 16:02:14 INFO - PID 7362 | 16:02:17 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36105/tests/kraken/driver.html?testName=audio-dft) 16:02:17 INFO - PID 7362 | RSS: Main: 158023680 16:02:17 INFO - PID 7362 | 16:02:20 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36105/tests/kraken/driver.html?testName=audio-fft) 16:02:21 INFO - PID 7362 | RSS: Main: 154730496 16:02:21 INFO - PID 7362 | 16:02:23 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36105/tests/kraken/driver.html?testName=audio-oscillator) 16:02:24 INFO - PID 7362 | RSS: Main: 155381760 16:02:24 INFO - PID 7362 | 16:02:26 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36105/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:02:26 INFO - PID 7362 | RSS: Main: 155082752 16:02:26 INFO - PID 7362 | 16:02:30 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36105/tests/kraken/driver.html?testName=imaging-darkroom) 16:02:30 INFO - PID 7362 | RSS: Main: 158273536 16:02:30 INFO - PID 7362 | 16:02:34 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36105/tests/kraken/driver.html?testName=imaging-desaturate) 16:02:34 INFO - PID 7362 | RSS: Main: 157941760 16:02:34 INFO - PID 7362 | 16:02:37 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36105/tests/kraken/driver.html?testName=json-parse-financial) 16:02:38 INFO - PID 7362 | RSS: Main: 158347264 16:02:38 INFO - PID 7362 | 16:02:40 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36105/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:02:40 INFO - PID 7362 | RSS: Main: 157986816 16:02:40 INFO - PID 7362 | 16:02:42 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:02:43 INFO - PID 7362 | RSS: Main: 157908992 16:02:43 INFO - PID 7362 | 16:02:45 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:02:45 INFO - PID 7362 | RSS: Main: 154980352 16:02:45 INFO - PID 7362 | 16:02:48 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:02:49 INFO - PID 7362 | RSS: Main: 155529216 16:02:49 INFO - PID 7362 | 16:02:52 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:02:52 INFO - PID 7362 | RSS: Main: 155557888 16:02:52 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | Cycle 1(1): loaded http://localhost:36105/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36105/tests/kraken/driver.html?testName=ai-astar) 16:02:54 INFO - PID 7362 | RSS: Main: 156798976 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | __start_tp_report 16:02:54 INFO - PID 7362 | _x_x_mozilla_page_load 16:02:54 INFO - PID 7362 | _x_x_mozilla_page_load_details 16:02:54 INFO - PID 7362 | |i|pagename|runs| 16:02:54 INFO - PID 7362 | |0;ai-astar;109;107;107;107;109;108;109;107;106;107 16:02:54 INFO - PID 7362 | |1;audio-beat-detection;117;119;123;117;117;115;121;117;120;120 16:02:54 INFO - PID 7362 | |2;audio-dft;166;164;162;163;164;165;164;164;171;165 16:02:54 INFO - PID 7362 | |3;audio-fft;74;74;75;75;73;73;74;78;74;79 16:02:54 INFO - PID 7362 | |4;audio-oscillator;82;81;79;79;78;79;78;79;79;79 16:02:54 INFO - PID 7362 | |5;imaging-gaussian-blur;111;115;114;114;114;114;115;115;114;114 16:02:54 INFO - PID 7362 | |6;imaging-darkroom;153;149;156;149;149;148;149;152;149;149 16:02:54 INFO - PID 7362 | |7;imaging-desaturate;97;95;94;94;95;95;95;95;95;96 16:02:54 INFO - PID 7362 | |8;json-parse-financial;54;56;51;55;53;54;54;54;53;53 16:02:54 INFO - PID 7362 | |9;json-stringify-tinderbox;39;39;43;38;38;39;38;38;38;39 16:02:54 INFO - PID 7362 | |10;stanford-crypto-aes;74;76;74;74;77;74;76;75;74;83 16:02:54 INFO - PID 7362 | |11;stanford-crypto-ccm;115;113;116;116;111;123;119;115;120;110 16:02:54 INFO - PID 7362 | |12;stanford-crypto-pbkdf2;176;172;177;168;167;180;167;175;173;172 16:02:54 INFO - PID 7362 | |13;stanford-crypto-sha256-iterative;74;73;64;67;64;75;66;69;64;65 16:02:54 INFO - PID 7362 | __end_tp_report 16:02:54 INFO - PID 7362 | __start_cc_report 16:02:54 INFO - PID 7362 | _x_x_mozilla_cycle_collect,756 16:02:54 INFO - PID 7362 | __end_cc_report 16:02:54 INFO - PID 7362 | __startTimestamp1506294174726__endTimestamp 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | ------- Summary: start ------- 16:02:54 INFO - PID 7362 | Number of tests: 14 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#0] ai-astar Cycles:10 Average:107.60 Median:107.50 stddev:1.07 (1.0%) stddev-sans-first:1.01 16:02:54 INFO - PID 7362 | Values: 109.0 107.0 107.0 107.0 109.0 108.0 109.0 107.0 106.0 107.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#1] audio-beat-detection Cycles:10 Average:118.60 Median:119.50 stddev:2.41 (2.0%) stddev-sans-first:2.49 16:02:54 INFO - PID 7362 | Values: 117.0 119.0 123.0 117.0 117.0 115.0 121.0 117.0 120.0 120.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 16:02:54 INFO - PID 7362 | Values: 166.0 164.0 162.0 163.0 164.0 165.0 164.0 164.0 171.0 165.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#3] audio-fft Cycles:10 Average:74.90 Median:74.50 stddev:2.02 (2.7%) stddev-sans-first:2.12 16:02:54 INFO - PID 7362 | Values: 74.0 74.0 75.0 75.0 73.0 73.0 74.0 78.0 74.0 79.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#4] audio-oscillator Cycles:10 Average:79.30 Median:79.00 stddev:1.25 (1.6%) stddev-sans-first:0.87 16:02:54 INFO - PID 7362 | Values: 82.0 81.0 79.0 79.0 78.0 79.0 78.0 79.0 79.0 79.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:0.50 16:02:54 INFO - PID 7362 | Values: 111.0 115.0 114.0 114.0 114.0 114.0 115.0 115.0 114.0 114.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:149.00 stddev:2.54 (1.7%) stddev-sans-first:2.50 16:02:54 INFO - PID 7362 | Values: 153.0 149.0 156.0 149.0 149.0 148.0 149.0 152.0 149.0 149.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.88 (0.9%) stddev-sans-first:0.60 16:02:54 INFO - PID 7362 | Values: 97.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#8] json-parse-financial Cycles:10 Average:53.70 Median:54.00 stddev:1.34 (2.5%) stddev-sans-first:1.41 16:02:54 INFO - PID 7362 | Values: 54.0 56.0 51.0 55.0 53.0 54.0 54.0 54.0 53.0 53.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#9] json-stringify-tinderbox Cycles:10 Average:38.90 Median:39.00 stddev:1.52 (3.9%) stddev-sans-first:1.62 16:02:54 INFO - PID 7362 | Values: 39.0 39.0 43.0 38.0 38.0 39.0 38.0 38.0 38.0 39.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:2.79 (3.7%) stddev-sans-first:2.89 16:02:54 INFO - PID 7362 | Values: 74.0 76.0 74.0 74.0 77.0 74.0 76.0 75.0 74.0 83.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#11] stanford-crypto-ccm Cycles:10 Average:115.80 Median:116.00 stddev:4.02 (3.5%) stddev-sans-first:4.26 16:02:54 INFO - PID 7362 | Values: 115.0 113.0 116.0 116.0 111.0 123.0 119.0 115.0 120.0 110.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.70 Median:174.00 stddev:4.42 (2.5%) stddev-sans-first:4.53 16:02:54 INFO - PID 7362 | Values: 176.0 172.0 177.0 168.0 167.0 180.0 167.0 175.0 173.0 172.0 16:02:54 INFO - PID 7362 | 16:02:54 INFO - PID 7362 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:4.38 (6.4%) stddev-sans-first:4.10 16:02:54 INFO - PID 7362 | Values: 74.0 73.0 64.0 67.0 64.0 75.0 66.0 69.0 64.0 65.0 16:02:54 INFO - PID 7362 | -------- Summary: end -------- 16:02:54 INFO - PID 7362 | 16:02:55 INFO - PID 7362 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:02:55 INFO - TEST-INFO | 7362: exit 0 16:02:55 INFO - TEST-OK | kraken | took 61828ms 16:02:55 INFO - SUITE-END | took 1170s 16:02:55 INFO - Completed test suite (00:19:30) 16:02:55 INFO - javascript benchmark 16:02:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8631.285236210451, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.767217458691, 3123.1411361875466, 3123.437781199384, 3125.687431256875, 3149.2599239178794, 6198.78304259351, 6213.689315534222, 6256.56204065715, 6259.155014073111, 6353.1105645209645, 6255.718492667829, 6265.310815810257, 6273.153124328214, 6312.305646378894, 6312.589681670688, 5762.4525670061275, 5767.33675627304, 5828.1549175369755, 5852.473277405033, 5953.0, 5868.0, 5869.178315035877, 5897.41025897409, 5912.9704351478185, 5953.047512397996, 54.911052810487135, 5672.517835983905, 5779.537636989031, 5831.212786273863, 5864.853378665546, 5350.625456218067, 5685.914711279334, 5737.942620573783, 5833.591648584601, 5837.0, 5759.452851979056, 5766.279215098113, 5823.737931793079, 5824.592278540504, 5837.766489340422, 6212.565120441571, 6319.968400158015, 6321.209848768904, 6396.392342727433, 6398.29618741938, 6711.731530738764, 6770.356816102462, 6834.0, 6844.760433384808, 6862.965685171542, 6642.867142657168, 6745.494087943423, 6773.830654233634, 6841.486888483384, 6906.965465172692, 6317.93682063178, 6321.968390158066, 6338.144350512668, 6339.36606339367, 6341.682915854235, 6935.445164386887, 6983.0, 7076.363127318566, 7078.0, 7084.964575177194, 6668.766593169313, 6680.632565208863, 6746.0892779475125, 6749.5612785168805, 6753.797386078426, 6611.173603299588, 6709.161354830646, 6714.093597364391, 6779.017042528904, 6875.5874647521305, 6682.599044057372, 6690.13028306317, 6697.933020669829, 6724.092247546617, 6839.794806155824, 6758.391744742997, 6871.244163142051, 6876.793696189123, 6894.345037221456, 6901.585904845725, 5282.630215884851, 5292.153255479182, 5359.3032905722785, 5360.892782144335, 5366.6243362964215, 4510.887227819265, 4607.285870690049, 4616.330632058332, 4619.630429565626, 4623.075384922961, 5734.971325143431, 5737.139429085671, 5802.94197058024, 5812.680302583314, 5837.474627283565, 6824.078749368871, 6826.692798824065, 6859.07402500666, 6928.61892595902, 6944.479164062715, 5786.04530252512, 5806.4193580641595, 5856.795012174553, 5887.175795388649, 5887.470127688529, 5720.799772008043, 5772.249607550992, 5819.70901454934, 5845.561582881301, 5899.882002360015, 6497.317781632955, 6596.274409814917, 6600.1089852869245, 6601.900971485432, 6602.207735071726, 6810.62541560219, 6819.045333653293, 6927.064846245692, 6927.134108236471, 6927.6882540286815, 6538.574992625464, 6575.210974683068, 6580.243272023587, 6660.10088638047, 6686.732530698718, 6492.220933488012, 6586.637734924625, 6690.632015239208, 6773.322667733188, 6785.253622101466, 6791.0832037676255, 6844.657767111724, 6874.312568743286, 6878.7248510059035, 6883.449324053963, 6578.506612004023, 6607.240167380813, 6673.733050677918, 6681.899771503528, 6683.966580167263, 6578.24350199714, 6599.373059559334, 6611.272759996493, 6680.565763225375, 6695.163104611924, 6376.521760868046, 6540.607563546202, 6608.4052435281055, 6634.668266586555, 6635.767748128792, 6582.407583317525, 6642.501812363996, 6661.433778128913, 6705.161854768154, 6738.393544581011, 6227.688615569294, 6357.8728425432155, 6375.968120159369, 6454.548181627241, 6461.8061458156335], "value": 6131.975573204971, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.7444766570028, 858.3347905373339, 864.9783755406114, 875.5709702245902, 884.6770928611058, 39383.80308098459, 39898.20203595934, 39948.20103597926, 39996.800015999914, 40062.59937400625, 38439.807800961025, 38516.61483385165, 38752.224955500875, 38837.0, 38892.0, 7144.07127073481, 7255.782326530212, 7257.165425976001, 7262.946872703455, 7263.963680181591, 6997.580145191305, 7027.47293952953, 7074.186468556105, 7080.716771329141, 7081.114860642419, 7044.154701435835, 7861.21387861215, 8047.275745182932, 8054.556999365032, 8055.395845311625, 7952.960235198845, 7953.681852725884, 7997.440179187459, 7999.360051195919, 8000.439969202187, 7824.882626760603, 7917.366610671133, 7922.04935407749, 7930.1276859545405, 7934.127246002935, 36370.0, 36540.81729591335, 36859.815700921325, 36948.815255923546, 36966.445503317475, 3499.230169362736, 3559.039059453933, 3560.3769340365334, 3562.87529936451, 3563.9109022274392, 30520.084397468112, 30585.08244752661, 30637.693623063707, 30678.0, 30688.0, 5075.492450754932, 5106.4638212987475, 5110.437851836295, 5121.948780512184, 5166.948330516684, 185327.0, 185625.0, 186171.0, 186225.0, 186522.0, 42831.357529637084, 43234.351484727755, 47921.28118078232, 48726.756366217945, 48727.0, 50473.0, 50560.494395055575, 50654.24018639723, 50756.23865642018, 50852.0, 15878.364865405485, 16001.119938403266, 16058.678826423406, 16062.357505699874, 16076.678466430605, 12916.41876115577, 13108.475660973645, 13110.278934658685, 13166.539171129156, 13204.075714699879, 13854.653633659038, 13901.16593004423, 13996.650083747987, 14033.368498417596, 14088.577342679737, 5637.267155269788, 5705.5720820938595, 5749.0, 5810.82567522975, 5833.562482813806, 988.2884323287221, 995.2038369304528, 998.0418797954045, 1002.5538635307219, 1007.5717819926502, 22116.889415552818, 22748.20381286647, 22754.886225568767, 23007.769922300897, 23097.53804923892, 1088.3089238333557, 1092.5138313450598, 1096.1011970184531, 1106.6126855600637, 1116.776644671069, 11910.46402911871, 11911.642650720492, 12163.474709237204, 12195.19495550147, 12240.204386714835, 206604.0, 208704.0, 218477.0, 219272.0, 220040.0, 51255.487445125815, 51453.228201577, 51692.22461663078, 51729.48270517322, 51792.22311665328, 1424.3519198764536, 1465.1136062682137, 1485.1089346392293, 1485.532057401915, 1486.5688950204535, 22669.546609067398, 22934.31197064091, 22970.885145574164, 23021.769782302632, 23080.884595576914, 36678.0, 36763.816180918926, 36838.63161368352, 36881.0, 36924.44613330749, 192659.0, 193258.0, 193901.0, 194416.0, 195338.0, 30393.24016899595, 30941.381172376878, 32573.837130814194, 33573.16067098244, 34320.31359372848, 43206.351904720825, 43315.133697326506, 43321.56678433175, 43988.78005609952, 44020.33969490524, 32213.677863221066, 32290.0, 32563.674363256065, 32671.509927350635, 32792.836035819666, 30795.69204308018, 31735.84132079325, 31801.522977155822, 32043.679563205, 32432.189195270308, 35664.28671426609, 35750.46374304336, 35845.28309433849, 36085.27829443344, 36162.276754464234, 31200.0, 31259.84370078135, 31557.211069723442, 31571.842140789147, 31740.841295793372, 23139.3058208254, 23208.883955580113, 23599.29202123939, 24048.87975560181, 24066.0], "value": 16895.00165212307, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.6049646736686, 592.3543337761839, 599.6671847124844, 601.5157797972631, 628.1488582970077, 22450.775492245073, 23228.535429291405, 23259.953302101403, 23260.18589349373, 23282.18512352068, 23088.191913283037, 25684.486310273784, 25946.48107037858, 25950.0, 25988.0, 6756.729730810774, 6868.587884726932, 6906.274841141683, 6912.792616221496, 6920.930790692079, 6545.869082618345, 6734.730610775563, 6811.693473793691, 6840.828979275509, 6844.212915514705, 6790.5925644461495, 6795.830104247384, 6799.082123913283, 6801.93198068018, 6803.931960680379, 6728.966355168192, 6750.257471678112, 6794.286599906988, 6803.523753337268, 6813.284605116441, 6296.685165741695, 6700.93299067008, 6960.9651951740425, 6987.371136597731, 7006.474514411389, 30341.634626441864, 31142.688573114207, 31148.0, 31172.688273117434, 31173.064808055795, 2042.2749923776994, 2061.9690704639443, 2069.98965005174, 2080.916763329465, 2090.2997495838913, 20984.580308393746, 21167.894160529253, 21643.78356216449, 21804.781952180594, 21933.0, 2436.719777225624, 2444.1201167579834, 2499.9500009999697, 2523.2808649534977, 2537.0739680016845, 122927.0, 128627.0, 139817.30091349478, 142840.28579857034, 149144.254278729, 19554.413367598994, 21402.464938376666, 21691.566168676854, 22347.888260558593, 23093.653595196087, 43695.78152109219, 43987.120257594666, 44022.559774402485, 44029.33955990663, 44100.55899441029, 11232.550697972152, 11419.828702569468, 11476.19666623345, 11487.597934072435, 11489.253198542068, 9388.295877809192, 9425.38734982224, 9434.528273586293, 9446.244300455946, 9603.47180905043, 11654.892785185393, 11663.59177428786, 11885.88114118865, 12053.0960177987, 12081.275123492618, 3971.8283106483655, 4287.849925252601, 4306.267934451088, 4343.739375637472, 4401.559844015637, 954.117441366733, 974.1622204903778, 978.9853152202722, 992.2954702161402, 995.3679413572289, 19661.90169049174, 19690.0, 20107.899460502606, 20440.977951102384, 20550.691739623617, 1037.7613148975627, 1049.41757324684, 1049.7270709615402, 1051.8264486359817, 1055.4300677633992, 11133.332000080021, 11185.66443006711, 11273.492692828842, 11306.208565400508, 11434.199606027498, 427639.0, 436296.0, 439607.0, 443735.0, 447458.0, 112136.0, 113969.0, 115537.4223128879, 115575.42212289052, 115910.0, 1144.6909334479644, 1160.1356989043047, 1183.230899915062, 1185.5613423033533, 1185.6680129563736, 17881.642367152843, 18285.26858925681, 18350.541236469195, 18354.63290734151, 18375.26498940081, 54753.726231368586, 54943.0, 56004.43995559992, 56651.58371040757, 58202.708986454796, 70495.0, 70836.0, 70859.64570177117, 70913.0, 71362.0, 20101.195952162336, 20593.0, 20660.173593056712, 20749.066292016592, 20756.06597703077, 22637.0, 22877.542449151257, 22935.541289174456, 23040.769592303863, 23121.537569248183, 15900.204989750697, 16238.188090595188, 16268.430604928772, 18473.630527389647, 18556.2577496904, 16050.197490125214, 16072.839271607134, 16321.265543050355, 16586.08776517303, 17447.214875330388, 18118.09409529492, 18510.0, 18780.0, 18824.96462694565, 18869.339573114874, 20185.09167087514, 20198.0, 20296.59406811885, 20344.186232551125, 20357.0, 18173.0, 18208.81791182071, 18260.634787303912, 18735.156917938453, 18747.343842965976], "value": 12966.54715671312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.730685209532, 1388.2156581531428, 1413.9151650900947, 1415.7522433574122, 1417.6739349949512, 15063.472778452757, 15692.058476491418, 15702.293396797142, 15711.45009924653, 15732.0, 15300.464483743071, 15351.232438378065, 15370.154641494713, 15404.306806193721, 15411.306491207895, 2807.564827451738, 2861.399106187703, 2878.1077865861544, 2904.244896326949, 2910.8253504789673, 2806.424682939992, 2815.6621205455376, 2825.2654309879476, 2834.376437183816, 2836.8297902125837, 2779.207925741164, 2786.2477131174674, 2794.5109605818902, 2886.177439429763, 2895.666998295202, 2806.7193280671872, 2856.1146044726097, 2856.11460447262, 2857.0714517781803, 2857.628508293919, 2705.391286960438, 2708.1469337158733, 2739.0, 2751.3534319435116, 2763.9723602763916, 15021.098734075991, 15085.849141508554, 15105.39578416862, 15122.470713524974, 15156.1664108474, 8054.073781515142, 8171.836563268761, 8227.506349619041, 8299.419040667155, 8299.875501867476, 5201.0, 5429.0, 5546.334439867202, 5558.666480011212, 5559.138333558264, 1835.8898466092078, 1838.108517369075, 1860.3302810988034, 1898.0509745127436, 1932.062949469506, 26798.866005670043, 26892.59661105085, 27047.59428608553, 27069.458610827674, 27154.049608263616, 6902.482313826483, 7031.718731250795, 7055.541389809646, 7215.963920180366, 7232.349088581947, 17333.0, 17442.040687762295, 17508.037057961934, 17575.296988120586, 17622.647547048986, 8126.065502467174, 8273.255407013277, 8274.544900030556, 8295.336373090138, 8299.460535065202, 7268.0, 7528.661210245552, 7608.429367797326, 7640.388768898475, 7665.6550455228535, 5216.21756736485, 5336.573074154058, 5411.648242864201, 5471.7264136793, 5480.479354461319, 1557.392616879418, 1557.5015994881755, 1561.7813506109153, 1574.480421460915, 1597.0657165558046, 876.5748611923212, 881.4006475596527, 892.6563273139758, 898.3307435960252, 900.2348004196381, 7209.711611535585, 8341.499510029418, 8362.163783621589, 8427.030891447563, 8534.829303413897, 715.6636380900968, 718.192033961793, 721.1706537481938, 725.992740072603, 726.5931078596003, 4778.593819525379, 5220.504052115043, 5313.256144139824, 5320.414754377015, 5519.116941289374, 21483.0, 22506.0, 22535.0, 22748.65877011846, 22837.657435138488, 21438.356849294545, 21616.43808249016, 22115.447113822283, 22522.0, 22595.322140335815, 11339.546418143347, 11459.025982791389, 11468.655940321803, 11553.595624153115, 11597.18819682614, 8236.052853921636, 8308.916910830814, 8382.245597896219, 8411.11683273272, 8562.443441176303, 18184.90907545454, 18935.810641893957, 19000.23999040023, 19229.8077019228, 19263.51841203981, 19045.809541904404, 19489.317873874345, 19518.0, 19606.60786784285, 19694.606107878048, 10871.836922446328, 11095.833562496407, 11120.888791111985, 11137.0, 11147.55409783632, 13559.389827457986, 13655.658608534866, 13670.863291366959, 13747.931260343634, 13779.517716879862, 10823.188260880308, 11225.214235003798, 11321.09431245482, 11361.943190283995, 11457.427128643702, 10965.0, 11002.064824490008, 11183.832242516532, 11301.830472542753, 11445.599404020819, 10002.599896004078, 10043.497825108861, 10061.0, 10233.181345492194, 10236.027577380137, 7277.199508054004, 7420.146683131293, 7447.292507211806, 7493.250674932681, 7499.550026998398, 7157.606331651601, 7195.820104497429, 7274.818129546804, 7320.487565870338, 7324.267573242846], "value": 6736.000746907022, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.6240845098076, 524.3707550938874, 532.9382696409131, 533.5115029068895, 535.290739769805, 6361.618302901829, 6382.5532212745065, 6406.03909413587, 6421.29365769765, 6477.643729594871, 6250.749970001206, 6280.85463594028, 6288.8742225155465, 6293.370662933716, 6329.525285603575, 5195.714235717034, 5214.8696282592955, 5230.189320655286, 5239.161734122541, 5270.288511050997, 4881.170201065809, 4977.50224977503, 5219.817306394277, 5221.608379371543, 5233.162693968966, 5006.949930500703, 5030.446650868402, 5058.924116138242, 5065.924011139836, 5073.568746656539, 4945.67853089548, 4987.401511818569, 5019.3976722793495, 5045.293658887758, 5062.772175252123, 4447.177272204653, 4478.664100192498, 4493.618042466394, 4511.300748384006, 4522.977385113087, 6049.939500604982, 6067.635941843503, 6154.446099851035, 6163.537734669872, 6182.752689892399, 5694.971525142348, 5757.568182386296, 5764.8847023059725, 5795.565332600029, 5801.854953626151, 6566.441852442548, 6627.105340778981, 6681.832954176184, 6685.899711504331, 6688.799336019927, 4872.537108974641, 4983.800647974077, 4986.700797952134, 4989.875253118665, 4990.0269447457395, 6631.204255489372, 6694.397504224595, 6878.8624227515165, 6883.074693255347, 6892.758753443655, 5082.237664350377, 5098.770555325019, 5106.4382917879, 5120.743962801845, 5128.461511541309, 5162.896742065138, 5169.224616307584, 5179.171332586843, 5182.0, 5189.55888749453, 5785.247917770663, 5839.854003649858, 5844.298684157843, 5852.180694702745, 5854.912176317359, 6620.933790662032, 6636.601803891782, 6645.102911107036, 6668.433183179484, 6711.295313992058, 1755.859531237498, 1773.5300145461463, 1776.4049043570549, 1778.968198444899, 1784.3933062758724, 1216.7701416688776, 1252.9310887901254, 1257.2959142880015, 1261.962141135749, 1263.7472505498938, 5610.747516361774, 5645.266115404971, 5656.660600363992, 5691.0, 5695.886082278331, 6614.404703576702, 6745.0, 6753.898691519631, 6798.898016529756, 6829.863402731918, 5649.6327738696855, 5737.88524229513, 5773.538116950718, 5813.854653633608, 5822.650640961471, 3508.210652603144, 3586.336527742376, 3608.530890984155, 3621.8370173342264, 3646.507721457622, 6480.708368123445, 6507.772227971998, 6560.245571759213, 6585.440237579764, 6596.437923521341, 6862.725490980305, 6997.370236678723, 6998.915168148945, 7005.50961432705, 7051.400630946427, 6544.640044797582, 6573.704183311763, 6580.243272023683, 6584.1440612721, 6608.372204640552, 6738.764143254963, 6788.0, 6803.0, 6856.9314306856295, 6859.828504287433, 6605.933940660532, 6657.667116644052, 6770.255271919987, 6778.423833974168, 6790.72837086511, 6418.326075761977, 6508.642024688687, 6521.5108866834225, 6568.901466477911, 6592.0, 4977.950220497749, 5018.874528136826, 5052.343195384577, 5086.21163719624, 5114.232865070269, 6559.6064236145985, 6752.831179220559, 6779.8983015253825, 6815.318468153145, 6848.589084654936, 6219.315875253628, 6540.117084193763, 6608.339166083353, 6632.30360812127, 6654.900176497454, 6482.481401487776, 6506.316836732075, 6539.574927629689, 6597.736090556324, 6609.239937407067, 6301.873962520815, 6458.38645328693, 6474.320196379313, 6542.0, 6620.404163625297, 6440.420362167428, 6696.464282857262, 6696.497762667722, 6704.765333213314, 6708.396244337838, 6284.4344009039405, 6312.274088479883, 6380.712867920862, 6388.4569811566535, 6430.3891130342545], "value": 5114.849507042216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [867.0, 903.6701603914573, 908.0964440381821, 915.3546749541574, 921.5069937583394, 17944.820551794495, 18658.906705466452, 18677.719834202482, 18706.06469676514, 18756.62486750264, 18457.2617095316, 18622.162002709876, 19029.333973310902, 19342.12960416781, 19513.609727805437, 952.8951815300329, 964.0985678390728, 967.7580604848788, 968.1867231525517, 968.7190714692766, 961.4952150121172, 975.9560819763128, 985.8767654043245, 985.9950700246488, 986.6694657289817, 1028.4703377760422, 1029.6653587584028, 1030.6804890483936, 1031.0617338222219, 1031.7162780235458, 1013.8023085498331, 1022.6983040003217, 1026.856240126383, 1027.681418760183, 1030.9947800894142, 727.287258486686, 738.7635956493924, 749.9062617172854, 750.2572453271222, 752.5785560086315, 20457.0, 20502.282420115225, 20557.177712891465, 20699.379018629465, 20709.27517536894, 21857.234996775038, 22029.779702202934, 22594.774052259432, 22809.657855132187, 22864.085436582518, 17592.0, 17853.7321940171, 17861.196246168824, 18084.819151808446, 18086.728699069394, 3757.135858752475, 3770.3590389633555, 3777.2067865748227, 3780.017195529182, 3781.5084039074745, 130541.08376748807, 139765.0, 140059.0, 141024.0, 146013.0, 16530.0908450034, 16636.251368688438, 16863.91568042152, 16872.325106995828, 16884.0, 29691.85154074216, 29839.0, 29940.550891736642, 29949.700502995125, 30005.849970750005, 8392.832143357098, 8510.872336914952, 8529.147085291544, 8538.829223415496, 8543.444676096035, 3838.616138386139, 3859.498265225559, 3892.8832135035996, 3921.8823435296986, 3933.0757272041046, 5371.516563509303, 5472.425395333512, 5474.042042642522, 5486.533644640171, 5494.066008778517, 989.5151375825793, 1021.7139201023725, 1028.8456731490187, 1031.1132426113536, 1033.0857191385678, 675.0, 703.855709579535, 705.5731282574071, 708.7342246657504, 718.8706032914125, 11806.704832379088, 11972.0, 12052.0, 12503.937480312541, 13094.869051309555, 694.191267173737, 697.9828296223917, 698.769406095987, 698.8951657251453, 710.7512370670328, 5656.8868622627315, 5707.828765136969, 5708.115242137475, 5785.363610002896, 5789.768409263583, 120435.0, 123609.38195309146, 124829.0, 126941.36529317294, 127232.0, 111358.44320778507, 112528.0, 115424.42287788675, 116030.0, 116719.0, 89984.5500772505, 92361.0, 92580.53709731543, 96493.51753241329, 96659.0, 10745.355278683304, 10760.139188864716, 10888.61889833852, 11051.392173430217, 11075.944620276847, 44843.55156448524, 45035.32447013363, 45627.54372456233, 47778.522214777404, 47957.0, 58166.4183358161, 58196.0, 58701.412985869596, 59351.0, 60828.391716082275, 15262.923685381502, 15497.690046199239, 15600.453984110502, 15663.216839158224, 15679.686406271583, 17089.31642734277, 17392.739108913123, 17447.738283925497, 17592.29630814804, 17593.472195834147, 16211.918940405223, 16419.753703694216, 16503.09232992149, 16670.0, 16674.16629168561, 15373.923130384277, 15684.41207200799, 15714.9214253928, 15850.207489625704, 15928.0, 15267.618309541906, 15508.5347439577, 15535.300911458786, 15641.765373519635, 15660.451884184455, 10567.260291779809, 10585.100266477435, 10769.569217231536, 10876.456177191267, 10885.23803333759, 11148.888511114785, 11154.72113197144, 11158.386288754196, 11171.888281117084, 11453.167493201048], "value": 8933.234010918306, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 107.0, 107.0, 107.0, 109.0, 108.0, 109.0, 107.0, 106.0, 107.0], "value": 107.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 123.0, 117.0, 117.0, 115.0, 121.0, 117.0, 120.0, 120.0], "value": 118.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 162.0, 163.0, 164.0, 165.0, 164.0, 164.0, 171.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 75.0, 73.0, 73.0, 74.0, 78.0, 74.0, 79.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 79.0, 79.0, 78.0, 79.0, 78.0, 79.0, 79.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 149.0, 156.0, 149.0, 149.0, 148.0, 149.0, 152.0, 149.0, 149.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 51.0, 55.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 43.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 39.0], "value": 38.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 74.0, 77.0, 74.0, 76.0, 75.0, 74.0, 83.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 116.0, 116.0, 111.0, 123.0, 119.0, 115.0, 120.0, 110.0], "value": 115.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 177.0, 168.0, 167.0, 180.0, 167.0, 175.0, 173.0, 172.0], "value": 172.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 64.0, 67.0, 64.0, 75.0, 66.0, 69.0, 64.0, 65.0], "value": 68.1, "unit": "score"}]}]} 16:02:55 INFO - Return code: 0 16:02:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:02:55 INFO - # TBPL SUCCESS # 16:02:55 INFO - Running post-action listener: _package_coverage_data 16:02:55 INFO - Running post-action listener: _resource_record_post_action 16:02:55 INFO - [mozharness: 2017-09-24 23:02:55.985440Z] Finished run-tests step (success) 16:02:55 INFO - Running post-run listener: _resource_record_post_run 16:02:56 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 332595200; Read time: 16; Write time: 332196 16:02:56 INFO - TinderboxPrint: CPU usage
13.1% 16:02:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:02:56 INFO - TinderboxPrint: I/O write bytes / time
332,595,200 / 332,196 16:02:56 INFO - TinderboxPrint: CPU idle
8,233.4 (86.8%) 16:02:56 INFO - TinderboxPrint: CPU user
1,193.4 (12.6%) 16:02:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:02:56 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 10473472; Read time: 0; Write time: 3248 16:02:56 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:02:56 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 321736704; Read time: 0; Write time: 328908 16:02:56 INFO - Running post-run listener: _upload_blobber_files 16:02:56 INFO - Blob upload gear active. 16:02:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:02: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 16:02: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'] 16:02: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 16:02:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:58 INFO - (blobuploader) - INFO - Done attempting. 16:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:02:58 INFO - (blobuploader) - INFO - Done attempting. 16:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:03:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:06 INFO - (blobuploader) - INFO - Done attempting. 16:03:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:03:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:03:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:03:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:03:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:03:07 INFO - (blobuploader) - INFO - Done attempting. 16:03:07 INFO - (blobuploader) - INFO - Iteration through files over. 16:03:07 INFO - Return code: 0 16:03:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:03:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:03:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac7531997126272f6e08a4143edc6865ab219b0f487c8068313fda67d38455a5afe626f8216bb3e0cf091700c228b959547dc5a8bf011c562932aa9d9ed548b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aefc26b5b493db0ddfe0044a5c3468b59bda4fdc5526e9848691ea2c8e72c3939c3150740625690a61bd4fc57d4c54ac0cf7fa39b94bacad6542472220c44ed0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ae79f384363524c136a9dc99653bbe9660668ed7075b2e30caf32f385c360125dc52fd1cfbebf19ffe4236c7aae81001132a583193017575fc69e4ddf6a51bc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6338f5e49e13db4735e97447117b2784a89fb131139eaec290c4e20ffbc48f7ad69cf0339676820effa9e587634cf281a78dad8e625c37ff31a783c7b3c82223"} 16:03:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:03:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:03:07 INFO - Contents: 16:03:07 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac7531997126272f6e08a4143edc6865ab219b0f487c8068313fda67d38455a5afe626f8216bb3e0cf091700c228b959547dc5a8bf011c562932aa9d9ed548b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aefc26b5b493db0ddfe0044a5c3468b59bda4fdc5526e9848691ea2c8e72c3939c3150740625690a61bd4fc57d4c54ac0cf7fa39b94bacad6542472220c44ed0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ae79f384363524c136a9dc99653bbe9660668ed7075b2e30caf32f385c360125dc52fd1cfbebf19ffe4236c7aae81001132a583193017575fc69e4ddf6a51bc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6338f5e49e13db4735e97447117b2784a89fb131139eaec290c4e20ffbc48f7ad69cf0339676820effa9e587634cf281a78dad8e625c37ff31a783c7b3c82223"} 16:03:07 INFO - Running post-run listener: copy_logs_to_upload_dir 16:03:07 INFO - Copying logs to upload dir... 16:03:07 INFO - mkdir: /builds/slave/test/build/upload/logs 16:03:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.131697 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-09-24 16:03:08.200866) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:03:08.203999) ========= 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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 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/3ac7531997126272f6e08a4143edc6865ab219b0f487c8068313fda67d38455a5afe626f8216bb3e0cf091700c228b959547dc5a8bf011c562932aa9d9ed548b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aefc26b5b493db0ddfe0044a5c3468b59bda4fdc5526e9848691ea2c8e72c3939c3150740625690a61bd4fc57d4c54ac0cf7fa39b94bacad6542472220c44ed0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ae79f384363524c136a9dc99653bbe9660668ed7075b2e30caf32f385c360125dc52fd1cfbebf19ffe4236c7aae81001132a583193017575fc69e4ddf6a51bc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6338f5e49e13db4735e97447117b2784a89fb131139eaec290c4e20ffbc48f7ad69cf0339676820effa9e587634cf281a78dad8e625c37ff31a783c7b3c82223"} build_url:https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/fh1savD2Q1aQeqxvlInuLA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3ac7531997126272f6e08a4143edc6865ab219b0f487c8068313fda67d38455a5afe626f8216bb3e0cf091700c228b959547dc5a8bf011c562932aa9d9ed548b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aefc26b5b493db0ddfe0044a5c3468b59bda4fdc5526e9848691ea2c8e72c3939c3150740625690a61bd4fc57d4c54ac0cf7fa39b94bacad6542472220c44ed0", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8ae79f384363524c136a9dc99653bbe9660668ed7075b2e30caf32f385c360125dc52fd1cfbebf19ffe4236c7aae81001132a583193017575fc69e4ddf6a51bc", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6338f5e49e13db4735e97447117b2784a89fb131139eaec290c4e20ffbc48f7ad69cf0339676820effa9e587634cf281a78dad8e625c37ff31a783c7b3c82223"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-24 16:03:08.362082) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:03:08.362400) ========= 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=eca2ab57546de7b41f256b19000001ef-1506290385.345103-1729695594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-24 16:03:08.383934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:03:08.384228) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-24 16:03:08.384545) ========= ========= Total master_lag: 0.65 =========