builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-054 starttime: 1505429425.7 results: success (0) revision: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:25.702375) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:25.702752) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:25.703031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:25.895440) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:25.895764) ========= 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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-14 15:50:26-- 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% 39.5M=0s 2017-09-14 15:50:26 (39.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.177859 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.124724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.124993) ========= 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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021391 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.213585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.213883) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe --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 b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe --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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-14 15:50:26,416 truncating revision to first 12 chars 2017-09-14 15:50:26,417 Setting DEBUG logging. 2017-09-14 15:50:26,417 attempt 1/10 2017-09-14 15:50:26,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b778b6cb49c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-14 15:50:26,803 unpacking tar archive at: mozilla-central-b778b6cb49c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.692919 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.934312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.937670) ========= script_repo_revision: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.938335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.938624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-14 15:50:26.968134) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-14 15:50:26.968397) ========= /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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:50:27 INFO - MultiFileLogger online at 20170914 15:50:27 in /builds/slave/test 15:50:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:50:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:50:27 INFO - {'append_to_log': False, 15:50:27 INFO - 'base_work_dir': '/builds/slave/test', 15:50:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:50:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:50:27 INFO - 'branch': 'Firefox-Non-PGO', 15:50:27 INFO - 'buildbot_json_path': 'buildprops.json', 15:50:27 INFO - 'code_coverage': False, 15:50:27 INFO - 'config_files': ('talos/linux_config.py',), 15:50:27 INFO - 'default_actions': ('clobber', 15:50:27 INFO - 'read-buildbot-config', 15:50:27 INFO - 'download-and-extract', 15:50:27 INFO - 'populate-webroot', 15:50:27 INFO - 'create-virtualenv', 15:50:27 INFO - 'install', 15:50:27 INFO - 'setup-mitmproxy', 15:50:27 INFO - 'run-tests'), 15:50:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:50:27 INFO - 'disable_ccov_upload': False, 15:50:27 INFO - 'disable_stylo': False, 15:50:27 INFO - 'download_minidump_stackwalk': True, 15:50:27 INFO - 'download_symbols': 'ondemand', 15:50:27 INFO - 'enable_stylo': False, 15:50:27 INFO - 'enable_webrender': False, 15:50:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:50:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:50:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:50:27 INFO - 'gecko_profile': False, 15:50:27 INFO - 'gecko_profile_interval': 0, 15:50:27 INFO - 'installer_path': 'installer.exe', 15:50:27 INFO - 'log_level': 'info', 15:50:27 INFO - 'log_name': 'talos', 15:50:27 INFO - 'log_to_console': True, 15:50:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:50:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:50:27 INFO - 'opt_config_files': (), 15:50:27 INFO - 'pip_index': False, 15:50:27 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 15:50:27 INFO - 'system_bits': '32', 15:50:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:50:27 INFO - 'title': 'talos-linux64-ix-054', 15:50:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:50:27 INFO - 'use_talos_json': True, 15:50:27 INFO - 'verify': 'False', 15:50:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:50:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:50:27 INFO - 'work_dir': 'build'} 15:50:27 INFO - [mozharness: 2017-09-14 22:50:27.301753Z] Running clobber step. 15:50:27 INFO - Running pre-action listener: _resource_record_pre_action 15:50:27 INFO - Running main action method: clobber 15:50:27 INFO - rmtree: /builds/slave/test/build 15:50:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:50:28 INFO - Running post-action listener: _resource_record_post_action 15:50:28 INFO - [mozharness: 2017-09-14 22:50:28.813562Z] Finished clobber step (success) 15:50:28 INFO - [mozharness: 2017-09-14 22:50:28.813659Z] Running read-buildbot-config step. 15:50:28 INFO - Running pre-action listener: _resource_record_pre_action 15:50:28 INFO - Running main action method: read_buildbot_config 15:50:28 INFO - Using buildbot properties: 15:50:28 INFO - { 15:50:28 INFO - "project": "", 15:50:28 INFO - "product": "firefox", 15:50:28 INFO - "who": "archaeopteryx@coole-files.de", 15:50:28 INFO - "installer_path": "public/build/target.tar.bz2", 15:50:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:50:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 15:50:28 INFO - "stage_platform": "linux64", 15:50:28 INFO - "basedir": "/builds/slave/test", 15:50:28 INFO - "buildnumber": 22, 15:50:28 INFO - "platform": "ubuntu64_hw", 15:50:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:50:28 INFO - "slavebuilddir": "test", 15:50:28 INFO - "taskId": "d-o72yx7SEWyQL6U4N0TBA", 15:50:28 INFO - "branch": "mozilla-central", 15:50:28 INFO - "script_repo_revision": "production", 15:50:28 INFO - "revision": "b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe", 15:50:28 INFO - "slavename": "talos-linux64-ix-054", 15:50:28 INFO - "repo_path": "mozilla-central" 15:50:28 INFO - } 15:50:28 INFO - Finding installer, test and symbols from parent task. 15:50:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-o72yx7SEWyQL6U4N0TBA'}, attempt #1 15:50:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d-o72yx7SEWyQL6U4N0TBA'}, attempt #1 15:50:29 INFO - Task dependencies: Nu1bmwwJTLu1t2PmdT-yrg 15:50:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg'}, attempt #1 15:50:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 15:50:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.test_packages.json 15:50:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.crashreporter-symbols.zip 15:50:30 INFO - Running post-action listener: _resource_record_post_action 15:50:30 INFO - [mozharness: 2017-09-14 22:50:30.194385Z] Finished read-buildbot-config step (success) 15:50:30 INFO - [mozharness: 2017-09-14 22:50:30.194601Z] Running download-and-extract step. 15:50:30 INFO - Running pre-action listener: _resource_record_pre_action 15:50:30 INFO - Running main action method: download_and_extract 15:50:30 INFO - mkdir: /builds/slave/test/build/tests 15:50:30 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:50:30 INFO - trying https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.test_packages.json 15:50:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:50:30 INFO - Downloaded 989 bytes. 15:50:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:50:30 INFO - Using the following test package requirements: 15:50:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:50:30 INFO - u'common': [u'target.common.tests.zip'], 15:50:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:50:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:50:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:50:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:50:30 INFO - u'mozbase': [u'target.common.tests.zip'], 15:50:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:50:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:50:30 INFO - u'web-platform': [u'target.common.tests.zip', 15:50:30 INFO - u'target.web-platform.tests.tar.gz'], 15:50:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:50:30 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:50:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.common.tests.zip 15:50:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:50:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.common.tests.zip into memory 15:50:33 INFO - Content-Length response header: 54593789 15:50:33 INFO - Bytes received: 54593789 15:50:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.talos.tests.zip 15:50:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:50:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.talos.tests.zip into memory 15:50:44 INFO - Content-Length response header: 14500356 15:50:44 INFO - Bytes received: 14500356 15:50: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:50:45 INFO - trying https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 15:50:45 INFO - Downloading https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:50:48 INFO - Downloaded 61400593 bytes. 15:50:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 15:50:48 INFO - mkdir: /builds/slave/test/properties 15:50:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:50:48 INFO - Writing to file /builds/slave/test/properties/build_url 15:50:48 INFO - Contents: 15:50:48 INFO - build_url:https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 15:50:48 INFO - Running post-action listener: _resource_record_post_action 15:50:48 INFO - Running post-action listener: find_tests_for_verification 15:50:48 INFO - Running post-action listener: set_extra_try_arguments 15:50:48 INFO - [mozharness: 2017-09-14 22:50:48.626795Z] Finished download-and-extract step (success) 15:50:48 INFO - [mozharness: 2017-09-14 22:50:48.626923Z] Running populate-webroot step. 15:50:48 INFO - Running pre-action listener: _resource_record_pre_action 15:50:48 INFO - Running main action method: populate_webroot 15:50:48 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:50:48 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['tresize', 15:50:48 INFO - 'tcanvasmark']}, 15:50:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:50:48 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['dromaeo_css', 15:50:48 INFO - 'kraken']}, 15:50:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:48 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:50:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'tests': ['damp', 'tps']}, 15:50:48 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['damp', 'tps']}, 15:50:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:50:48 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['dromaeo_dom']}, 15:50:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:50:48 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['basic_compositor_video', 15:50:48 INFO - 'glvideo']}, 15:50:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:50:48 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['ts_paint_webext', 15:50:48 INFO - 'tp5o_webext']}, 15:50:48 INFO - 'other-e10s': {'tests': ['a11yr', 15:50:48 INFO - 'ts_paint', 15:50:48 INFO - 'tpaint', 15:50:48 INFO - 'sessionrestore', 15:50:48 INFO - 'sessionrestore_many_windows', 15:50:48 INFO - 'sessionrestore_no_auto_restore', 15:50:48 INFO - 'tabpaint']}, 15:50:48 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['a11yr', 15:50:48 INFO - 'ts_paint', 15:50:48 INFO - 'tpaint', 15:50:48 INFO - 'sessionrestore', 15:50:48 INFO - 'sessionrestore_many_windows', 15:50:48 INFO - 'sessionrestore_no_auto_restore', 15:50:48 INFO - 'tabpaint']}, 15:50:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:50:48 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:50:48 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['bloom_basic_singleton']}, 15:50:48 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['bloom_basic']}, 15:50:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:50:48 INFO - 'tsvgr_opacity', 15:50:48 INFO - 'tart', 15:50:48 INFO - 'tscrollx', 15:50:48 INFO - 'tsvg_static']}, 15:50:48 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['tsvgx', 15:50:48 INFO - 'tsvgr_opacity', 15:50:48 INFO - 'tart', 15:50:48 INFO - 'tscrollx', 15:50:48 INFO - 'tsvg_static']}, 15:50:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:50:48 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo'], 15:50:48 INFO - 'tests': ['tp5o']}, 15:50:48 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:48 INFO - 'talos_options': ['--mitmproxy', 15:50:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:48 INFO - '--firstNonBlankPaint'], 15:50:48 INFO - 'tests': ['tp6_google', 15:50:48 INFO - 'tp6_youtube', 15:50:48 INFO - 'tp6_amazon', 15:50:48 INFO - 'tp6_facebook']}, 15:50:48 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo', 15:50:48 INFO - '--mitmproxy', 15:50:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:48 INFO - '--firstNonBlankPaint'], 15:50:48 INFO - 'tests': ['tp6_google', 15:50:48 INFO - 'tp6_youtube', 15:50:48 INFO - 'tp6_amazon', 15:50:48 INFO - 'tp6_facebook']}, 15:50:48 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:50:48 INFO - 'talos_options': ['--stylo-threads=1', 15:50:48 INFO - '--mitmproxy', 15:50:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:50:48 INFO - '--firstNonBlankPaint'], 15:50:48 INFO - 'tests': ['tp6_google', 15:50:48 INFO - 'tp6_youtube', 15:50:48 INFO - 'tp6_amazon', 15:50:48 INFO - 'tp6_facebook']}, 15:50:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--xperf_path', 15:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:48 INFO - 'tests': ['tp5n']}, 15:50:48 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:50:48 INFO - 'talos_options': ['--disable-stylo', 15:50:48 INFO - '--xperf_path', 15:50:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:50:48 INFO - 'tests': ['tp5n']}}} 15:50:48 INFO - Running post-action listener: _resource_record_post_action 15:50:48 INFO - [mozharness: 2017-09-14 22:50:48.650060Z] Finished populate-webroot step (success) 15:50:48 INFO - [mozharness: 2017-09-14 22:50:48.650159Z] Running create-virtualenv step. 15:50:48 INFO - Running pre-action listener: _resource_record_pre_action 15:50:48 INFO - Running main action method: create_virtualenv 15:50:48 INFO - Creating virtualenv /builds/slave/test/build/venv 15:50:48 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:50:48 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:50:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:50:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:50:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:50:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:50:49 INFO - Installing pip...............done. 15:50:49 INFO - Return code: 0 15:50:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:50:49 INFO - Reading from file tmpfile_stdout 15:50:49 INFO - Output received: 15:50:49 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:50:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:50:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:50:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:50:49 INFO - Using env: {'DISPLAY': ':0', 15:50:49 INFO - 'HOME': '/home/cltbld', 15:50:49 INFO - 'LANG': 'en_US.UTF-8', 15:50:49 INFO - 'LANGUAGE': 'en_US:en', 15:50:49 INFO - 'LOGNAME': 'cltbld', 15:50:49 INFO - 'MAIL': '/var/mail/cltbld', 15:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:49 INFO - 'MOZ_NO_REMOTE': '1', 15:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:49 INFO - 'NO_EM_RESTART': '1', 15:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:49 INFO - 'PWD': '/builds/slave/test', 15:50:49 INFO - 'SHELL': '/bin/bash', 15:50:49 INFO - 'SHLVL': '1', 15:50:49 INFO - 'TERM': 'linux', 15:50:49 INFO - 'TMOUT': '86400', 15:50:49 INFO - 'USER': 'cltbld', 15:50:49 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:49 INFO - '_': '/tools/buildbot/bin/python'} 15:50:55 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:50:55 INFO - Downloading/unpacking pip>=1.5 15:50:55 INFO - Running setup.py egg_info for package pip 15:50:55 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:55 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:55 INFO - Installing collected packages: pip 15:50:55 INFO - Found existing installation: pip 1.1 15:50:55 INFO - Uninstalling pip: 15:50:55 INFO - Successfully uninstalled pip 15:50:55 INFO - Running setup.py install for pip 15:50:55 INFO - warning: no files found matching 'pip/cacert.pem' 15:50:55 INFO - warning: no files found matching '*.html' under directory 'docs' 15:50:55 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:50:55 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:50:55 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:50:55 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:50:55 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:50:55 INFO - Successfully installed pip 15:50:55 INFO - Cleaning up... 15:50:55 INFO - Return code: 0 15:50:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:50:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:50:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:50:55 INFO - Using env: {'DISPLAY': ':0', 15:50:55 INFO - 'HOME': '/home/cltbld', 15:50:55 INFO - 'LANG': 'en_US.UTF-8', 15:50:55 INFO - 'LANGUAGE': 'en_US:en', 15:50:55 INFO - 'LOGNAME': 'cltbld', 15:50:55 INFO - 'MAIL': '/var/mail/cltbld', 15:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:55 INFO - 'MOZ_NO_REMOTE': '1', 15:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:55 INFO - 'NO_EM_RESTART': '1', 15:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:55 INFO - 'PWD': '/builds/slave/test', 15:50:55 INFO - 'SHELL': '/bin/bash', 15:50:55 INFO - 'SHLVL': '1', 15:50:55 INFO - 'TERM': 'linux', 15:50:55 INFO - 'TMOUT': '86400', 15:50:55 INFO - 'USER': 'cltbld', 15:50:55 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:55 INFO - '_': '/tools/buildbot/bin/python'} 15:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:55 INFO - Downloading/unpacking psutil>=3.1.1 15:50: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:50: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:50: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:50: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:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:56 INFO - Installing collected packages: psutil 15:50:56 INFO - Running setup.py install for psutil 15:50:56 INFO - building 'psutil._psutil_linux' extension 15:50:56 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:50:56 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:50:57 INFO - building 'psutil._psutil_posix' extension 15:50:57 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:50:57 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:50:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:50:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:50:57 INFO - Successfully installed psutil 15:50:57 INFO - Cleaning up... 15:50:57 INFO - Return code: 0 15:50:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:50: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:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50: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:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:50:57 INFO - Using env: {'DISPLAY': ':0', 15:50:57 INFO - 'HOME': '/home/cltbld', 15:50:57 INFO - 'LANG': 'en_US.UTF-8', 15:50:57 INFO - 'LANGUAGE': 'en_US:en', 15:50:57 INFO - 'LOGNAME': 'cltbld', 15:50:57 INFO - 'MAIL': '/var/mail/cltbld', 15:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:57 INFO - 'MOZ_NO_REMOTE': '1', 15:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:57 INFO - 'NO_EM_RESTART': '1', 15:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:57 INFO - 'PWD': '/builds/slave/test', 15:50:57 INFO - 'SHELL': '/bin/bash', 15:50:57 INFO - 'SHLVL': '1', 15:50:57 INFO - 'TERM': 'linux', 15:50:57 INFO - 'TMOUT': '86400', 15:50:57 INFO - 'USER': 'cltbld', 15:50:57 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:57 INFO - '_': '/tools/buildbot/bin/python'} 15:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:50:59 INFO - Installing collected packages: mozsystemmonitor 15:50:59 INFO - Running setup.py install for mozsystemmonitor 15:50:59 INFO - Successfully installed mozsystemmonitor 15:50:59 INFO - Cleaning up... 15:50:59 INFO - Return code: 0 15:50:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:50:59 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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:50:59 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:50:59 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:50:59 INFO - Using env: {'DISPLAY': ':0', 15:50:59 INFO - 'HOME': '/home/cltbld', 15:50:59 INFO - 'LANG': 'en_US.UTF-8', 15:50:59 INFO - 'LANGUAGE': 'en_US:en', 15:50:59 INFO - 'LOGNAME': 'cltbld', 15:50:59 INFO - 'MAIL': '/var/mail/cltbld', 15:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:59 INFO - 'MOZ_NO_REMOTE': '1', 15:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:59 INFO - 'NO_EM_RESTART': '1', 15:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:59 INFO - 'PWD': '/builds/slave/test', 15:50:59 INFO - 'SHELL': '/bin/bash', 15:50:59 INFO - 'SHLVL': '1', 15:50:59 INFO - 'TERM': 'linux', 15:50:59 INFO - 'TMOUT': '86400', 15:50:59 INFO - 'USER': 'cltbld', 15:50:59 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:59 INFO - '_': '/tools/buildbot/bin/python'} 15:50:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:50:59 INFO - Downloading/unpacking jsonschema==2.5.1 15:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:50:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:51:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:00 INFO - Downloading functools32-3.2.3-2.tar.gz 15:51:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:51:00 INFO - warning: no files found matching '*.txt' 15:51:00 INFO - no previously-included directories found matching 'build' 15:51:00 INFO - no previously-included directories found matching 'dist' 15:51:00 INFO - no previously-included directories found matching '.git*' 15:51:00 INFO - Installing collected packages: jsonschema, functools32 15:51:00 INFO - Running setup.py install for functools32 15:51:00 INFO - warning: no files found matching '*.txt' 15:51:00 INFO - no previously-included directories found matching 'build' 15:51:00 INFO - no previously-included directories found matching 'dist' 15:51:00 INFO - no previously-included directories found matching '.git*' 15:51:00 INFO - Successfully installed jsonschema functools32 15:51:00 INFO - Cleaning up... 15:51:01 INFO - Return code: 0 15:51:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:51:01 INFO - Using env: {'DISPLAY': ':0', 15:51:01 INFO - 'HOME': '/home/cltbld', 15:51:01 INFO - 'LANG': 'en_US.UTF-8', 15:51:01 INFO - 'LANGUAGE': 'en_US:en', 15:51:01 INFO - 'LOGNAME': 'cltbld', 15:51:01 INFO - 'MAIL': '/var/mail/cltbld', 15:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:01 INFO - 'MOZ_NO_REMOTE': '1', 15:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:01 INFO - 'NO_EM_RESTART': '1', 15:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:01 INFO - 'PWD': '/builds/slave/test', 15:51:01 INFO - 'SHELL': '/bin/bash', 15:51:01 INFO - 'SHLVL': '1', 15:51:01 INFO - 'TERM': 'linux', 15:51:01 INFO - 'TMOUT': '86400', 15:51:01 INFO - 'USER': 'cltbld', 15:51:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:01 INFO - '_': '/tools/buildbot/bin/python'} 15:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:51:01 INFO - Cleaning up... 15:51:01 INFO - Return code: 0 15:51:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:51:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:51:01 INFO - Using env: {'DISPLAY': ':0', 15:51:01 INFO - 'HOME': '/home/cltbld', 15:51:01 INFO - 'LANG': 'en_US.UTF-8', 15:51:01 INFO - 'LANGUAGE': 'en_US:en', 15:51:01 INFO - 'LOGNAME': 'cltbld', 15:51:01 INFO - 'MAIL': '/var/mail/cltbld', 15:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:01 INFO - 'MOZ_NO_REMOTE': '1', 15:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:01 INFO - 'NO_EM_RESTART': '1', 15:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:01 INFO - 'PWD': '/builds/slave/test', 15:51:01 INFO - 'SHELL': '/bin/bash', 15:51:01 INFO - 'SHLVL': '1', 15:51:01 INFO - 'TERM': 'linux', 15:51:01 INFO - 'TMOUT': '86400', 15:51:01 INFO - 'USER': 'cltbld', 15:51:01 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:01 INFO - '_': '/tools/buildbot/bin/python'} 15:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:02 INFO - Downloading blobuploader-1.2.4.tar.gz 15:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:51:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:51: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:51: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:51: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:51: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:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:51:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:51: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:51: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:51: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:51: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:51:03 INFO - Downloading docopt-0.6.1.tar.gz 15:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:51:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:51:03 INFO - Running setup.py install for blobuploader 15:51:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:51:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:51:03 INFO - Running setup.py install for requests 15:51:03 INFO - Running setup.py install for docopt 15:51:03 INFO - Successfully installed blobuploader requests docopt 15:51:03 INFO - Cleaning up... 15:51:03 INFO - Return code: 0 15:51:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:03 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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:03 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:51:03 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:51:03 INFO - Using env: {'DISPLAY': ':0', 15:51:03 INFO - 'HOME': '/home/cltbld', 15:51:03 INFO - 'LANG': 'en_US.UTF-8', 15:51:03 INFO - 'LANGUAGE': 'en_US:en', 15:51:03 INFO - 'LOGNAME': 'cltbld', 15:51:03 INFO - 'MAIL': '/var/mail/cltbld', 15:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:03 INFO - 'MOZ_NO_REMOTE': '1', 15:51:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:03 INFO - 'NO_EM_RESTART': '1', 15:51:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:03 INFO - 'PWD': '/builds/slave/test', 15:51:03 INFO - 'SHELL': '/bin/bash', 15:51:03 INFO - 'SHLVL': '1', 15:51:03 INFO - 'TERM': 'linux', 15:51:03 INFO - 'TMOUT': '86400', 15:51:03 INFO - 'USER': 'cltbld', 15:51:03 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:03 INFO - '_': '/tools/buildbot/bin/python'} 15:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:03 INFO - Running setup.py (path:/tmp/pip-gkFZFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:04 INFO - Running setup.py (path:/tmp/pip-o0jm_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:04 INFO - Running setup.py (path:/tmp/pip-d9p9CP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:04 INFO - Running setup.py (path:/tmp/pip-rCOIDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:04 INFO - Running setup.py (path:/tmp/pip-wM6t61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:04 INFO - Running setup.py (path:/tmp/pip-P08s6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:04 INFO - Running setup.py (path:/tmp/pip-1KWYXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:04 INFO - Running setup.py (path:/tmp/pip-kl0Z5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:04 INFO - Running setup.py (path:/tmp/pip-HlJ7Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:04 INFO - Running setup.py (path:/tmp/pip-QlSnRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:04 INFO - Running setup.py (path:/tmp/pip-MH4JEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:04 INFO - Running setup.py (path:/tmp/pip-fOkHBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 INFO - Running setup.py (path:/tmp/pip-c3V27M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 INFO - Running setup.py (path:/tmp/pip-z_UjiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:04 INFO - Running setup.py (path:/tmp/pip-W9L9Z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:05 INFO - Running setup.py (path:/tmp/pip-BzvH8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:05 INFO - Running setup.py (path:/tmp/pip-FiQoqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:51:05 INFO - Running setup.py install for manifestparser 15:51:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozcrash 15:51:05 INFO - Running setup.py install for mozdebug 15:51:05 INFO - Running setup.py install for mozdevice 15:51:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozfile 15:51:05 INFO - Running setup.py install for mozhttpd 15:51:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozinfo 15:51:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozInstall 15:51:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:51:05 INFO - Running setup.py install for mozleak 15:51:06 INFO - Running setup.py install for mozlog 15:51:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Running setup.py install for moznetwork 15:51:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Running setup.py install for mozprocess 15:51:06 INFO - Running setup.py install for mozprofile 15:51:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Running setup.py install for mozrunner 15:51:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Running setup.py install for mozscreenshot 15:51:06 INFO - Running setup.py install for moztest 15:51:06 INFO - Running setup.py install for mozversion 15:51:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:51:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:51:06 INFO - Cleaning up... 15:51:06 INFO - Return code: 0 15:51:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51: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:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51: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:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:06 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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:06 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:51:06 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:51:06 INFO - Using env: {'DISPLAY': ':0', 15:51:06 INFO - 'HOME': '/home/cltbld', 15:51:06 INFO - 'LANG': 'en_US.UTF-8', 15:51:06 INFO - 'LANGUAGE': 'en_US:en', 15:51:06 INFO - 'LOGNAME': 'cltbld', 15:51:06 INFO - 'MAIL': '/var/mail/cltbld', 15:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:06 INFO - 'MOZ_NO_REMOTE': '1', 15:51:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:06 INFO - 'NO_EM_RESTART': '1', 15:51:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:06 INFO - 'PWD': '/builds/slave/test', 15:51:06 INFO - 'SHELL': '/bin/bash', 15:51:06 INFO - 'SHLVL': '1', 15:51:06 INFO - 'TERM': 'linux', 15:51:06 INFO - 'TMOUT': '86400', 15:51:06 INFO - 'USER': 'cltbld', 15:51:06 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:06 INFO - '_': '/tools/buildbot/bin/python'} 15:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:51:07 INFO - Running setup.py (path:/tmp/pip-NTEE2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:51:07 INFO - Running setup.py (path:/tmp/pip-T24hR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:51:07 INFO - Running setup.py (path:/tmp/pip-3srcF9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:51:07 INFO - Running setup.py (path:/tmp/pip-Tc7y2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:51:07 INFO - Running setup.py (path:/tmp/pip-t9aJ9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:51:07 INFO - Running setup.py (path:/tmp/pip-XLF82w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:51:07 INFO - Running setup.py (path:/tmp/pip-Or1qaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:51:07 INFO - Running setup.py (path:/tmp/pip-obKTg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:51:07 INFO - Running setup.py (path:/tmp/pip-D9q44o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:51:07 INFO - Running setup.py (path:/tmp/pip-LSg8pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:51:07 INFO - Running setup.py (path:/tmp/pip-Rpp_Eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:51:07 INFO - Running setup.py (path:/tmp/pip-p2v0wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:51:07 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:51:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:51:07 INFO - Running setup.py (path:/tmp/pip-kd_045-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:51:08 INFO - Running setup.py (path:/tmp/pip-DFFRyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:08 INFO - Running setup.py (path:/tmp/pip-1P2TAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:51:08 INFO - Running setup.py (path:/tmp/pip-UPoyQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:51:08 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:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:51:08 INFO - Running setup.py (path:/tmp/pip-fKgUoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 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:51:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:51:08 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:51:08 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:51:08 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:51:08 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:51:09 INFO - Downloading blessings-1.6.tar.gz 15:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:51:09 INFO - Installing collected packages: blessings 15:51:09 INFO - Running setup.py install for blessings 15:51:09 INFO - Successfully installed blessings 15:51:09 INFO - Cleaning up... 15:51:09 INFO - Return code: 0 15:51:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:51:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:09 INFO - Reading from file tmpfile_stdout 15:51:09 INFO - Current package versions: 15:51:09 INFO - argparse == 1.2.1 15:51:09 INFO - blessings == 1.6 15:51:09 INFO - blobuploader == 1.2.4 15:51:09 INFO - docopt == 0.6.1 15:51:09 INFO - functools32 == 3.2.3-2 15:51:09 INFO - jsonschema == 2.5.1 15:51:09 INFO - manifestparser == 1.1 15:51:09 INFO - mozInstall == 1.13 15:51:09 INFO - mozcrash == 1.0 15:51:09 INFO - mozdebug == 0.1 15:51:09 INFO - mozdevice == 0.51 15:51:09 INFO - mozfile == 1.2 15:51:09 INFO - mozhttpd == 0.7 15:51:09 INFO - mozinfo == 0.10 15:51:09 INFO - mozleak == 0.1 15:51:09 INFO - mozlog == 3.5 15:51:09 INFO - moznetwork == 0.27 15:51:09 INFO - mozprocess == 0.25 15:51:09 INFO - mozprofile == 0.28 15:51:09 INFO - mozrunner == 6.13 15:51:09 INFO - mozscreenshot == 0.1 15:51:09 INFO - mozsystemmonitor == 0.3 15:51:09 INFO - moztest == 0.8 15:51:09 INFO - mozversion == 1.4 15:51:09 INFO - psutil == 3.1.1 15:51:09 INFO - requests == 1.2.3 15:51:09 INFO - wsgiref == 0.1.2 15:51:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:09 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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:09 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:51:09 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:51:09 INFO - Using env: {'DISPLAY': ':0', 15:51:09 INFO - 'HOME': '/home/cltbld', 15:51:09 INFO - 'LANG': 'en_US.UTF-8', 15:51:09 INFO - 'LANGUAGE': 'en_US:en', 15:51:09 INFO - 'LOGNAME': 'cltbld', 15:51:09 INFO - 'MAIL': '/var/mail/cltbld', 15:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:09 INFO - 'MOZ_NO_REMOTE': '1', 15:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:09 INFO - 'NO_EM_RESTART': '1', 15:51:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:09 INFO - 'PWD': '/builds/slave/test', 15:51:09 INFO - 'SHELL': '/bin/bash', 15:51:09 INFO - 'SHLVL': '1', 15:51:09 INFO - 'TERM': 'linux', 15:51:09 INFO - 'TMOUT': '86400', 15:51:09 INFO - 'USER': 'cltbld', 15:51:09 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:09 INFO - '_': '/tools/buildbot/bin/python'} 15:51:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:51:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:51:11 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:51:11 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:51:11 INFO - Installing collected packages: simplejson 15:51:11 INFO - Running setup.py install for simplejson 15:51:11 INFO - building 'simplejson._speedups' extension 15:51:11 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:51:12 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:51:12 INFO - Successfully installed simplejson 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:51:12 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 0x131d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1689a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, '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': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', '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:51:12 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:51:12 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:51:12 INFO - Using env: {'DISPLAY': ':0', 15:51:12 INFO - 'HOME': '/home/cltbld', 15:51:12 INFO - 'LANG': 'en_US.UTF-8', 15:51:12 INFO - 'LANGUAGE': 'en_US:en', 15:51:12 INFO - 'LOGNAME': 'cltbld', 15:51:12 INFO - 'MAIL': '/var/mail/cltbld', 15:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:12 INFO - 'MOZ_NO_REMOTE': '1', 15:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:12 INFO - 'NO_EM_RESTART': '1', 15:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:12 INFO - 'PWD': '/builds/slave/test', 15:51:12 INFO - 'SHELL': '/bin/bash', 15:51:12 INFO - 'SHLVL': '1', 15:51:12 INFO - 'TERM': 'linux', 15:51:12 INFO - 'TMOUT': '86400', 15:51:12 INFO - 'USER': 'cltbld', 15:51:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:12 INFO - '_': '/tools/buildbot/bin/python'} 15:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:51:12 INFO - Cleaning up... 15:51:12 INFO - Return code: 0 15:51:12 INFO - Running post-action listener: _resource_record_post_action 15:51:12 INFO - Running post-action listener: _start_resource_monitoring 15:51:12 INFO - Starting resource monitoring. 15:51:12 INFO - [mozharness: 2017-09-14 22:51:12.594612Z] Finished create-virtualenv step (success) 15:51:12 INFO - [mozharness: 2017-09-14 22:51:12.595132Z] Running install step. 15:51:12 INFO - Running pre-action listener: _resource_record_pre_action 15:51:12 INFO - Running main action method: install 15:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:51:12 INFO - Reading from file tmpfile_stdout 15:51:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:51:12 INFO - Reading from file tmpfile_stdout 15:51:12 INFO - Output received: 15:51:12 INFO - Usage: mozinstall [options] installer 15:51:12 INFO - Options: 15:51:12 INFO - -h, --help show this help message and exit 15:51:12 INFO - -d DEST, --destination=DEST 15:51:12 INFO - Directory to install application into. [default: 15:51:12 INFO - "/builds/slave/test"] 15:51:12 INFO - --app=APP Application being installed. [default: firefox] 15:51:12 INFO - mkdir: /builds/slave/test/build/application 15:51:12 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:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:51:30 INFO - Reading from file tmpfile_stdout 15:51:30 INFO - Output received: 15:51:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:51:30 INFO - Running post-action listener: _resource_record_post_action 15:51:30 INFO - [mozharness: 2017-09-14 22:51:30.672822Z] Finished install step (success) 15:51:30 INFO - [mozharness: 2017-09-14 22:51:30.673073Z] Running setup-mitmproxy step. 15:51:30 INFO - Running pre-action listener: _resource_record_pre_action 15:51:30 INFO - Running main action method: setup_mitmproxy 15:51:30 INFO - Skipping: mitmproxy is not required 15:51:30 INFO - Running post-action listener: _resource_record_post_action 15:51:30 INFO - [mozharness: 2017-09-14 22:51:30.674198Z] Finished setup-mitmproxy step (success) 15:51:30 INFO - [mozharness: 2017-09-14 22:51:30.674418Z] Running run-tests step. 15:51:30 INFO - Running pre-action listener: _resource_record_pre_action 15:51:30 INFO - Running pre-action listener: _set_gcov_prefix 15:51:30 INFO - Running main action method: run_tests 15:51:30 WARNING - Try message not found. 15:51:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:51:30 INFO - Python 2.7.3 15:51:30 INFO - Return code: 0 15:51:30 INFO - grabbing minidump binary from tooltool 15:51:30 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:51:30 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 0x168d090>, '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 0x168dd80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1687f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:51:30 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:51:30 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:51:30 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:51:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:51:30 INFO - Return code: 0 15:51:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:51:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:51:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:51:30 INFO - ENV: RUST_BACKTRACE is now full 15:51:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:51:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:51:30 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/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:51:30 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/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --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:51:30 INFO - Using env: {'DISPLAY': ':0', 15:51:30 INFO - 'HOME': '/home/cltbld', 15:51:30 INFO - 'LANG': 'en_US.UTF-8', 15:51:30 INFO - 'LANGUAGE': 'en_US:en', 15:51:30 INFO - 'LOGNAME': 'cltbld', 15:51:30 INFO - 'MAIL': '/var/mail/cltbld', 15:51:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:30 INFO - 'MOZ_NO_REMOTE': '1', 15:51:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:30 INFO - 'NO_EM_RESTART': '1', 15:51:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:30 INFO - 'PWD': '/builds/slave/test', 15:51:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:30 INFO - 'RUST_BACKTRACE': 'full', 15:51:30 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:30 INFO - 'SHELL': '/bin/bash', 15:51:30 INFO - 'SHLVL': '1', 15:51:30 INFO - 'TERM': 'linux', 15:51:30 INFO - 'TMOUT': '86400', 15:51:30 INFO - 'USER': 'cltbld', 15:51:30 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:30 INFO - '_': '/tools/buildbot/bin/python'} 15:51:30 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/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:51:31 INFO - mozversion application_buildid: 20170914215707 15:51:31 INFO - mozversion application_changeset: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe 15:51:31 INFO - mozversion application_display_name: Nightly 15:51:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:51:31 INFO - mozversion application_name: Firefox 15:51:31 INFO - mozversion application_remotingname: firefox 15:51:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:51:31 INFO - mozversion application_vendor: Mozilla 15:51:31 INFO - mozversion application_version: 57.0a1 15:51:31 INFO - mozversion platform_buildid: 20170914215707 15:51:31 INFO - mozversion platform_changeset: b778b6cb49c8ed1dab244c00dc4dc3cf88b25ffe 15:51:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:51:31 INFO - mozversion platform_version: 57.0a1 15:51:31 INFO - using testdate: 1505429491 15:51:31 INFO - actual date: 1505429491 15:51:31 INFO - starting webserver on 'localhost:55567' 15:51:31 INFO - SUITE-START | Running 2 tests 15:51:31 INFO - TEST-START | dromaeo_css 15:51:31 INFO - Initialising browser for dromaeo_css test... 15:51:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55567/getInfo.html -profile /tmp/tmpm31Oyq/profile 15:51:31 INFO - TEST-INFO | started process 10456 (/builds/slave/test/build/application/firefox/firefox http://localhost:55567/getInfo.html) 15:51:36 INFO - TEST-INFO | 10456: exit 0 15:51:37 INFO - Browser initialized. 15:51:37 INFO - Running cycle 1/1 for dromaeo_css test... 15:51:37 INFO - Using env: {'DISPLAY': ':0', 15:51:37 INFO - 'HOME': '/home/cltbld', 15:51:37 INFO - 'JSGC_DISABLE_POISONING': '1', 15:51:37 INFO - 'LANG': 'en_US.UTF-8', 15:51:37 INFO - 'LANGUAGE': 'en_US:en', 15:51:37 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:51:37 INFO - 'LOGNAME': 'cltbld', 15:51:37 INFO - 'MAIL': '/var/mail/cltbld', 15:51:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:51:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:51:37 INFO - 'MOZ_CRASHREPORTER': '1', 15:51:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:51:37 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:51:37 INFO - 'MOZ_NO_REMOTE': '1', 15:51:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:51:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:51:37 INFO - 'NO_EM_RESTART': '1', 15:51:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:51:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:51:37 INFO - 'PWD': '/builds/slave/test', 15:51:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:51:37 INFO - 'RUST_BACKTRACE': 'full', 15:51:37 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:51:37 INFO - 'SHELL': '/bin/bash', 15:51:37 INFO - 'SHLVL': '1', 15:51:37 INFO - 'STYLO_FORCE_DISABLED': '1', 15:51:37 INFO - 'TERM': 'linux', 15:51:37 INFO - 'TMOUT': '86400', 15:51:37 INFO - 'USER': 'cltbld', 15:51:37 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 15:51:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:51:37 INFO - '_': '/tools/buildbot/bin/python'} 15:51:37 INFO - TEST-INFO | started process 10688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm31Oyq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:38 INFO - PID 10688 | 15:51:38 INFO - PID 10688 | (/builds/slave/test/build/application/firefox/firefox:10737): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:51:38 INFO - PID 10688 | 15:51:48 INFO - PID 10688 | RSS: Main: 173776896 15:51:48 INFO - PID 10688 | 15:54:45 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55567/tests/dromaeo/cssquery-ext.html) 15:54:46 INFO - PID 10688 | RSS: Main: 175882240 15:54:46 INFO - PID 10688 | 15:57:48 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-ext.html (next: http://localhost:55567/tests/dromaeo/cssquery-jquery.html) 15:57:48 INFO - PID 10688 | RSS: Main: 172126208 15:57:48 INFO - PID 10688 | 16:00:50 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55567/tests/dromaeo/cssquery-mootools.html) 16:00:51 INFO - PID 10688 | RSS: Main: 174940160 16:00:51 INFO - PID 10688 | 16:03:53 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55567/tests/dromaeo/cssquery-prototype.html) 16:03:53 INFO - PID 10688 | RSS: Main: 172937216 16:03:53 INFO - PID 10688 | 16:06:56 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55567/tests/dromaeo/cssquery-yui.html) 16:06:57 INFO - PID 10688 | RSS: Main: 174919680 16:06:57 INFO - PID 10688 | 16:09:58 INFO - PID 10688 | Cycle 1(1): loaded http://localhost:55567/tests/dromaeo/cssquery-yui.html (next: http://localhost:55567/tests/dromaeo/cssquery-dojo.html) 16:09:59 INFO - PID 10688 | RSS: Main: 177164288 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | __start_tp_report 16:09:59 INFO - PID 10688 | _x_x_mozilla_page_load 16:09:59 INFO - PID 10688 | _x_x_mozilla_page_load_details 16:09:59 INFO - PID 10688 | |i|pagename|runs| 16:09:59 INFO - PID 10688 | |0;dojo.html;3138.984305078475;3172.984135079325;3174.6507884132725;3201.2797120647842;3215.1479857837676;6105.084237364397;6140.416660417253;6251.249850017998;6284.497240220783;6352.777652782153;6166.229221347332;6183.227096612924;6192.102145188945;6227.159333489977;6245.4066863647995;5706.258186435768;5735.111057786029;5744.59787814851;5793.33376661683;5873.588848780587;5767.42325767422;5814.360420353758;5827.825165245049;5831;5841.707914604252;1226.2448060167017;5663.122216056477;5798.246227990356;5841.970790146064;5867.647941123525;5288.338957630296;5664.518515926151;5706;5781.508571771405;5801.245838041028;5684.914726279109;5699.344575373802;5768.077107662753;5769.221155144044;5779.104238842986;6145.84635384119;6193.845153871144;6285.088662143963;6302.621842689453;6315.5894866833505;6681.966590167067;6710.060591517192;6760.492963027793;6766.69549870257;6789.626570538619;6584.374484423972;6685.164354455693;6765.289644587346;6768.120144381248;6856.074429951943;6155.322914479404;6185.721642526097;6194.845128871814;6204.379562043805;6204.937950620526;6706.161729783777;6833.555818871758;6849.657517124124;6862.073620061228;6902.206246281641;6583.341665833378;6592.373724496165;6674.399304062657;6674.5327827052615;6686.99695045747;6683.7660681875905;6688.933110668929;6725.125733654593;6788.185417749803;6791.388775010174;6516.706748196342;6613.6362500062;6617.7683781067435;6621.966890165519;6641.701123449457;6588;6648.301928297556;6675.899861501985;6748.6963086660235;6750.966245168841;5327.840164795062;5329.7068661224;5331.333583302087;5341.252224688546;5345.839624811262;4640.373549570765;4643.016179308284;4661.557152070615;4667.556582124693;4676.08816280822;5652;5735.254416925856;5786.537077033827;5798.623089499169;5875.059990401515;6776.220734615484;6799.762008329685;6802.217744959294;6821.113255276782;6829.3170682932305;5720.256366672306;5841;5849.912251316234;5865.706714664335;5874.265716785402;5752.45351691597;5771.740271687784;5843.620164689281;5843.678597677169;5853.795117170878;6282.842928926813;6410.583312084793;6457.838554036092;6562.442192413603;6562.67186640666;6786.8303292417095;6812.455003599601;6824.454043676395;6831.829204269933;6838.2136054352395;6470.191226096738;6484.286728459771;6488.837779055561;6499.6750162492635;6565.770198043237;6464.450521705708;6548.050532672831;6593.571417857824;6677.666116694243;6679.799606011828;6737.393634572716;6823.488238382042;6824.829379265558;6833.726650933907;6843.452523798183;6476.579022363531;6598.406143447113;6601.273859875314;6640.501962352746;6649.833754155991;6537.117489139096;6543.378379053982;6550.672466376567;6636.933630663631;6639.535232533676;6307.369263073656;6393.328700486382;6482;6560.704768285534;6564.934350656432;6435.259945106185;6459.677016149268;6477.611343319416;6497.837554060997;6521.739130434729;6166.784162554289;6242.875142497215;6247.875042499034;6266.592671476339;6268.592541484789 16:09:59 INFO - PID 10688 | |1;ext.html;807.2976510435922;860.8063185783199;882.1663527966075;887.2414085956507;888.6978427334705;38749.806250968744;40331.395029074585;40555.79722101393;40706.38940415892;40762.18475630486;37088.44367334485;37395.06512337193;37523.81238093813;37599;37658.0585485363;6811.897821532669;6845.726170953156;6939.44484441246;6948.965255173743;6953.235144134166;6867.690953907087;6938.236793952661;6944.201416837052;6946.097007389032;6952.2700116487795;6928.203256625477;6955.547889387199;6955.860882782366;6956.478264130211;6973.895391569105;7562.886556701654;7723.65243564041;7729.033870766154;7736.34241089508;7768.844623107534;7488.4009279257525;7562.168161502231;7584.848303033964;7602.011738474018;7609.505382150142;36813.631863681556;38202.80898595489;38762.612373876465;38802;38969.61030389716;3197.1207917822785;3219.388316219911;3237.5629290045777;3237.7895436796534;3238.6923242291946;31547.842260788777;31568.526472102938;31601.525977110363;31677;31830.363392732015;5164.070467315882;5165.147750621143;5187.455317191679;5196.45437229093;5197.610179236573;179227.10386447984;180831;181368;181372.0931395348;181533.9999999987;46533;46596.5340346599;46694;46958.76520617375;47008.5299147011;48588.51411485911;48893.266601001014;49324;49324.506754931994;49371.75314123406;15325.31036103378;15465.922670386575;15487.767683484757;15515.689686206213;15598.220088995506;12557.74884502323;12583.245005299712;12584.307863067435;12589.93705031469;12590.81113783294;13899.444022239199;14115;14176.291185440687;14375.712485750226;14383.568492945229;5551.472610102034;5593.524550413261;5631.267935168484;5697.6296540724725;5749.8562535936935;980.4313498171043;983.3755565216139;987.7086259553449;1013.7668336282696;1014.0518615094762;22461.55076898453;22710.31869043931;22799.31602051941;22878.771212287666;22933;1086.9021788038956;1096.8025755363951;1099.9780004399868;1100.0044959311836;1110.0730889707024;11913.880861191277;12209.389530523438;12250.632481025583;12268.957138643136;12278.894899459092;225537;228861;228960;228988;229737;43524.78237608792;51182.48817511852;51498.22752658713;52016.479835201164;52188.21717674162;1431.8782903453114;1457.6574504991318;1461.7734251191082;1463.4804644351102;1473.1823837770141;25655.230343089737;26495.867520662272;26509.867450662623;26637.334066648487;27209.86395068012;36591;36670.08324791795;36806.44790328201;36840.63159368372;36875.63124368722;200107;200258;200322;200487;200496;33790.49314260337;33914;34044.829775850965;34152.65847341495;34266.14334641654;40198;42271.7886410566;42729.78635106929;42871.14257714766;42901.356479653456;30556;30931.2267193313;31035.22411939629;31177.688223118384;32120.678793212704;30698.079057628307;30974.535381969738;31093.378132437676;31247.218819529695;31248.21879453032;33804.32391352209;34290.82854585711;34626.30747385089;34800.82599586986;35062;30171.245718857204;30346.241343965696;30351.544726828673;30537.54193687141;30933.8453307732;22673.773262267165;22781.77218227863;22936.541269174188;22966.770332296463;23103.422414439774 16:09:59 INFO - PID 10688 | |2;jquery.html;552.4889477233557;563.8280324501028;564.757154423598;580.7386675995801;588.5762251179151;22001.119955201793;22903.885480572575;23022.424439389022;23047;23130.537389252226;23327.416814579643;24320.635190472112;24444.877775611098;24653.75346246537;24697.876510617465;6582.934170658292;6713.2951040140815;6753.223379311393;6753.628550429725;6757.290484499131;6620.735170593171;6712.429443497309;6712.83217919551;6712.899306510406;6715.56348837324;6307.621542707429;6600.867982640344;6601.174853143357;6614.37163469472;6681.933180668204;6508.804735857908;6556.770513032021;6570.408663220333;6571.2771595124495;6572.277049524549;5957.612755170943;5994.370591087916;6022.578419510636;6072;6226.1905952225925;27577.724222757715;27931.720682793115;28116.578251326246;28127.437451250862;28129.57805632917;2086.9791302086937;2118.7457505099333;2118.7457505099333;2121.1727426303755;2121.374194612593;18499.537511562183;18830.246790128378;19070.14184361707;19091.713624295648;19202.423927282205;2419.2823095601966;2419.4193393585415;2467.6175192844958;2473.109680515013;2474.134053081425;117081.41459292649;123203.3839830804;123513.38243308816;131066;133551;14311.040112212957;14470.565883023526;14505.854941450661;14639.194844283667;14715.92642036783;22492.88753556222;22708.65937010946;22761.772382275965;22781;22781.202657906895;9828.476586129162;10026.298159128937;10224.437655928847;10227.693169204937;10321.948390258001;9255.814883702289;9327.300452465957;9379.296552758571;9440.291978101532;9453.243740500744;8683.884627676583;8845.513496757612;8850.468971861708;9004.234640055669;9183.724488265363;2575.961360579593;2580.3936075022357;2623.252373073665;2659.880305386262;2677.9598306025423;947.2564037230741;964.4358050540512;969.2052516936045;995.348047029197;1007.8337074382791;18520.81479185218;18522.444326670222;18852.81147188538;19120.713189302172;19300.420987370402;1008.7478130467383;1021.6475316015963;1031.3141760729031;1037.0510982451124;1038.3925403638805;10245.48772561369;10455.902130276363;10663.893361066444;10681.786364272672;10864.94567527173;427500;437978;439703;441069;447158;107555;107750;109358;109640.4517977405;111563.4421827902;1026.5124066068558;1135.5684839761004;1146.1633007904277;1189.4409627475072;1200.75984803038;19459.437847347122;19489;19766.50583735418;19837.60324793525;19908.402747917586;51493.485065150366;52858.735706321226;53291.73354133205;53551.19673204983;54326;65636.6718166406;65816.34183658102;65928;66073.33926660672;67774.66112669405;13864;14128.081674691111;14240.643983900485;14257.144571325754;14271.785923210953;21955.231566895083;22055.44861378414;22325.441863953532;22532.88733556387;22551.5489690202;17871.28514859391;18013.2794688211;18146.45560633183;18205;18257;15770.68458630798;15974.121423321829;16373.42693005739;16391.34434622602;16507.174641268128;17175.828241717423;18388.448346549623;18462.261509540007;18570.81429185745;18599.34902278414;14035.859641403864;14037.438502459787;14051;14060;14102.576922692335;17748.3788067417;17972.640547188723;18070.09649517545;18070.457886263433;18100.09499525045 16:09:59 INFO - PID 10688 | |3;mootools.html;1320.9009324300678;1386.1475192756452;1405.6345350208942;1416.369715476613;1439.654482924098;14498.347574359153;15226.543203703906;15244.923775381121;15268.84731152688;15282.617934551641;14834.925825370858;15154.545363639108;15160.6967860643;15164;15164;2640.419107796282;2703.040420650665;2738.0553708970374;2740.4519096180743;2752.3669556002133;2652.323657467353;2684.650995370599;2693.3939863530645;2718.429129882727;2718.714534973829;2506.1103308325555;2689.287338855205;2690.7443792839745;2693.3670587411943;2693.8383696978244;2776.6806817215875;2788.6235358226686;2798.1046065259125;2802.5095608268575;2814.634097567324;2541.872906354675;2680.1021657744677;2769.695333513312;2773.1819113361607;2778.833270003786;15241;15288.617784555363;15353.769693454607;15361.846381536154;15389.615259618487;7881.605919703992;8150.796230094295;8172.918270817335;8177.223163799429;8192.631331590033;5172.793088276464;5328.44051374604;5379.488948549921;5491.945080549223;5496.587755918322;1797;1803.8105998870192;1815.7185636226407;1835.9449216523526;1854.1192933356547;25731.61402578963;26225.033122515888;26422.339441513923;26423.67881605912;26476.73523264762;6610.107635469246;6794.45644348451;6838.316168383122;6969.163700355888;7064.081669382947;17193.7420938686;17241.741373879402;17246.91376543134;17254.137293135293;17254.482365529053;7559.735409260649;7754.9224507755325;7790.9220907790195;7796.337311328601;7797.337226335711;6943.583384996917;7111.466640001917;7162.856742865113;7174.461915356369;7326.963365183246;5159.2003239497935;5276.1030624793875;5278.8944221116135;5290.047791397586;5331.733413329318;1553.3999980020596;1560.8439156084528;1569.4663814303192;1571.0652161963612;1601.175394671745;886.6674996876171;894.3069121430943;904.5251243097294;916.8074704312036;919.8298314811781;7552.320291173821;7575.848483030309;7657.57883316423;7658.923410765932;7680.500767450098;718.1382341190592;728.3190217146985;732.9157146928064;733.3509843788286;733.8495608400265;4831.613470922318;5091.847244582668;5099.929014906911;5109.8722531937;5243;21394.35816925495;21624;21898.45253868666;22047.2283470081;22102.668459973112;20911.790882090983;21526.46183845385;21893.233736819137;21940.561188776133;22328.21851235199;10868.891311086945;11027.669169924915;11135.10919126484;11192.216544841784;11305.378204198683;8330.208630180123;8338.207870252316;8374.623141958748;8384.832303353776;8385.916140838513;18139.727904081185;18908.621827563646;18991;19116.904415477835;19225.230990760214;19202.327918522784;19553.8044619552;19610;19654.90172549128;20301.187952481734;10075.647352342632;10859.34843909368;10863.293885897392;10869.184811139037;10875.40185289785;13733.862661373258;13804.723905522034;13963.371648276056;13992.930035349758;14051.929740351234;10901;10921.126309895031;11122.332660040423;11132.443377831238;11199.496022678835;10436.791264174826;10467.267291289536;10489.79020419572;10700.83948740754;10767.569297228023;9417.858732118886;9536.904630953602;9605.567749451431;9635.084666956627;9646.517674116407;7319.890201647086;7417.777466676009;7418.554886706815;7478.06524184477;7501.962490187732;7497.88753168692;7569.545827250383;7604.8479030417975;7651.196624354363;7704.884426733492 16:09:59 INFO - PID 10688 | |4;prototype.html;493.3959383111925;516.1277441124499;524.2424696313826;524.6275144647301;533.7704786941614;6307.653079080649;6324.6521441320765;6341.556091073627;6360.745570177193;6393.808185754429;6178.258608966919;6212.192414986057;6288.811335659926;6319.810405687826;6350.1744773179535;5182.766775495112;5232.529072383475;5237.423883372826;5241.266222728821;5242.764075616587;4928.137575924216;5014.473480284572;5168.405633352157;5195.766190521435;5245.029669511134;4938.08645400602;4972.353594032771;5006.624503162259;5011.899762004758;5032.194848824189;4964.826231081913;4969.875753106165;4977.178765503688;4989.501049895018;4994.950050499503;4375.78121093944;4453.777311134463;4457.710248833815;4468.419105516262;4515.819367225307;6089.44719096632;6094.96952515239;6160.1375807387;6160.476359509447;6163.568550201488;5693.373728889819;5719.370869204384;5724.198612194255;5725.76895967369;5742.224799652077;6600.636964966925;6610.3720146586;6620.30486798884;6635.535512514126;6698.129243198353;4902.877428064291;4907.11671899058;4918.2376731606655;4933.605311575066;4936.136176169156;6589.34106589342;6740.359665831738;6762.357576030269;6804.693788779517;6843.775772873836;4817.9518204818205;4979.278004689299;4991.575716064102;4994.850154495371;5013.348264725562;5055.317532133188;5057.797688092435;5060.544550990355;5069.112905241568;5072.1123803335;5580.832575022756;5688.11834165705;5703.971480142573;5728.484436400744;5740.770369185186;6541.215054193527;6653.301403352675;6677.732890684319;6686.732530698815;6700.698468568926;1747.7553142560052;1758.498827834061;1765.8587313015184;1770.4954088085092;1785.9462916879104;1205.6684411786828;1208.957686480969;1232.5377983256278;1241.807519834427;1253.3419954523947;5695.40198279183;5732.878834831139;5752.2455651026;5808.186853840466;5835.124731290255;6782.999015290501;6788.694508747119;6813.829654258584;6823.727050917908;6835.624040677711;5699.544036477072;5729.713514324267;5749.798757043483;5778.1286538018785;5787.536997040227;3567.2687099144614;3593.407087830531;3594.1374070223483;3597.2086141048926;3647.6170002149925;6371.203599550056;6385.808425747235;6420.678966051679;6427.107801489348;6475.287718350977;6819.488538359643;6875.209350924708;6885.380315771605;6896.689648965808;6911.9308806912295;6477.967610162013;6529.738810447624;6571.835704107436;6584.374484423972;6604.207495100619;6256.562040657111;6591.769288074895;6609.834754131185;6657.900131497934;6780.559263647847;6618;6620.470362370903;6641.900371494528;6672.465332973346;6710.496712746466;6292.622442653455;6311.936880631135;6384.744610215539;6461.967690161519;6535.44448721864;4979.975100124621;4982;4989.950100498949;5010.674306170233;5019.196928491424;6787.389134977876;6793.66031698423;6806.489513286424;6820.965895170492;6899.965500172668;6463.482921366373;6510.609363438209;6610.636414997221;6617.205935287796;6629.801105966829;6580.670966451563;6621.966890165519;6646.501512386493;6653.301403352772;6677.899831502628;6572.441342485942;6581.308962558863;6597.736090556324;6599.274079851117;6614;6593.307702691149;6611.371919667624;6614.966925165343;6672.666366681549;6676.566023208476;6297.874042519215;6322.715477803418;6349.206349206349;6440.13058237132;6464.191976003 16:09:59 INFO - PID 10688 | |5;yui.html;890.172139909884;902.6705252582807;923.6028507741669;927.9628814847406;934.6308208257739;17536.38622648206;17998;18057.909710451444;20543.589128217463;22054.117835286568;21320.57358852826;21544.245951391706;21561.67657485135;21579;21605.783942160575;911.2983003087619;919.3564504846601;949.8337790886602;951.6621599332241;952.7094236257939;952.5570609666504;961.2742379503466;976.3799987008265;979.314479864098;982.140626951414;1026.6252817721552;1026.7689769801773;1029.7065336379133;1034.177828626244;1034.9896501035007;1007.5667462990948;1012.9189664826796;1017.8625885505436;1018.5671089786848;1019.4240254256322;745.8993035940133;747.9326860582573;751.504007355143;754.3550264523808;757.2351924556183;19854.90072549628;20025;20081.79918200814;20113.79886201134;20166.39500814978;20132.29536966199;20543.178272869216;20740.5851882963;20927.581448370947;20956.895215523826;17070.658586828195;17347.219375128025;17359.132043397778;17360.392386266547;17365.913170434065;3590.461430785377;3613.6205698401814;3627.963720362789;3628.546431696038;3635.1275693833554;140503;141320.29339853337;141956;142858;144028.27985860108;15967.520974370787;16364.672706545802;16494;16513.504594861934;16518;31042.223944401572;31380;31534.684653153174;31537.36925261482;31547.21131971673;8452.66189352419;8491.915080849112;8575.056743758181;8654.394192406471;8658.48049117055;4304.117655880537;4341.261985462479;4341.45731783527;4375.16871794358;4385.232584297735;5409.675419474844;5412.539934105566;5507.311586051744;5508.283923089973;5509.035918714209;952.4999375328008;962.1965658675085;969.8399764038854;978.7993461340408;978.8433850583872;645.4965127200791;661.8312330355728;667.576089183372;669.5279827721445;686.5468790598181;9344.15902568772;9736.221102311798;9921.65274215399;10495.10791582724;10597.84103238452;670.5239280111078;673.9561928474634;674.5986138247735;683.5693513086724;684.2644157530674;5026.019926114445;5078.111330517145;5097.388313402415;5133.050385678662;5159.019786240602;112296;112898;113010;114765.42617287027;117050;104087.4795626017;105315.94684053215;105827.47086264673;105883.4705826466;107069;90686.09313906908;91121.54439227894;91402;92055.99999999866;94552;9381.530923453936;9610.183134433652;9654.855177172489;9672.419654820733;9753.219742420448;33306.666933331326;43283.567164329215;43929;44230.77884610556;44531.332030020225;70354;80494.59752701434;80875;81079;81155;12637.684057898627;12741.17182383142;12796;12823.743525129632;12893.677658058623;16601.83398166051;17146.742798857777;17263.05053222085;17291.135443227537;17438.82561174372;16024.599385015;16038.599035023752;16079.839201607834;16192.02847829134;16204.513864584082;15988.520344389686;16032.198390080215;16182.67634647324;16255.943363681323;16317.836821632107;15606.453774117852;15832.208389580705;15904;15916.840831591537;15933.442329518411;11434.714132146762;11526.59656912004;11582.94208528952;11732.354720490455;11820.881791182323;11169.603799525059;11264.380459074502;11343.773124537298;11615.593454229062;11727.882721172678 16:09:59 INFO - PID 10688 | __end_tp_report 16:09:59 INFO - PID 10688 | __start_cc_report 16:09:59 INFO - PID 10688 | _x_x_mozilla_cycle_collect,365 16:09:59 INFO - PID 10688 | __end_cc_report 16:09:59 INFO - PID 10688 | __startTimestamp1505430599221__endTimestamp 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | ------- Summary: start ------- 16:09:59 INFO - PID 10688 | Number of tests: 6 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#0] dojo.html Cycles:165 Average:6139.87 Median:6393.33 stddev:826.30 (12.9%) stddev-sans-first:794.59 16:09:59 INFO - PID 10688 | Values: 3139.0 3173.0 3174.7 3201.3 3215.1 6105.1 6140.4 6251.2 6284.5 6352.8 6166.2 6183.2 6192.1 6227.2 6245.4 5706.3 5735.1 5744.6 5793.3 5873.6 5767.4 5814.4 5827.8 5831.0 5841.7 1226.2 5663.1 5798.2 5842.0 5867.6 5288.3 5664.5 5706.0 5781.5 5801.2 5684.9 5699.3 5768.1 5769.2 5779.1 6145.8 6193.8 6285.1 6302.6 6315.6 6682.0 6710.1 6760.5 6766.7 6789.6 6584.4 6685.2 6765.3 6768.1 6856.1 6155.3 6185.7 6194.8 6204.4 6204.9 6706.2 6833.6 6849.7 6862.1 6902.2 6583.3 6592.4 6674.4 6674.5 6687.0 6683.8 6688.9 6725.1 6788.2 6791.4 6516.7 6613.6 6617.8 6622.0 6641.7 6588.0 6648.3 6675.9 6748.7 6751.0 5327.8 5329.7 5331.3 5341.3 5345.8 4640.4 4643.0 4661.6 4667.6 4676.1 5652.0 5735.3 5786.5 5798.6 5875.1 6776.2 6799.8 6802.2 6821.1 6829.3 5720.3 5841.0 5849.9 5865.7 5874.3 5752.5 5771.7 5843.6 5843.7 5853.8 6282.8 6410.6 6457.8 6562.4 6562.7 6786.8 6812.5 6824.5 6831.8 6838.2 6470.2 6484.3 6488.8 6499.7 6565.8 6464.5 6548.1 6593.6 6677.7 6679.8 6737.4 6823.5 6824.8 6833.7 6843.5 6476.6 6598.4 6601.3 6640.5 6649.8 6537.1 6543.4 6550.7 6636.9 6639.5 6307.4 6393.3 6482.0 6560.7 6564.9 6435.3 6459.7 6477.6 6497.8 6521.7 6166.8 6242.9 6247.9 6266.6 6268.6 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#1] ext.html Cycles:180 Average:36791.26 Median:34098.74 stddev:52871.41 (155.1%) stddev-sans-first:52950.69 16:09:59 INFO - PID 10688 | Values: 807.3 860.8 882.2 887.2 888.7 38749.8 40331.4 40555.8 40706.4 40762.2 37088.4 37395.1 37523.8 37599.0 37658.1 6811.9 6845.7 6939.4 6949.0 6953.2 6867.7 6938.2 6944.2 6946.1 6952.3 6928.2 6955.5 6955.9 6956.5 6973.9 7562.9 7723.7 7729.0 7736.3 7768.8 7488.4 7562.2 7584.8 7602.0 7609.5 36813.6 38202.8 38762.6 38802.0 38969.6 3197.1 3219.4 3237.6 3237.8 3238.7 31547.8 31568.5 31601.5 31677.0 31830.4 5164.1 5165.1 5187.5 5196.5 5197.6 179227.1 180831.0 181368.0 181372.1 181534.0 46533.0 46596.5 46694.0 46958.8 47008.5 48588.5 48893.3 49324.0 49324.5 49371.8 15325.3 15465.9 15487.8 15515.7 15598.2 12557.7 12583.2 12584.3 12589.9 12590.8 13899.4 14115.0 14176.3 14375.7 14383.6 5551.5 5593.5 5631.3 5697.6 5749.9 980.4 983.4 987.7 1013.8 1014.1 22461.6 22710.3 22799.3 22878.8 22933.0 1086.9 1096.8 1100.0 1100.0 1110.1 11913.9 12209.4 12250.6 12269.0 12278.9 225537.0 228861.0 228960.0 228988.0 229737.0 43524.8 51182.5 51498.2 52016.5 52188.2 1431.9 1457.7 1461.8 1463.5 1473.2 25655.2 26495.9 26509.9 26637.3 27209.9 36591.0 36670.1 36806.4 36840.6 36875.6 200107.0 200258.0 200322.0 200487.0 200496.0 33790.5 33914.0 34044.8 34152.7 34266.1 40198.0 42271.8 42729.8 42871.1 42901.4 30556.0 30931.2 31035.2 31177.7 32120.7 30698.1 30974.5 31093.4 31247.2 31248.2 33804.3 34290.8 34626.3 34800.8 35062.0 30171.2 30346.2 30351.5 30537.5 30933.8 22673.8 22781.8 22936.5 22966.8 23103.4 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#2] jquery.html Cycles:180 Average:32394.53 Median:22542.22 stddev:74019.87 (328.4%) stddev-sans-first:74188.91 16:09:59 INFO - PID 10688 | Values: 552.5 563.8 564.8 580.7 588.6 22001.1 22903.9 23022.4 23047.0 23130.5 23327.4 24320.6 24444.9 24653.8 24697.9 6582.9 6713.3 6753.2 6753.6 6757.3 6620.7 6712.4 6712.8 6712.9 6715.6 6307.6 6600.9 6601.2 6614.4 6681.9 6508.8 6556.8 6570.4 6571.3 6572.3 5957.6 5994.4 6022.6 6072.0 6226.2 27577.7 27931.7 28116.6 28127.4 28129.6 2087.0 2118.7 2118.7 2121.2 2121.4 18499.5 18830.2 19070.1 19091.7 19202.4 2419.3 2419.4 2467.6 2473.1 2474.1 117081.4 123203.4 123513.4 131066.0 133551.0 14311.0 14470.6 14505.9 14639.2 14715.9 22492.9 22708.7 22761.8 22781.0 22781.2 9828.5 10026.3 10224.4 10227.7 10321.9 9255.8 9327.3 9379.3 9440.3 9453.2 8683.9 8845.5 8850.5 9004.2 9183.7 2576.0 2580.4 2623.3 2659.9 2678.0 947.3 964.4 969.2 995.3 1007.8 18520.8 18522.4 18852.8 19120.7 19300.4 1008.7 1021.6 1031.3 1037.1 1038.4 10245.5 10455.9 10663.9 10681.8 10864.9 427500.0 437978.0 439703.0 441069.0 447158.0 107555.0 107750.0 109358.0 109640.5 111563.4 1026.5 1135.6 1146.2 1189.4 1200.8 19459.4 19489.0 19766.5 19837.6 19908.4 51493.5 52858.7 53291.7 53551.2 54326.0 65636.7 65816.3 65928.0 66073.3 67774.7 13864.0 14128.1 14240.6 14257.1 14271.8 21955.2 22055.4 22325.4 22532.9 22551.5 17871.3 18013.3 18146.5 18205.0 18257.0 15770.7 15974.1 16373.4 16391.3 16507.2 17175.8 18388.4 18462.3 18570.8 18599.3 14035.9 14037.4 14051.0 14060.0 14102.6 17748.4 17972.6 18070.1 18070.5 18100.1 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#3] mootools.html Cycles:180 Average:9294.27 Median:2686.97 stddev:6705.08 (249.5%) stddev-sans-first:6697.13 16:09:59 INFO - PID 10688 | Values: 1320.9 1386.1 1405.6 1416.4 1439.7 14498.3 15226.5 15244.9 15268.8 15282.6 14834.9 15154.5 15160.7 15164.0 15164.0 2640.4 2703.0 2738.1 2740.5 2752.4 2652.3 2684.7 2693.4 2718.4 2718.7 2506.1 2689.3 2690.7 2693.4 2693.8 2776.7 2788.6 2798.1 2802.5 2814.6 2541.9 2680.1 2769.7 2773.2 2778.8 15241.0 15288.6 15353.8 15361.8 15389.6 7881.6 8150.8 8172.9 8177.2 8192.6 5172.8 5328.4 5379.5 5491.9 5496.6 1797.0 1803.8 1815.7 1835.9 1854.1 25731.6 26225.0 26422.3 26423.7 26476.7 6610.1 6794.5 6838.3 6969.2 7064.1 17193.7 17241.7 17246.9 17254.1 17254.5 7559.7 7754.9 7790.9 7796.3 7797.3 6943.6 7111.5 7162.9 7174.5 7327.0 5159.2 5276.1 5278.9 5290.0 5331.7 1553.4 1560.8 1569.5 1571.1 1601.2 886.7 894.3 904.5 916.8 919.8 7552.3 7575.8 7657.6 7658.9 7680.5 718.1 728.3 732.9 733.4 733.8 4831.6 5091.8 5099.9 5109.9 5243.0 21394.4 21624.0 21898.5 22047.2 22102.7 20911.8 21526.5 21893.2 21940.6 22328.2 10868.9 11027.7 11135.1 11192.2 11305.4 8330.2 8338.2 8374.6 8384.8 8385.9 18139.7 18908.6 18991.0 19116.9 19225.2 19202.3 19553.8 19610.0 19654.9 20301.2 10075.6 10859.3 10863.3 10869.2 10875.4 13733.9 13804.7 13963.4 13992.9 14051.9 10901.0 10921.1 11122.3 11132.4 11199.5 10436.8 10467.3 10489.8 10700.8 10767.6 9417.9 9536.9 9605.6 9635.1 9646.5 7319.9 7417.8 7418.6 7478.1 7502.0 7497.9 7569.5 7604.8 7651.2 7704.9 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#4] prototype.html Cycles:180 Average:5539.75 Median:6195.23 stddev:1549.59 (25.0%) stddev-sans-first:1506.94 16:09:59 INFO - PID 10688 | Values: 493.4 516.1 524.2 524.6 533.8 6307.7 6324.7 6341.6 6360.7 6393.8 6178.3 6212.2 6288.8 6319.8 6350.2 5182.8 5232.5 5237.4 5241.3 5242.8 4928.1 5014.5 5168.4 5195.8 5245.0 4938.1 4972.4 5006.6 5011.9 5032.2 4964.8 4969.9 4977.2 4989.5 4995.0 4375.8 4453.8 4457.7 4468.4 4515.8 6089.4 6095.0 6160.1 6160.5 6163.6 5693.4 5719.4 5724.2 5725.8 5742.2 6600.6 6610.4 6620.3 6635.5 6698.1 4902.9 4907.1 4918.2 4933.6 4936.1 6589.3 6740.4 6762.4 6804.7 6843.8 4818.0 4979.3 4991.6 4994.9 5013.3 5055.3 5057.8 5060.5 5069.1 5072.1 5580.8 5688.1 5704.0 5728.5 5740.8 6541.2 6653.3 6677.7 6686.7 6700.7 1747.8 1758.5 1765.9 1770.5 1785.9 1205.7 1209.0 1232.5 1241.8 1253.3 5695.4 5732.9 5752.2 5808.2 5835.1 6783.0 6788.7 6813.8 6823.7 6835.6 5699.5 5729.7 5749.8 5778.1 5787.5 3567.3 3593.4 3594.1 3597.2 3647.6 6371.2 6385.8 6420.7 6427.1 6475.3 6819.5 6875.2 6885.4 6896.7 6911.9 6478.0 6529.7 6571.8 6584.4 6604.2 6256.6 6591.8 6609.8 6657.9 6780.6 6618.0 6620.5 6641.9 6672.5 6710.5 6292.6 6311.9 6384.7 6462.0 6535.4 4980.0 4982.0 4990.0 5010.7 5019.2 6787.4 6793.7 6806.5 6821.0 6900.0 6463.5 6510.6 6610.6 6617.2 6629.8 6580.7 6622.0 6646.5 6653.3 6677.9 6572.4 6581.3 6597.7 6599.3 6614.0 6593.3 6611.4 6615.0 6672.7 6676.6 6297.9 6322.7 6349.2 6440.1 6464.2 16:09:59 INFO - PID 10688 | 16:09:59 INFO - PID 10688 | [#5] yui.html Cycles:180 Average:24352.10 Median:21829.95 stddev:35274.26 (161.6%) stddev-sans-first:35329.23 16:09:59 INFO - PID 10688 | Values: 890.2 902.7 923.6 928.0 934.6 17536.4 17998.0 18057.9 20543.6 22054.1 21320.6 21544.2 21561.7 21579.0 21605.8 911.3 919.4 949.8 951.7 952.7 952.6 961.3 976.4 979.3 982.1 1026.6 1026.8 1029.7 1034.2 1035.0 1007.6 1012.9 1017.9 1018.6 1019.4 745.9 747.9 751.5 754.4 757.2 19854.9 20025.0 20081.8 20113.8 20166.4 20132.3 20543.2 20740.6 20927.6 20956.9 17070.7 17347.2 17359.1 17360.4 17365.9 3590.5 3613.6 3628.0 3628.5 3635.1 140503.0 141320.3 141956.0 142858.0 144028.3 15967.5 16364.7 16494.0 16513.5 16518.0 31042.2 31380.0 31534.7 31537.4 31547.2 8452.7 8491.9 8575.1 8654.4 8658.5 4304.1 4341.3 4341.5 4375.2 4385.2 5409.7 5412.5 5507.3 5508.3 5509.0 952.5 962.2 969.8 978.8 978.8 645.5 661.8 667.6 669.5 686.5 9344.2 9736.2 9921.7 10495.1 10597.8 670.5 674.0 674.6 683.6 684.3 5026.0 5078.1 5097.4 5133.1 5159.0 112296.0 112898.0 113010.0 114765.4 117050.0 104087.5 105315.9 105827.5 105883.5 107069.0 90686.1 91121.5 91402.0 92056.0 94552.0 9381.5 9610.2 9654.9 9672.4 9753.2 33306.7 43283.6 43929.0 44230.8 44531.3 70354.0 80494.6 80875.0 81079.0 81155.0 12637.7 12741.2 12796.0 12823.7 12893.7 16601.8 17146.7 17263.1 17291.1 17438.8 16024.6 16038.6 16079.8 16192.0 16204.5 15988.5 16032.2 16182.7 16255.9 16317.8 15606.5 15832.2 15904.0 15916.8 15933.4 11434.7 11526.6 11582.9 11732.4 11820.9 11169.6 11264.4 11343.8 11615.6 11727.9 16:09:59 INFO - PID 10688 | -------- Summary: end -------- 16:09:59 INFO - PID 10688 | 16:09:59 INFO - TEST-INFO | 10688: exit 0 16:09:59 INFO - TEST-OK | dromaeo_css | took 1108915ms 16:09:59 INFO - TEST-START | kraken 16:09:59 INFO - Initialising browser for kraken test... 16:09:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55567/getInfo.html -profile /tmp/tmpUfZjqy/profile 16:09:59 INFO - TEST-INFO | started process 11062 (/builds/slave/test/build/application/firefox/firefox http://localhost:55567/getInfo.html) 16:10:05 INFO - TEST-INFO | 11062: exit 0 16:10:05 INFO - Browser initialized. 16:10:05 INFO - Running cycle 1/1 for kraken test... 16:10:05 INFO - Using env: {'DISPLAY': ':0', 16:10:05 INFO - 'HOME': '/home/cltbld', 16:10:05 INFO - 'JSGC_DISABLE_POISONING': '1', 16:10:05 INFO - 'LANG': 'en_US.UTF-8', 16:10:05 INFO - 'LANGUAGE': 'en_US:en', 16:10:05 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:10:05 INFO - 'LOGNAME': 'cltbld', 16:10:05 INFO - 'MAIL': '/var/mail/cltbld', 16:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:10:05 INFO - 'MOZ_CRASHREPORTER': '1', 16:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:05 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:10:05 INFO - 'MOZ_NO_REMOTE': '1', 16:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:10:05 INFO - 'NO_EM_RESTART': '1', 16:10:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:05 INFO - 'PWD': '/builds/slave/test', 16:10:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:05 INFO - 'RUST_BACKTRACE': 'full', 16:10:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:10:05 INFO - 'SHELL': '/bin/bash', 16:10:05 INFO - 'SHLVL': '1', 16:10:05 INFO - 'STYLO_FORCE_DISABLED': '1', 16:10:05 INFO - 'TERM': 'linux', 16:10:05 INFO - 'TMOUT': '86400', 16:10:05 INFO - 'USER': 'cltbld', 16:10:05 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379', 16:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:05 INFO - '_': '/tools/buildbot/bin/python'} 16:10:05 INFO - TEST-INFO | started process 11297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfZjqy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:10:06 INFO - PID 11297 | 16:10:06 INFO - PID 11297 | (/builds/slave/test/build/application/firefox/firefox:11346): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:10:06 INFO - PID 11297 | 16:10:16 INFO - PID 11297 | RSS: Main: 173408256 16:10:16 INFO - PID 11297 | 16:10:19 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55567/tests/kraken/driver.html?testName=audio-beat-detection) 16:10:20 INFO - PID 11297 | RSS: Main: 178180096 16:10:20 INFO - PID 11297 | 16:10:22 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55567/tests/kraken/driver.html?testName=audio-dft) 16:10:23 INFO - PID 11297 | RSS: Main: 178122752 16:10:23 INFO - PID 11297 | 16:10:26 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55567/tests/kraken/driver.html?testName=audio-fft) 16:10:27 INFO - PID 11297 | RSS: Main: 173744128 16:10:27 INFO - PID 11297 | 16:10:29 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55567/tests/kraken/driver.html?testName=audio-oscillator) 16:10:29 INFO - PID 11297 | RSS: Main: 174530560 16:10:29 INFO - PID 11297 | 16:10:31 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:10:32 INFO - PID 11297 | RSS: Main: 174829568 16:10:32 INFO - PID 11297 | 16:10:35 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55567/tests/kraken/driver.html?testName=imaging-darkroom) 16:10:36 INFO - PID 11297 | RSS: Main: 177319936 16:10:36 INFO - PID 11297 | 16:10:40 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55567/tests/kraken/driver.html?testName=imaging-desaturate) 16:10:40 INFO - PID 11297 | RSS: Main: 177537024 16:10:40 INFO - PID 11297 | 16:10:43 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55567/tests/kraken/driver.html?testName=json-parse-financial) 16:10:44 INFO - PID 11297 | RSS: Main: 178327552 16:10:44 INFO - PID 11297 | 16:10:46 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:10:46 INFO - PID 11297 | RSS: Main: 178016256 16:10:46 INFO - PID 11297 | 16:10:48 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:10:48 INFO - PID 11297 | RSS: Main: 177860608 16:10:48 INFO - PID 11297 | 16:10:50 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:10:51 INFO - PID 11297 | RSS: Main: 175226880 16:10:51 INFO - PID 11297 | 16:10:54 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:10:54 INFO - PID 11297 | RSS: Main: 175837184 16:10:54 INFO - PID 11297 | 16:10:57 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:10:58 INFO - PID 11297 | RSS: Main: 175763456 16:10:58 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | Cycle 1(1): loaded http://localhost:55567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55567/tests/kraken/driver.html?testName=ai-astar) 16:11:00 INFO - PID 11297 | RSS: Main: 177324032 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | __start_tp_report 16:11:00 INFO - PID 11297 | _x_x_mozilla_page_load 16:11:00 INFO - PID 11297 | _x_x_mozilla_page_load_details 16:11:00 INFO - PID 11297 | |i|pagename|runs| 16:11:00 INFO - PID 11297 | |0;ai-astar;115;109;108;108;107;97;108;108;107;108 16:11:00 INFO - PID 11297 | |1;audio-beat-detection;118;119;116;117;118;120;117;116;121;116 16:11:00 INFO - PID 11297 | |2;audio-dft;163;162;163;164;162;162;163;169;168;166 16:11:00 INFO - PID 11297 | |3;audio-fft;74;75;77;76;75;73;72;77;76;74 16:11:00 INFO - PID 11297 | |4;audio-oscillator;80;80;80;79;83;81;81;79;79;82 16:11:00 INFO - PID 11297 | |5;imaging-gaussian-blur;117;114;113;113;113;113;113;113;115;114 16:11:00 INFO - PID 11297 | |6;imaging-darkroom;161;148;148;148;148;150;149;150;150;149 16:11:00 INFO - PID 11297 | |7;imaging-desaturate;93;93;94;94;99;95;94;94;94;94 16:11:00 INFO - PID 11297 | |8;json-parse-financial;55;53;53;55;55;53;53;54;54;53 16:11:00 INFO - PID 11297 | |9;json-stringify-tinderbox;38;38;37;38;38;38;37;37;38;39 16:11:00 INFO - PID 11297 | |10;stanford-crypto-aes;76;75;74;74;75;75;76;76;74;74 16:11:00 INFO - PID 11297 | |11;stanford-crypto-ccm;114;121;110;116;114;121;122;110;115;113 16:11:00 INFO - PID 11297 | |12;stanford-crypto-pbkdf2;185;171;171;167;169;178;172;166;164;174 16:11:00 INFO - PID 11297 | |13;stanford-crypto-sha256-iterative;67;68;65;65;67;74;67;65;69;66 16:11:00 INFO - PID 11297 | __end_tp_report 16:11:00 INFO - PID 11297 | __start_cc_report 16:11:00 INFO - PID 11297 | _x_x_mozilla_cycle_collect,917 16:11:00 INFO - PID 11297 | __end_cc_report 16:11:00 INFO - PID 11297 | __startTimestamp1505430660560__endTimestamp 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | ------- Summary: start ------- 16:11:00 INFO - PID 11297 | Number of tests: 14 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#0] ai-astar Cycles:10 Average:107.50 Median:108.00 stddev:4.35 (4.0%) stddev-sans-first:3.67 16:11:00 INFO - PID 11297 | Values: 115.0 109.0 108.0 108.0 107.0 97.0 108.0 108.0 107.0 108.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:118.00 stddev:1.75 (1.5%) stddev-sans-first:1.86 16:11:00 INFO - PID 11297 | Values: 118.0 119.0 116.0 117.0 118.0 120.0 117.0 116.0 121.0 116.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.57 (1.6%) stddev-sans-first:2.69 16:11:00 INFO - PID 11297 | Values: 163.0 162.0 163.0 164.0 162.0 162.0 163.0 169.0 168.0 166.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#3] audio-fft Cycles:10 Average:74.90 Median:75.50 stddev:1.66 (2.2%) stddev-sans-first:1.73 16:11:00 INFO - PID 11297 | Values: 74.0 75.0 77.0 76.0 75.0 73.0 72.0 77.0 76.0 74.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#4] audio-oscillator Cycles:10 Average:80.40 Median:80.50 stddev:1.35 (1.7%) stddev-sans-first:1.42 16:11:00 INFO - PID 11297 | Values: 80.0 80.0 80.0 79.0 83.0 81.0 81.0 79.0 79.0 82.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:113.50 stddev:1.32 (1.2%) stddev-sans-first:0.73 16:11:00 INFO - PID 11297 | Values: 117.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 115.0 114.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.50 stddev:3.93 (2.6%) stddev-sans-first:0.93 16:11:00 INFO - PID 11297 | Values: 161.0 148.0 148.0 148.0 148.0 150.0 149.0 150.0 150.0 149.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.71 (1.8%) stddev-sans-first:1.74 16:11:00 INFO - PID 11297 | Values: 93.0 93.0 94.0 94.0 99.0 95.0 94.0 94.0 94.0 94.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.92 (1.7%) stddev-sans-first:0.87 16:11:00 INFO - PID 11297 | Values: 55.0 53.0 53.0 55.0 55.0 53.0 53.0 54.0 54.0 53.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#9] json-stringify-tinderbox Cycles:10 Average:37.80 Median:38.00 stddev:0.63 (1.7%) stddev-sans-first:0.67 16:11:00 INFO - PID 11297 | Values: 38.0 38.0 37.0 38.0 38.0 38.0 37.0 37.0 38.0 39.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:75.00 stddev:0.88 (1.2%) stddev-sans-first:0.83 16:11:00 INFO - PID 11297 | Values: 76.0 75.0 74.0 74.0 75.0 75.0 76.0 76.0 74.0 74.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#11] stanford-crypto-ccm Cycles:10 Average:115.60 Median:115.50 stddev:4.40 (3.8%) stddev-sans-first:4.63 16:11:00 INFO - PID 11297 | Values: 114.0 121.0 110.0 116.0 114.0 121.0 122.0 110.0 115.0 113.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:171.50 stddev:6.18 (3.6%) stddev-sans-first:4.29 16:11:00 INFO - PID 11297 | Values: 185.0 171.0 171.0 167.0 169.0 178.0 172.0 166.0 164.0 174.0 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.71 (4.0%) stddev-sans-first:2.87 16:11:00 INFO - PID 11297 | Values: 67.0 68.0 65.0 65.0 67.0 74.0 67.0 65.0 69.0 66.0 16:11:00 INFO - PID 11297 | -------- Summary: end -------- 16:11:00 INFO - PID 11297 | 16:11:00 INFO - PID 11297 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:11:01 INFO - TEST-INFO | 11297: exit 0 16:11:01 INFO - TEST-OK | kraken | took 61377ms 16:11:01 INFO - SUITE-END | took 1170s 16:11:01 INFO - Completed test suite (00:19:30) 16:11:01 INFO - javascript benchmark 16:11:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8402.283118007903, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.984305078475, 3172.984135079325, 3174.6507884132725, 3201.2797120647842, 3215.1479857837676, 6105.084237364397, 6140.416660417253, 6251.249850017998, 6284.497240220783, 6352.777652782153, 6166.229221347332, 6183.227096612924, 6192.102145188945, 6227.159333489977, 6245.4066863647995, 5706.258186435768, 5735.111057786029, 5744.59787814851, 5793.33376661683, 5873.588848780587, 5767.42325767422, 5814.360420353758, 5827.825165245049, 5831.0, 5841.707914604252, 1226.2448060167017, 5663.122216056477, 5798.246227990356, 5841.970790146064, 5867.647941123525, 5288.338957630296, 5664.518515926151, 5706.0, 5781.508571771405, 5801.245838041028, 5684.914726279109, 5699.344575373802, 5768.077107662753, 5769.221155144044, 5779.104238842986, 6145.84635384119, 6193.845153871144, 6285.088662143963, 6302.621842689453, 6315.5894866833505, 6681.966590167067, 6710.060591517192, 6760.492963027793, 6766.69549870257, 6789.626570538619, 6584.374484423972, 6685.164354455693, 6765.289644587346, 6768.120144381248, 6856.074429951943, 6155.322914479404, 6185.721642526097, 6194.845128871814, 6204.379562043805, 6204.937950620526, 6706.161729783777, 6833.555818871758, 6849.657517124124, 6862.073620061228, 6902.206246281641, 6583.341665833378, 6592.373724496165, 6674.399304062657, 6674.5327827052615, 6686.99695045747, 6683.7660681875905, 6688.933110668929, 6725.125733654593, 6788.185417749803, 6791.388775010174, 6516.706748196342, 6613.6362500062, 6617.7683781067435, 6621.966890165519, 6641.701123449457, 6588.0, 6648.301928297556, 6675.899861501985, 6748.6963086660235, 6750.966245168841, 5327.840164795062, 5329.7068661224, 5331.333583302087, 5341.252224688546, 5345.839624811262, 4640.373549570765, 4643.016179308284, 4661.557152070615, 4667.556582124693, 4676.08816280822, 5652.0, 5735.254416925856, 5786.537077033827, 5798.623089499169, 5875.059990401515, 6776.220734615484, 6799.762008329685, 6802.217744959294, 6821.113255276782, 6829.3170682932305, 5720.256366672306, 5841.0, 5849.912251316234, 5865.706714664335, 5874.265716785402, 5752.45351691597, 5771.740271687784, 5843.620164689281, 5843.678597677169, 5853.795117170878, 6282.842928926813, 6410.583312084793, 6457.838554036092, 6562.442192413603, 6562.67186640666, 6786.8303292417095, 6812.455003599601, 6824.454043676395, 6831.829204269933, 6838.2136054352395, 6470.191226096738, 6484.286728459771, 6488.837779055561, 6499.6750162492635, 6565.770198043237, 6464.450521705708, 6548.050532672831, 6593.571417857824, 6677.666116694243, 6679.799606011828, 6737.393634572716, 6823.488238382042, 6824.829379265558, 6833.726650933907, 6843.452523798183, 6476.579022363531, 6598.406143447113, 6601.273859875314, 6640.501962352746, 6649.833754155991, 6537.117489139096, 6543.378379053982, 6550.672466376567, 6636.933630663631, 6639.535232533676, 6307.369263073656, 6393.328700486382, 6482.0, 6560.704768285534, 6564.934350656432, 6435.259945106185, 6459.677016149268, 6477.611343319416, 6497.837554060997, 6521.739130434729, 6166.784162554289, 6242.875142497215, 6247.875042499034, 6266.592671476339, 6268.592541484789], "value": 6081.079283841777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.2976510435922, 860.8063185783199, 882.1663527966075, 887.2414085956507, 888.6978427334705, 38749.806250968744, 40331.395029074585, 40555.79722101393, 40706.38940415892, 40762.18475630486, 37088.44367334485, 37395.06512337193, 37523.81238093813, 37599.0, 37658.0585485363, 6811.897821532669, 6845.726170953156, 6939.44484441246, 6948.965255173743, 6953.235144134166, 6867.690953907087, 6938.236793952661, 6944.201416837052, 6946.097007389032, 6952.2700116487795, 6928.203256625477, 6955.547889387199, 6955.860882782366, 6956.478264130211, 6973.895391569105, 7562.886556701654, 7723.65243564041, 7729.033870766154, 7736.34241089508, 7768.844623107534, 7488.4009279257525, 7562.168161502231, 7584.848303033964, 7602.011738474018, 7609.505382150142, 36813.631863681556, 38202.80898595489, 38762.612373876465, 38802.0, 38969.61030389716, 3197.1207917822785, 3219.388316219911, 3237.5629290045777, 3237.7895436796534, 3238.6923242291946, 31547.842260788777, 31568.526472102938, 31601.525977110363, 31677.0, 31830.363392732015, 5164.070467315882, 5165.147750621143, 5187.455317191679, 5196.45437229093, 5197.610179236573, 179227.10386447984, 180831.0, 181368.0, 181372.0931395348, 181533.9999999987, 46533.0, 46596.5340346599, 46694.0, 46958.76520617375, 47008.5299147011, 48588.51411485911, 48893.266601001014, 49324.0, 49324.506754931994, 49371.75314123406, 15325.31036103378, 15465.922670386575, 15487.767683484757, 15515.689686206213, 15598.220088995506, 12557.74884502323, 12583.245005299712, 12584.307863067435, 12589.93705031469, 12590.81113783294, 13899.444022239199, 14115.0, 14176.291185440687, 14375.712485750226, 14383.568492945229, 5551.472610102034, 5593.524550413261, 5631.267935168484, 5697.6296540724725, 5749.8562535936935, 980.4313498171043, 983.3755565216139, 987.7086259553449, 1013.7668336282696, 1014.0518615094762, 22461.55076898453, 22710.31869043931, 22799.31602051941, 22878.771212287666, 22933.0, 1086.9021788038956, 1096.8025755363951, 1099.9780004399868, 1100.0044959311836, 1110.0730889707024, 11913.880861191277, 12209.389530523438, 12250.632481025583, 12268.957138643136, 12278.894899459092, 225537.0, 228861.0, 228960.0, 228988.0, 229737.0, 43524.78237608792, 51182.48817511852, 51498.22752658713, 52016.479835201164, 52188.21717674162, 1431.8782903453114, 1457.6574504991318, 1461.7734251191082, 1463.4804644351102, 1473.1823837770141, 25655.230343089737, 26495.867520662272, 26509.867450662623, 26637.334066648487, 27209.86395068012, 36591.0, 36670.08324791795, 36806.44790328201, 36840.63159368372, 36875.63124368722, 200107.0, 200258.0, 200322.0, 200487.0, 200496.0, 33790.49314260337, 33914.0, 34044.829775850965, 34152.65847341495, 34266.14334641654, 40198.0, 42271.7886410566, 42729.78635106929, 42871.14257714766, 42901.356479653456, 30556.0, 30931.2267193313, 31035.22411939629, 31177.688223118384, 32120.678793212704, 30698.079057628307, 30974.535381969738, 31093.378132437676, 31247.218819529695, 31248.21879453032, 33804.32391352209, 34290.82854585711, 34626.30747385089, 34800.82599586986, 35062.0, 30171.245718857204, 30346.241343965696, 30351.544726828673, 30537.54193687141, 30933.8453307732, 22673.773262267165, 22781.77218227863, 22936.541269174188, 22966.770332296463, 23103.422414439774], "value": 16725.223970105337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4889477233557, 563.8280324501028, 564.757154423598, 580.7386675995801, 588.5762251179151, 22001.119955201793, 22903.885480572575, 23022.424439389022, 23047.0, 23130.537389252226, 23327.416814579643, 24320.635190472112, 24444.877775611098, 24653.75346246537, 24697.876510617465, 6582.934170658292, 6713.2951040140815, 6753.223379311393, 6753.628550429725, 6757.290484499131, 6620.735170593171, 6712.429443497309, 6712.83217919551, 6712.899306510406, 6715.56348837324, 6307.621542707429, 6600.867982640344, 6601.174853143357, 6614.37163469472, 6681.933180668204, 6508.804735857908, 6556.770513032021, 6570.408663220333, 6571.2771595124495, 6572.277049524549, 5957.612755170943, 5994.370591087916, 6022.578419510636, 6072.0, 6226.1905952225925, 27577.724222757715, 27931.720682793115, 28116.578251326246, 28127.437451250862, 28129.57805632917, 2086.9791302086937, 2118.7457505099333, 2118.7457505099333, 2121.1727426303755, 2121.374194612593, 18499.537511562183, 18830.246790128378, 19070.14184361707, 19091.713624295648, 19202.423927282205, 2419.2823095601966, 2419.4193393585415, 2467.6175192844958, 2473.109680515013, 2474.134053081425, 117081.41459292649, 123203.3839830804, 123513.38243308816, 131066.0, 133551.0, 14311.040112212957, 14470.565883023526, 14505.854941450661, 14639.194844283667, 14715.92642036783, 22492.88753556222, 22708.65937010946, 22761.772382275965, 22781.0, 22781.202657906895, 9828.476586129162, 10026.298159128937, 10224.437655928847, 10227.693169204937, 10321.948390258001, 9255.814883702289, 9327.300452465957, 9379.296552758571, 9440.291978101532, 9453.243740500744, 8683.884627676583, 8845.513496757612, 8850.468971861708, 9004.234640055669, 9183.724488265363, 2575.961360579593, 2580.3936075022357, 2623.252373073665, 2659.880305386262, 2677.9598306025423, 947.2564037230741, 964.4358050540512, 969.2052516936045, 995.348047029197, 1007.8337074382791, 18520.81479185218, 18522.444326670222, 18852.81147188538, 19120.713189302172, 19300.420987370402, 1008.7478130467383, 1021.6475316015963, 1031.3141760729031, 1037.0510982451124, 1038.3925403638805, 10245.48772561369, 10455.902130276363, 10663.893361066444, 10681.786364272672, 10864.94567527173, 427500.0, 437978.0, 439703.0, 441069.0, 447158.0, 107555.0, 107750.0, 109358.0, 109640.4517977405, 111563.4421827902, 1026.5124066068558, 1135.5684839761004, 1146.1633007904277, 1189.4409627475072, 1200.75984803038, 19459.437847347122, 19489.0, 19766.50583735418, 19837.60324793525, 19908.402747917586, 51493.485065150366, 52858.735706321226, 53291.73354133205, 53551.19673204983, 54326.0, 65636.6718166406, 65816.34183658102, 65928.0, 66073.33926660672, 67774.66112669405, 13864.0, 14128.081674691111, 14240.643983900485, 14257.144571325754, 14271.785923210953, 21955.231566895083, 22055.44861378414, 22325.441863953532, 22532.88733556387, 22551.5489690202, 17871.28514859391, 18013.2794688211, 18146.45560633183, 18205.0, 18257.0, 15770.68458630798, 15974.121423321829, 16373.42693005739, 16391.34434622602, 16507.174641268128, 17175.828241717423, 18388.448346549623, 18462.261509540007, 18570.81429185745, 18599.34902278414, 14035.859641403864, 14037.438502459787, 14051.0, 14060.0, 14102.576922692335, 17748.3788067417, 17972.640547188723, 18070.09649517545, 18070.457886263433, 18100.09499525045], "value": 11720.273651118368, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.9009324300678, 1386.1475192756452, 1405.6345350208942, 1416.369715476613, 1439.654482924098, 14498.347574359153, 15226.543203703906, 15244.923775381121, 15268.84731152688, 15282.617934551641, 14834.925825370858, 15154.545363639108, 15160.6967860643, 15164.0, 15164.0, 2640.419107796282, 2703.040420650665, 2738.0553708970374, 2740.4519096180743, 2752.3669556002133, 2652.323657467353, 2684.650995370599, 2693.3939863530645, 2718.429129882727, 2718.714534973829, 2506.1103308325555, 2689.287338855205, 2690.7443792839745, 2693.3670587411943, 2693.8383696978244, 2776.6806817215875, 2788.6235358226686, 2798.1046065259125, 2802.5095608268575, 2814.634097567324, 2541.872906354675, 2680.1021657744677, 2769.695333513312, 2773.1819113361607, 2778.833270003786, 15241.0, 15288.617784555363, 15353.769693454607, 15361.846381536154, 15389.615259618487, 7881.605919703992, 8150.796230094295, 8172.918270817335, 8177.223163799429, 8192.631331590033, 5172.793088276464, 5328.44051374604, 5379.488948549921, 5491.945080549223, 5496.587755918322, 1797.0, 1803.8105998870192, 1815.7185636226407, 1835.9449216523526, 1854.1192933356547, 25731.61402578963, 26225.033122515888, 26422.339441513923, 26423.67881605912, 26476.73523264762, 6610.107635469246, 6794.45644348451, 6838.316168383122, 6969.163700355888, 7064.081669382947, 17193.7420938686, 17241.741373879402, 17246.91376543134, 17254.137293135293, 17254.482365529053, 7559.735409260649, 7754.9224507755325, 7790.9220907790195, 7796.337311328601, 7797.337226335711, 6943.583384996917, 7111.466640001917, 7162.856742865113, 7174.461915356369, 7326.963365183246, 5159.2003239497935, 5276.1030624793875, 5278.8944221116135, 5290.047791397586, 5331.733413329318, 1553.3999980020596, 1560.8439156084528, 1569.4663814303192, 1571.0652161963612, 1601.175394671745, 886.6674996876171, 894.3069121430943, 904.5251243097294, 916.8074704312036, 919.8298314811781, 7552.320291173821, 7575.848483030309, 7657.57883316423, 7658.923410765932, 7680.500767450098, 718.1382341190592, 728.3190217146985, 732.9157146928064, 733.3509843788286, 733.8495608400265, 4831.613470922318, 5091.847244582668, 5099.929014906911, 5109.8722531937, 5243.0, 21394.35816925495, 21624.0, 21898.45253868666, 22047.2283470081, 22102.668459973112, 20911.790882090983, 21526.46183845385, 21893.233736819137, 21940.561188776133, 22328.21851235199, 10868.891311086945, 11027.669169924915, 11135.10919126484, 11192.216544841784, 11305.378204198683, 8330.208630180123, 8338.207870252316, 8374.623141958748, 8384.832303353776, 8385.916140838513, 18139.727904081185, 18908.621827563646, 18991.0, 19116.904415477835, 19225.230990760214, 19202.327918522784, 19553.8044619552, 19610.0, 19654.90172549128, 20301.187952481734, 10075.647352342632, 10859.34843909368, 10863.293885897392, 10869.184811139037, 10875.40185289785, 13733.862661373258, 13804.723905522034, 13963.371648276056, 13992.930035349758, 14051.929740351234, 10901.0, 10921.126309895031, 11122.332660040423, 11132.443377831238, 11199.496022678835, 10436.791264174826, 10467.267291289536, 10489.79020419572, 10700.83948740754, 10767.569297228023, 9417.858732118886, 9536.904630953602, 9605.567749451431, 9635.084666956627, 9646.517674116407, 7319.890201647086, 7417.777466676009, 7418.554886706815, 7478.06524184477, 7501.962490187732, 7497.88753168692, 7569.545827250383, 7604.8479030417975, 7651.196624354363, 7704.884426733492], "value": 6599.463982758887, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.3959383111925, 516.1277441124499, 524.2424696313826, 524.6275144647301, 533.7704786941614, 6307.653079080649, 6324.6521441320765, 6341.556091073627, 6360.745570177193, 6393.808185754429, 6178.258608966919, 6212.192414986057, 6288.811335659926, 6319.810405687826, 6350.1744773179535, 5182.766775495112, 5232.529072383475, 5237.423883372826, 5241.266222728821, 5242.764075616587, 4928.137575924216, 5014.473480284572, 5168.405633352157, 5195.766190521435, 5245.029669511134, 4938.08645400602, 4972.353594032771, 5006.624503162259, 5011.899762004758, 5032.194848824189, 4964.826231081913, 4969.875753106165, 4977.178765503688, 4989.501049895018, 4994.950050499503, 4375.78121093944, 4453.777311134463, 4457.710248833815, 4468.419105516262, 4515.819367225307, 6089.44719096632, 6094.96952515239, 6160.1375807387, 6160.476359509447, 6163.568550201488, 5693.373728889819, 5719.370869204384, 5724.198612194255, 5725.76895967369, 5742.224799652077, 6600.636964966925, 6610.3720146586, 6620.30486798884, 6635.535512514126, 6698.129243198353, 4902.877428064291, 4907.11671899058, 4918.2376731606655, 4933.605311575066, 4936.136176169156, 6589.34106589342, 6740.359665831738, 6762.357576030269, 6804.693788779517, 6843.775772873836, 4817.9518204818205, 4979.278004689299, 4991.575716064102, 4994.850154495371, 5013.348264725562, 5055.317532133188, 5057.797688092435, 5060.544550990355, 5069.112905241568, 5072.1123803335, 5580.832575022756, 5688.11834165705, 5703.971480142573, 5728.484436400744, 5740.770369185186, 6541.215054193527, 6653.301403352675, 6677.732890684319, 6686.732530698815, 6700.698468568926, 1747.7553142560052, 1758.498827834061, 1765.8587313015184, 1770.4954088085092, 1785.9462916879104, 1205.6684411786828, 1208.957686480969, 1232.5377983256278, 1241.807519834427, 1253.3419954523947, 5695.40198279183, 5732.878834831139, 5752.2455651026, 5808.186853840466, 5835.124731290255, 6782.999015290501, 6788.694508747119, 6813.829654258584, 6823.727050917908, 6835.624040677711, 5699.544036477072, 5729.713514324267, 5749.798757043483, 5778.1286538018785, 5787.536997040227, 3567.2687099144614, 3593.407087830531, 3594.1374070223483, 3597.2086141048926, 3647.6170002149925, 6371.203599550056, 6385.808425747235, 6420.678966051679, 6427.107801489348, 6475.287718350977, 6819.488538359643, 6875.209350924708, 6885.380315771605, 6896.689648965808, 6911.9308806912295, 6477.967610162013, 6529.738810447624, 6571.835704107436, 6584.374484423972, 6604.207495100619, 6256.562040657111, 6591.769288074895, 6609.834754131185, 6657.900131497934, 6780.559263647847, 6618.0, 6620.470362370903, 6641.900371494528, 6672.465332973346, 6710.496712746466, 6292.622442653455, 6311.936880631135, 6384.744610215539, 6461.967690161519, 6535.44448721864, 4979.975100124621, 4982.0, 4989.950100498949, 5010.674306170233, 5019.196928491424, 6787.389134977876, 6793.66031698423, 6806.489513286424, 6820.965895170492, 6899.965500172668, 6463.482921366373, 6510.609363438209, 6610.636414997221, 6617.205935287796, 6629.801105966829, 6580.670966451563, 6621.966890165519, 6646.501512386493, 6653.301403352772, 6677.899831502628, 6572.441342485942, 6581.308962558863, 6597.736090556324, 6599.274079851117, 6614.0, 6593.307702691149, 6611.371919667624, 6614.966925165343, 6672.666366681549, 6676.566023208476, 6297.874042519215, 6322.715477803418, 6349.206349206349, 6440.13058237132, 6464.191976003], "value": 5084.036081680906, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.172139909884, 902.6705252582807, 923.6028507741669, 927.9628814847406, 934.6308208257739, 17536.38622648206, 17998.0, 18057.909710451444, 20543.589128217463, 22054.117835286568, 21320.57358852826, 21544.245951391706, 21561.67657485135, 21579.0, 21605.783942160575, 911.2983003087619, 919.3564504846601, 949.8337790886602, 951.6621599332241, 952.7094236257939, 952.5570609666504, 961.2742379503466, 976.3799987008265, 979.314479864098, 982.140626951414, 1026.6252817721552, 1026.7689769801773, 1029.7065336379133, 1034.177828626244, 1034.9896501035007, 1007.5667462990948, 1012.9189664826796, 1017.8625885505436, 1018.5671089786848, 1019.4240254256322, 745.8993035940133, 747.9326860582573, 751.504007355143, 754.3550264523808, 757.2351924556183, 19854.90072549628, 20025.0, 20081.79918200814, 20113.79886201134, 20166.39500814978, 20132.29536966199, 20543.178272869216, 20740.5851882963, 20927.581448370947, 20956.895215523826, 17070.658586828195, 17347.219375128025, 17359.132043397778, 17360.392386266547, 17365.913170434065, 3590.461430785377, 3613.6205698401814, 3627.963720362789, 3628.546431696038, 3635.1275693833554, 140503.0, 141320.29339853337, 141956.0, 142858.0, 144028.27985860108, 15967.520974370787, 16364.672706545802, 16494.0, 16513.504594861934, 16518.0, 31042.223944401572, 31380.0, 31534.684653153174, 31537.36925261482, 31547.21131971673, 8452.66189352419, 8491.915080849112, 8575.056743758181, 8654.394192406471, 8658.48049117055, 4304.117655880537, 4341.261985462479, 4341.45731783527, 4375.16871794358, 4385.232584297735, 5409.675419474844, 5412.539934105566, 5507.311586051744, 5508.283923089973, 5509.035918714209, 952.4999375328008, 962.1965658675085, 969.8399764038854, 978.7993461340408, 978.8433850583872, 645.4965127200791, 661.8312330355728, 667.576089183372, 669.5279827721445, 686.5468790598181, 9344.15902568772, 9736.221102311798, 9921.65274215399, 10495.10791582724, 10597.84103238452, 670.5239280111078, 673.9561928474634, 674.5986138247735, 683.5693513086724, 684.2644157530674, 5026.019926114445, 5078.111330517145, 5097.388313402415, 5133.050385678662, 5159.019786240602, 112296.0, 112898.0, 113010.0, 114765.42617287027, 117050.0, 104087.4795626017, 105315.94684053215, 105827.47086264673, 105883.4705826466, 107069.0, 90686.09313906908, 91121.54439227894, 91402.0, 92055.99999999866, 94552.0, 9381.530923453936, 9610.183134433652, 9654.855177172489, 9672.419654820733, 9753.219742420448, 33306.666933331326, 43283.567164329215, 43929.0, 44230.77884610556, 44531.332030020225, 70354.0, 80494.59752701434, 80875.0, 81079.0, 81155.0, 12637.684057898627, 12741.17182383142, 12796.0, 12823.743525129632, 12893.677658058623, 16601.83398166051, 17146.742798857777, 17263.05053222085, 17291.135443227537, 17438.82561174372, 16024.599385015, 16038.599035023752, 16079.839201607834, 16192.02847829134, 16204.513864584082, 15988.520344389686, 16032.198390080215, 16182.67634647324, 16255.943363681323, 16317.836821632107, 15606.453774117852, 15832.208389580705, 15904.0, 15916.840831591537, 15933.442329518411, 11434.714132146762, 11526.59656912004, 11582.94208528952, 11732.354720490455, 11820.881791182323, 11169.603799525059, 11264.380459074502, 11343.773124537298, 11615.593454229062, 11727.882721172678], "value": 8797.33876638158, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 108.0, 108.0, 107.0, 97.0, 108.0, 108.0, 107.0, 108.0], "value": 107.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 116.0, 117.0, 118.0, 120.0, 117.0, 116.0, 121.0, 116.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 162.0, 162.0, 163.0, 169.0, 168.0, 166.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 76.0, 75.0, 73.0, 72.0, 77.0, 76.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 83.0, 81.0, 81.0, 79.0, 79.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 148.0, 148.0, 148.0, 148.0, 150.0, 149.0, 150.0, 150.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 99.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 55.0, 55.0, 53.0, 53.0, 54.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 38.0, 38.0, 37.0, 37.0, 38.0, 39.0], "value": 37.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 74.0, 75.0, 75.0, 76.0, 76.0, 74.0, 74.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 121.0, 110.0, 116.0, 114.0, 121.0, 122.0, 110.0, 115.0, 113.0], "value": 115.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 171.0, 171.0, 167.0, 169.0, 178.0, 172.0, 166.0, 164.0, 174.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 65.0, 65.0, 67.0, 74.0, 67.0, 65.0, 69.0, 66.0], "value": 67.3, "unit": "score"}]}]} 16:11:01 INFO - Return code: 0 16:11:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:11:01 INFO - # TBPL SUCCESS # 16:11:01 INFO - Running post-action listener: _package_coverage_data 16:11:01 INFO - Running post-action listener: _resource_record_post_action 16:11:01 INFO - [mozharness: 2017-09-14 23:11:01.861405Z] Finished run-tests step (success) 16:11:01 INFO - Running post-run listener: _resource_record_post_run 16:11:01 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 16384; Write bytes: 349175808; Read time: 168; Write time: 203356 16:11:01 INFO - TinderboxPrint: CPU usage
13.1% 16:11:01 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 168 16:11:01 INFO - TinderboxPrint: I/O write bytes / time
349,175,808 / 203,356 16:11:01 INFO - TinderboxPrint: CPU idle
8,235.6 (86.9%) 16:11:01 INFO - TinderboxPrint: CPU user
1,193.6 (12.6%) 16:11:01 INFO - TinderboxPrint: Swap in / out
0 / 0 16:11:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12718080; Read time: 0; Write time: 1564 16:11:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:11:01 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 12288; Write bytes: 336457728; Read time: 152; Write time: 201792 16:11:02 INFO - Running post-run listener: _upload_blobber_files 16:11:02 INFO - Blob upload gear active. 16:11:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:11:02 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:11:02 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:11:02 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:11:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:03 INFO - (blobuploader) - INFO - Done attempting. 16:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:11:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:10 INFO - (blobuploader) - INFO - Done attempting. 16:11:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:11:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:11:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:11 INFO - (blobuploader) - INFO - Done attempting. 16:11:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:11:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:11:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:11:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:11:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:11:12 INFO - (blobuploader) - INFO - Done attempting. 16:11:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:11:12 INFO - Return code: 0 16:11:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:11:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:11:12 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01997524c89b92094f332d944fa3067f0a2c7b8592d86776b61a33760eaa8eb2a0dd315c04e40c7fce98e949228d2f2ddaa1baea417b20cc0b130e0fbc7b8752", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1347626e631a81e62d6a9504184536645623714e232a15b2f54f626c4f9b5265409ae5b4858cbb822f98f689a327d0cc11b5fa1ed9ea581a786ce55ec333fab9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6673d8954234ef1cad68af3b172f17e6b14d2f46a06cff9bff5d687849c38c43567f1f5f4713929184e38a9d5e419fa8281ea43f139b164a1fb7390da2f44ef", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb959906308974d74868d899ba5ef69d3a20b2738c11c83949e6d618030808fe356358be5f24d7f4dcf723a63cfe0585d30fff722b9b35eeece3247bfc593b25"} 16:11:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:11:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:11:12 INFO - Contents: 16:11:12 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01997524c89b92094f332d944fa3067f0a2c7b8592d86776b61a33760eaa8eb2a0dd315c04e40c7fce98e949228d2f2ddaa1baea417b20cc0b130e0fbc7b8752", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1347626e631a81e62d6a9504184536645623714e232a15b2f54f626c4f9b5265409ae5b4858cbb822f98f689a327d0cc11b5fa1ed9ea581a786ce55ec333fab9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6673d8954234ef1cad68af3b172f17e6b14d2f46a06cff9bff5d687849c38c43567f1f5f4713929184e38a9d5e419fa8281ea43f139b164a1fb7390da2f44ef", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb959906308974d74868d899ba5ef69d3a20b2738c11c83949e6d618030808fe356358be5f24d7f4dcf723a63cfe0585d30fff722b9b35eeece3247bfc593b25"} 16:11:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:11:12 INFO - Copying logs to upload dir... 16:11:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:11:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.020561 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-09-14 16:11:12.030505) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:11:12.040031) ========= 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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 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/01997524c89b92094f332d944fa3067f0a2c7b8592d86776b61a33760eaa8eb2a0dd315c04e40c7fce98e949228d2f2ddaa1baea417b20cc0b130e0fbc7b8752", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1347626e631a81e62d6a9504184536645623714e232a15b2f54f626c4f9b5265409ae5b4858cbb822f98f689a327d0cc11b5fa1ed9ea581a786ce55ec333fab9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6673d8954234ef1cad68af3b172f17e6b14d2f46a06cff9bff5d687849c38c43567f1f5f4713929184e38a9d5e419fa8281ea43f139b164a1fb7390da2f44ef", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb959906308974d74868d899ba5ef69d3a20b2738c11c83949e6d618030808fe356358be5f24d7f4dcf723a63cfe0585d30fff722b9b35eeece3247bfc593b25"} build_url:https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.010055 build_url: 'https://queue.taskcluster.net/v1/task/Nu1bmwwJTLu1t2PmdT-yrg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01997524c89b92094f332d944fa3067f0a2c7b8592d86776b61a33760eaa8eb2a0dd315c04e40c7fce98e949228d2f2ddaa1baea417b20cc0b130e0fbc7b8752", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1347626e631a81e62d6a9504184536645623714e232a15b2f54f626c4f9b5265409ae5b4858cbb822f98f689a327d0cc11b5fa1ed9ea581a786ce55ec333fab9", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d6673d8954234ef1cad68af3b172f17e6b14d2f46a06cff9bff5d687849c38c43567f1f5f4713929184e38a9d5e419fa8281ea43f139b164a1fb7390da2f44ef", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fb959906308974d74868d899ba5ef69d3a20b2738c11c83949e6d618030808fe356358be5f24d7f4dcf723a63cfe0585d30fff722b9b35eeece3247bfc593b25"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-14 16:11:12.307001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:11:12.307327) ========= 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=cbe409c6de289db6ac707de3000001d4-1505425132.434915-344683379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004532 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-14 16:11:12.389524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:11:12.391870) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-14 16:11:12.392184) ========= ========= Total master_lag: 0.52 =========