builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-004 starttime: 1506938240.33 results: success (0) revision: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.328872) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.329282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.329550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.347781) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.348203) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 02:57:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.9M=0s 2017-10-02 02:57:20 (41.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.189797 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.656521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.656843) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020391 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.713446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:20.715782) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 --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 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 --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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 02:57:20,768 truncating revision to first 12 chars 2017-10-02 02:57:20,768 Setting DEBUG logging. 2017-10-02 02:57:20,768 attempt 1/10 2017-10-02 02:57:20,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0a2877a3738c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 02:57:21,158 unpacking tar archive at: mozilla-central-0a2877a3738c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728339 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:21.478074) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:21.478345) ========= script_repo_revision: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:21.478705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:21.483018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 02:57:21.583709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-10-02 02:57:21.584027) ========= /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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:57:21 INFO - MultiFileLogger online at 20171002 02:57:21 in /builds/slave/test 02:57:21 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 02:57:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:21 INFO - {'append_to_log': False, 02:57:21 INFO - 'base_work_dir': '/builds/slave/test', 02:57:21 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:57:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:21 INFO - 'branch': 'Firefox-Non-PGO', 02:57:21 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:21 INFO - 'code_coverage': False, 02:57:21 INFO - 'config_files': ('talos/linux_config.py',), 02:57:21 INFO - 'default_actions': ('clobber', 02:57:21 INFO - 'read-buildbot-config', 02:57:21 INFO - 'download-and-extract', 02:57:21 INFO - 'populate-webroot', 02:57:21 INFO - 'create-virtualenv', 02:57:21 INFO - 'install', 02:57:21 INFO - 'setup-mitmproxy', 02:57:21 INFO - 'run-tests'), 02:57:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:21 INFO - 'disable_ccov_upload': False, 02:57:21 INFO - 'disable_stylo': False, 02:57:21 INFO - 'download_minidump_stackwalk': True, 02:57:21 INFO - 'download_symbols': 'ondemand', 02:57:21 INFO - 'enable_stylo': False, 02:57:21 INFO - 'enable_webrender': False, 02:57:21 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 02:57:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:21 INFO - 'gecko_profile': False, 02:57:21 INFO - 'gecko_profile_interval': 0, 02:57:21 INFO - 'installer_path': 'installer.exe', 02:57:21 INFO - 'log_level': 'info', 02:57:21 INFO - 'log_name': 'talos', 02:57:21 INFO - 'log_to_console': True, 02:57:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:57:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:57:21 INFO - 'opt_config_files': (), 02:57:21 INFO - 'pip_index': False, 02:57:21 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 02:57:21 INFO - 'system_bits': '32', 02:57:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:21 INFO - 'title': 'talos-linux64-ix-004', 02:57:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:21 INFO - 'use_talos_json': True, 02:57:21 INFO - 'verify': 'False', 02:57:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:21 INFO - 'work_dir': 'build'} 02:57:21 INFO - [mozharness: 2017-10-02 09:57:21.771853Z] Running clobber step. 02:57:21 INFO - Running pre-action listener: _resource_record_pre_action 02:57:21 INFO - Running main action method: clobber 02:57:21 INFO - rmtree: /builds/slave/test/build 02:57:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:22 INFO - Running post-action listener: _resource_record_post_action 02:57:22 INFO - [mozharness: 2017-10-02 09:57:22.771316Z] Finished clobber step (success) 02:57:22 INFO - [mozharness: 2017-10-02 09:57:22.771414Z] Running read-buildbot-config step. 02:57:22 INFO - Running pre-action listener: _resource_record_pre_action 02:57:22 INFO - Running main action method: read_buildbot_config 02:57:22 INFO - Using buildbot properties: 02:57:22 INFO - { 02:57:22 INFO - "project": "", 02:57:22 INFO - "product": "firefox", 02:57:22 INFO - "who": "archaeopteryx@coole-files.de", 02:57:22 INFO - "installer_path": "public/build/target.tar.bz2", 02:57:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 02:57:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:57:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 02:57:22 INFO - "stage_platform": "linux64", 02:57:22 INFO - "basedir": "/builds/slave/test", 02:57:22 INFO - "buildnumber": 88, 02:57:22 INFO - "platform": "ubuntu64_hw", 02:57:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:57:22 INFO - "slavebuilddir": "test", 02:57:22 INFO - "taskId": "NPrlEyYYQKeyjzbgq3b1sw", 02:57:22 INFO - "branch": "mozilla-central", 02:57:22 INFO - "script_repo_revision": "production", 02:57:22 INFO - "revision": "0a2877a3738c35b1cb9c6073d6c5be76f9c07656", 02:57:22 INFO - "slavename": "talos-linux64-ix-004", 02:57:22 INFO - "repo_path": "mozilla-central" 02:57:22 INFO - } 02:57:22 INFO - Finding installer, test and symbols from parent task. 02:57:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NPrlEyYYQKeyjzbgq3b1sw'}, attempt #1 02:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NPrlEyYYQKeyjzbgq3b1sw'}, attempt #1 02:57:23 INFO - Task dependencies: PYtAjz9HRZeMO2pXV7pH9g 02:57:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g'}, attempt #1 02:57:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 02:57:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.test_packages.json 02:57:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.crashreporter-symbols.zip 02:57:24 INFO - Running post-action listener: _resource_record_post_action 02:57:24 INFO - [mozharness: 2017-10-02 09:57:24.097071Z] Finished read-buildbot-config step (success) 02:57:24 INFO - [mozharness: 2017-10-02 09:57:24.097290Z] Running download-and-extract step. 02:57:24 INFO - Running pre-action listener: _resource_record_pre_action 02:57:24 INFO - Running main action method: download_and_extract 02:57:24 INFO - mkdir: /builds/slave/test/build/tests 02:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:24 INFO - trying https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.test_packages.json 02:57:24 INFO - Downloading https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:57:24 INFO - Downloaded 989 bytes. 02:57:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:57:24 INFO - Using the following test package requirements: 02:57:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:57:24 INFO - u'common': [u'target.common.tests.zip'], 02:57:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:57:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:57:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:57:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:57:24 INFO - u'mozbase': [u'target.common.tests.zip'], 02:57:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:57:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:57:24 INFO - u'web-platform': [u'target.common.tests.zip', 02:57:24 INFO - u'target.web-platform.tests.tar.gz'], 02:57:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:57:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 02:57:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.common.tests.zip 02:57:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:57:24 INFO - Fetch https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.common.tests.zip into memory 02:57:27 INFO - Content-Length response header: 55366722 02:57:27 INFO - Bytes received: 55366722 02:57:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.talos.tests.zip 02:57:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:57:37 INFO - Fetch https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.talos.tests.zip into memory 02:57:39 INFO - Content-Length response header: 14522385 02:57:39 INFO - Bytes received: 14522385 02:57:39 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')]} 02:57:39 INFO - trying https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 02:57:39 INFO - Downloading https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:57:41 INFO - Downloaded 61505409 bytes. 02:57:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 02:57:41 INFO - mkdir: /builds/slave/test/properties 02:57:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:41 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:41 INFO - Contents: 02:57:41 INFO - build_url:https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 02:57:41 INFO - Running post-action listener: _resource_record_post_action 02:57:41 INFO - Running post-action listener: find_tests_for_verification 02:57:41 INFO - Running post-action listener: set_extra_try_arguments 02:57:41 INFO - [mozharness: 2017-10-02 09:57:41.452546Z] Finished download-and-extract step (success) 02:57:41 INFO - [mozharness: 2017-10-02 09:57:41.452689Z] Running populate-webroot step. 02:57:41 INFO - Running pre-action listener: _resource_record_pre_action 02:57:41 INFO - Running main action method: populate_webroot 02:57:41 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:41 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['tresize', 02:57:41 INFO - 'tcanvasmark']}, 02:57:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:41 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['dromaeo_css', 02:57:41 INFO - 'kraken']}, 02:57:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:41 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'tests': ['damp', 'tps']}, 02:57:41 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['damp', 'tps']}, 02:57:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:41 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['dromaeo_dom']}, 02:57:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:57:41 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['basic_compositor_video', 02:57:41 INFO - 'glvideo']}, 02:57:41 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:57:41 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['ts_paint_webext', 02:57:41 INFO - 'tp5o_webext']}, 02:57:41 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:41 INFO - 'ts_paint', 02:57:41 INFO - 'tpaint', 02:57:41 INFO - 'sessionrestore', 02:57:41 INFO - 'sessionrestore_many_windows', 02:57:41 INFO - 'sessionrestore_no_auto_restore', 02:57:41 INFO - 'tabpaint', 02:57:41 INFO - 'cpstartup']}, 02:57:41 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['a11yr', 02:57:41 INFO - 'ts_paint', 02:57:41 INFO - 'tpaint', 02:57:41 INFO - 'sessionrestore', 02:57:41 INFO - 'sessionrestore_many_windows', 02:57:41 INFO - 'sessionrestore_no_auto_restore', 02:57:41 INFO - 'tabpaint', 02:57:41 INFO - 'cpstartup']}, 02:57:41 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 02:57:41 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 02:57:41 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['perf_reftest_singletons']}, 02:57:41 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['perf_reftest']}, 02:57:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:41 INFO - 'tsvgr_opacity', 02:57:41 INFO - 'tart', 02:57:41 INFO - 'tscrollx', 02:57:41 INFO - 'tsvg_static']}, 02:57:41 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['tsvgx', 02:57:41 INFO - 'tsvgr_opacity', 02:57:41 INFO - 'tart', 02:57:41 INFO - 'tscrollx', 02:57:41 INFO - 'tsvg_static']}, 02:57:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:57:41 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--disable-stylo'], 02:57:41 INFO - 'tests': ['tp5o']}, 02:57:41 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:57:41 INFO - 'talos_options': ['--mitmproxy', 02:57:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:41 INFO - '--firstNonBlankPaint'], 02:57:41 INFO - 'tests': ['tp6_google', 02:57:41 INFO - 'tp6_youtube', 02:57:41 INFO - 'tp6_amazon', 02:57:41 INFO - 'tp6_facebook']}, 02:57:41 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:57:41 INFO - 'talos_options': ['--disable-stylo', 02:57:41 INFO - '--mitmproxy', 02:57:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:41 INFO - '--firstNonBlankPaint'], 02:57:41 INFO - 'tests': ['tp6_google', 02:57:41 INFO - 'tp6_youtube', 02:57:41 INFO - 'tp6_amazon', 02:57:41 INFO - 'tp6_facebook']}, 02:57:41 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:57:41 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 02:57:41 INFO - 'talos_options': ['--stylo-threads=1', 02:57:41 INFO - '--mitmproxy', 02:57:41 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:57:41 INFO - '--firstNonBlankPaint'], 02:57:41 INFO - 'tests': ['tp6_google', 02:57:41 INFO - 'tp6_youtube', 02:57:41 INFO - 'tp6_amazon', 02:57:41 INFO - 'tp6_facebook']}, 02:57:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--xperf_path', 02:57:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:41 INFO - 'tests': ['tp5n']}, 02:57:41 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 02:57:41 INFO - 'talos_options': ['--disable-stylo', 02:57:41 INFO - '--xperf_path', 02:57:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:41 INFO - 'tests': ['tp5n']}}} 02:57:41 INFO - Running post-action listener: _resource_record_post_action 02:57:41 INFO - [mozharness: 2017-10-02 09:57:41.475462Z] Finished populate-webroot step (success) 02:57:41 INFO - [mozharness: 2017-10-02 09:57:41.475609Z] Running create-virtualenv step. 02:57:41 INFO - Running pre-action listener: _resource_record_pre_action 02:57:41 INFO - Running main action method: create_virtualenv 02:57:41 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:41 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:57:41 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 02:57:41 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:57:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:43 INFO - Installing pip...............done. 02:57:43 INFO - Return code: 0 02:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:57:43 INFO - Reading from file tmpfile_stdout 02:57:43 INFO - Output received: 02:57:43 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 02:57:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:43 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:43 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 02:57:43 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 02:57:43 INFO - Using env: {'DISPLAY': ':0', 02:57:43 INFO - 'HOME': '/home/cltbld', 02:57:43 INFO - 'LANG': 'en_US.UTF-8', 02:57:43 INFO - 'LANGUAGE': 'en_US:en', 02:57:43 INFO - 'LOGNAME': 'cltbld', 02:57:43 INFO - 'MAIL': '/var/mail/cltbld', 02:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:43 INFO - 'MOZ_NO_REMOTE': '1', 02:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:43 INFO - 'NO_EM_RESTART': '1', 02:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:43 INFO - 'PWD': '/builds/slave/test', 02:57:43 INFO - 'SHELL': '/bin/bash', 02:57:43 INFO - 'SHLVL': '1', 02:57:43 INFO - 'TERM': 'linux', 02:57:43 INFO - 'TMOUT': '86400', 02:57:43 INFO - 'USER': 'cltbld', 02:57:43 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:43 INFO - '_': '/tools/buildbot/bin/python'} 02:57:44 INFO - Ignoring indexes: http://pypi.python.org/simple/ 02:57:44 INFO - Downloading/unpacking pip>=1.5 02:57:44 INFO - Running setup.py egg_info for package pip 02:57:44 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:44 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:44 INFO - Installing collected packages: pip 02:57:44 INFO - Found existing installation: pip 1.1 02:57:44 INFO - Uninstalling pip: 02:57:44 INFO - Successfully uninstalled pip 02:57:44 INFO - Running setup.py install for pip 02:57:44 INFO - warning: no files found matching 'pip/cacert.pem' 02:57:44 INFO - warning: no files found matching '*.html' under directory 'docs' 02:57:44 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 02:57:44 INFO - no previously-included directories found matching 'docs/_build/_sources' 02:57:44 INFO - Installing pip script to /builds/slave/test/build/venv/bin 02:57:44 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 02:57:44 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 02:57:44 INFO - Successfully installed pip 02:57:44 INFO - Cleaning up... 02:57:44 INFO - Return code: 0 02:57:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:44 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:44 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 02:57:44 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 02:57:44 INFO - Using env: {'DISPLAY': ':0', 02:57:44 INFO - 'HOME': '/home/cltbld', 02:57:44 INFO - 'LANG': 'en_US.UTF-8', 02:57:44 INFO - 'LANGUAGE': 'en_US:en', 02:57:44 INFO - 'LOGNAME': 'cltbld', 02:57:44 INFO - 'MAIL': '/var/mail/cltbld', 02:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:44 INFO - 'MOZ_NO_REMOTE': '1', 02:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:44 INFO - 'NO_EM_RESTART': '1', 02:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:44 INFO - 'PWD': '/builds/slave/test', 02:57:44 INFO - 'SHELL': '/bin/bash', 02:57:44 INFO - 'SHLVL': '1', 02:57:44 INFO - 'TERM': 'linux', 02:57:44 INFO - 'TMOUT': '86400', 02:57:44 INFO - 'USER': 'cltbld', 02:57:44 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:44 INFO - '_': '/tools/buildbot/bin/python'} 02:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:44 INFO - Downloading/unpacking psutil>=3.1.1 02:57:44 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 02:57:44 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 02:57:44 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 02:57:44 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 02:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:46 INFO - Installing collected packages: psutil 02:57:46 INFO - Running setup.py install for psutil 02:57:46 INFO - building 'psutil._psutil_linux' extension 02:57:46 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 02:57:46 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 02:57:46 INFO - building 'psutil._psutil_posix' extension 02:57:46 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 02:57:46 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 02:57:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:46 INFO - Successfully installed psutil 02:57:46 INFO - Cleaning up... 02:57:46 INFO - Return code: 0 02:57:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:57:46 INFO - Using env: {'DISPLAY': ':0', 02:57:46 INFO - 'HOME': '/home/cltbld', 02:57:46 INFO - 'LANG': 'en_US.UTF-8', 02:57:46 INFO - 'LANGUAGE': 'en_US:en', 02:57:46 INFO - 'LOGNAME': 'cltbld', 02:57:46 INFO - 'MAIL': '/var/mail/cltbld', 02:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:46 INFO - 'MOZ_NO_REMOTE': '1', 02:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:46 INFO - 'NO_EM_RESTART': '1', 02:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:46 INFO - 'PWD': '/builds/slave/test', 02:57:46 INFO - 'SHELL': '/bin/bash', 02:57:46 INFO - 'SHLVL': '1', 02:57:46 INFO - 'TERM': 'linux', 02:57:46 INFO - 'TMOUT': '86400', 02:57:46 INFO - 'USER': 'cltbld', 02:57:46 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:46 INFO - '_': '/tools/buildbot/bin/python'} 02:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:48 INFO - Installing collected packages: mozsystemmonitor 02:57:48 INFO - Running setup.py install for mozsystemmonitor 02:57:48 INFO - Successfully installed mozsystemmonitor 02:57:48 INFO - Cleaning up... 02:57:48 INFO - Return code: 0 02:57:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:57:48 INFO - Using env: {'DISPLAY': ':0', 02:57:48 INFO - 'HOME': '/home/cltbld', 02:57:48 INFO - 'LANG': 'en_US.UTF-8', 02:57:48 INFO - 'LANGUAGE': 'en_US:en', 02:57:48 INFO - 'LOGNAME': 'cltbld', 02:57:48 INFO - 'MAIL': '/var/mail/cltbld', 02:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:48 INFO - 'MOZ_NO_REMOTE': '1', 02:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:48 INFO - 'NO_EM_RESTART': '1', 02:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:48 INFO - 'PWD': '/builds/slave/test', 02:57:48 INFO - 'SHELL': '/bin/bash', 02:57:48 INFO - 'SHLVL': '1', 02:57:48 INFO - 'TERM': 'linux', 02:57:48 INFO - 'TMOUT': '86400', 02:57:48 INFO - 'USER': 'cltbld', 02:57:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:48 INFO - '_': '/tools/buildbot/bin/python'} 02:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:48 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:49 INFO - warning: no files found matching '*.txt' 02:57:49 INFO - no previously-included directories found matching 'build' 02:57:49 INFO - no previously-included directories found matching 'dist' 02:57:49 INFO - no previously-included directories found matching '.git*' 02:57:49 INFO - Installing collected packages: jsonschema, functools32 02:57:50 INFO - Running setup.py install for functools32 02:57:50 INFO - warning: no files found matching '*.txt' 02:57:50 INFO - no previously-included directories found matching 'build' 02:57:50 INFO - no previously-included directories found matching 'dist' 02:57:50 INFO - no previously-included directories found matching '.git*' 02:57:50 INFO - Successfully installed jsonschema functools32 02:57:50 INFO - Cleaning up... 02:57:50 INFO - Return code: 0 02:57:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:57:50 INFO - Using env: {'DISPLAY': ':0', 02:57:50 INFO - 'HOME': '/home/cltbld', 02:57:50 INFO - 'LANG': 'en_US.UTF-8', 02:57:50 INFO - 'LANGUAGE': 'en_US:en', 02:57:50 INFO - 'LOGNAME': 'cltbld', 02:57:50 INFO - 'MAIL': '/var/mail/cltbld', 02:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:50 INFO - 'MOZ_NO_REMOTE': '1', 02:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:50 INFO - 'NO_EM_RESTART': '1', 02:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:50 INFO - 'PWD': '/builds/slave/test', 02:57:50 INFO - 'SHELL': '/bin/bash', 02:57:50 INFO - 'SHLVL': '1', 02:57:50 INFO - 'TERM': 'linux', 02:57:50 INFO - 'TMOUT': '86400', 02:57:50 INFO - 'USER': 'cltbld', 02:57:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:50 INFO - '_': '/tools/buildbot/bin/python'} 02:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:50 INFO - Cleaning up... 02:57:50 INFO - Return code: 0 02:57:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:57:50 INFO - Using env: {'DISPLAY': ':0', 02:57:50 INFO - 'HOME': '/home/cltbld', 02:57:50 INFO - 'LANG': 'en_US.UTF-8', 02:57:50 INFO - 'LANGUAGE': 'en_US:en', 02:57:50 INFO - 'LOGNAME': 'cltbld', 02:57:50 INFO - 'MAIL': '/var/mail/cltbld', 02:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:50 INFO - 'MOZ_NO_REMOTE': '1', 02:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:50 INFO - 'NO_EM_RESTART': '1', 02:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:50 INFO - 'PWD': '/builds/slave/test', 02:57:50 INFO - 'SHELL': '/bin/bash', 02:57:50 INFO - 'SHLVL': '1', 02:57:50 INFO - 'TERM': 'linux', 02:57:50 INFO - 'TMOUT': '86400', 02:57:50 INFO - 'USER': 'cltbld', 02:57:50 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:50 INFO - '_': '/tools/buildbot/bin/python'} 02:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:50 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 02:57:50 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 02:57:50 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 02:57:50 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 02:57:51 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:52 INFO - Downloading docopt-0.6.1.tar.gz 02:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:52 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:52 INFO - Running setup.py install for blobuploader 02:57:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:52 INFO - Running setup.py install for requests 02:57:52 INFO - Running setup.py install for docopt 02:57:52 INFO - Successfully installed blobuploader requests docopt 02:57:52 INFO - Cleaning up... 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'DISPLAY': ':0', 02:57:52 INFO - 'HOME': '/home/cltbld', 02:57:52 INFO - 'LANG': 'en_US.UTF-8', 02:57:52 INFO - 'LANGUAGE': 'en_US:en', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MAIL': '/var/mail/cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SHLVL': '1', 02:57:52 INFO - 'TERM': 'linux', 02:57:52 INFO - 'TMOUT': '86400', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - '_': '/tools/buildbot/bin/python'} 02:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:53 INFO - Running setup.py (path:/tmp/pip-e8z4bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:53 INFO - Running setup.py (path:/tmp/pip-SLjE6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:53 INFO - Running setup.py (path:/tmp/pip-IssDp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:53 INFO - Running setup.py (path:/tmp/pip-o_42DG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:53 INFO - Running setup.py (path:/tmp/pip-O2wvFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:53 INFO - Running setup.py (path:/tmp/pip-TnMW_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:53 INFO - Running setup.py (path:/tmp/pip-YYYdnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:53 INFO - Running setup.py (path:/tmp/pip-xeUFcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:53 INFO - Running setup.py (path:/tmp/pip-VWiU9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:53 INFO - Running setup.py (path:/tmp/pip-Lu3zhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:53 INFO - Running setup.py (path:/tmp/pip-dbrq_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:53 INFO - Running setup.py (path:/tmp/pip-TrgKVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:53 INFO - Running setup.py (path:/tmp/pip-4HRLOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:53 INFO - Running setup.py (path:/tmp/pip-uOGKX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:54 INFO - Running setup.py (path:/tmp/pip-LuJRD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:54 INFO - Running setup.py (path:/tmp/pip-tCJS5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:54 INFO - Running setup.py (path:/tmp/pip-NX99OU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:54 INFO - Running setup.py install for manifestparser 02:57:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozcrash 02:57:54 INFO - Running setup.py install for mozdebug 02:57:54 INFO - Running setup.py install for mozdevice 02:57:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozfile 02:57:54 INFO - Running setup.py install for mozhttpd 02:57:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozinfo 02:57:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:54 INFO - Running setup.py install for mozInstall 02:57:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for mozleak 02:57:55 INFO - Running setup.py install for mozlog 02:57:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for moznetwork 02:57:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for mozprocess 02:57:55 INFO - Running setup.py install for mozprofile 02:57:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for mozrunner 02:57:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:55 INFO - Running setup.py install for mozscreenshot 02:57:55 INFO - Running setup.py install for moztest 02:57:55 INFO - Running setup.py install for mozversion 02:57:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:56 INFO - Cleaning up... 02:57:56 INFO - Return code: 0 02:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:56 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')]} 02:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:56 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')]} 02:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:56 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:56 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 02:57:56 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 02:57:56 INFO - Using env: {'DISPLAY': ':0', 02:57:56 INFO - 'HOME': '/home/cltbld', 02:57:56 INFO - 'LANG': 'en_US.UTF-8', 02:57:56 INFO - 'LANGUAGE': 'en_US:en', 02:57:56 INFO - 'LOGNAME': 'cltbld', 02:57:56 INFO - 'MAIL': '/var/mail/cltbld', 02:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:56 INFO - 'MOZ_NO_REMOTE': '1', 02:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:56 INFO - 'NO_EM_RESTART': '1', 02:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:56 INFO - 'PWD': '/builds/slave/test', 02:57:56 INFO - 'SHELL': '/bin/bash', 02:57:56 INFO - 'SHLVL': '1', 02:57:56 INFO - 'TERM': 'linux', 02:57:56 INFO - 'TMOUT': '86400', 02:57:56 INFO - 'USER': 'cltbld', 02:57:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:56 INFO - '_': '/tools/buildbot/bin/python'} 02:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:56 INFO - Running setup.py (path:/tmp/pip-5uz2j7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:56 INFO - Running setup.py (path:/tmp/pip-CABtcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:56 INFO - Running setup.py (path:/tmp/pip-1fXI4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:56 INFO - Running setup.py (path:/tmp/pip-MAhF__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:56 INFO - Running setup.py (path:/tmp/pip-rcLnc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:56 INFO - Running setup.py (path:/tmp/pip-4qX1Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:56 INFO - Running setup.py (path:/tmp/pip-AFJkOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:56 INFO - Running setup.py (path:/tmp/pip-c_QsIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:56 INFO - Running setup.py (path:/tmp/pip-5iS8ET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:56 INFO - Running setup.py (path:/tmp/pip-NGmtgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:56 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)) 02:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:56 INFO - Running setup.py (path:/tmp/pip-Sdg_i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:57 INFO - Running setup.py (path:/tmp/pip-5uzNg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:57 INFO - Running setup.py (path:/tmp/pip-STihcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:57 INFO - Running setup.py (path:/tmp/pip-KSIeON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:57 INFO - Running setup.py (path:/tmp/pip-QdhKOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:57 INFO - Running setup.py (path:/tmp/pip-rOFoNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:57 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)) 02:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:57 INFO - Running setup.py (path:/tmp/pip-BG5Hsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:57 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)) 02:57:57 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)) 02:57:57 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)) 02:57:57 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)) 02:57:57 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)) 02:57:57 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)) 02:57:57 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)) 02:57:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:58 INFO - Downloading blessings-1.6.tar.gz 02:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:58 INFO - Installing collected packages: blessings 02:57:58 INFO - Running setup.py install for blessings 02:57:58 INFO - Successfully installed blessings 02:57:58 INFO - Cleaning up... 02:57:58 INFO - Return code: 0 02:57:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:59 INFO - Reading from file tmpfile_stdout 02:57:59 INFO - Current package versions: 02:57:59 INFO - argparse == 1.2.1 02:57:59 INFO - blessings == 1.6 02:57:59 INFO - blobuploader == 1.2.4 02:57:59 INFO - docopt == 0.6.1 02:57:59 INFO - functools32 == 3.2.3-2 02:57:59 INFO - jsonschema == 2.5.1 02:57:59 INFO - manifestparser == 1.1 02:57:59 INFO - mozInstall == 1.13 02:57:59 INFO - mozcrash == 1.0 02:57:59 INFO - mozdebug == 0.1 02:57:59 INFO - mozdevice == 0.51 02:57:59 INFO - mozfile == 1.2 02:57:59 INFO - mozhttpd == 0.7 02:57:59 INFO - mozinfo == 0.10 02:57:59 INFO - mozleak == 0.1 02:57:59 INFO - mozlog == 3.5 02:57:59 INFO - moznetwork == 0.27 02:57:59 INFO - mozprocess == 0.25 02:57:59 INFO - mozprofile == 0.28 02:57:59 INFO - mozrunner == 6.13 02:57:59 INFO - mozscreenshot == 0.1 02:57:59 INFO - mozsystemmonitor == 0.3 02:57:59 INFO - moztest == 0.8 02:57:59 INFO - mozversion == 1.4 02:57:59 INFO - psutil == 3.1.1 02:57:59 INFO - requests == 1.2.3 02:57:59 INFO - wsgiref == 0.1.2 02:57:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57: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')]} 02:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:59 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:57:59 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 02:57:59 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 02:57:59 INFO - Using env: {'DISPLAY': ':0', 02:57:59 INFO - 'HOME': '/home/cltbld', 02:57:59 INFO - 'LANG': 'en_US.UTF-8', 02:57:59 INFO - 'LANGUAGE': 'en_US:en', 02:57:59 INFO - 'LOGNAME': 'cltbld', 02:57:59 INFO - 'MAIL': '/var/mail/cltbld', 02:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:59 INFO - 'MOZ_NO_REMOTE': '1', 02:57:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:59 INFO - 'NO_EM_RESTART': '1', 02:57:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:59 INFO - 'PWD': '/builds/slave/test', 02:57:59 INFO - 'SHELL': '/bin/bash', 02:57:59 INFO - 'SHLVL': '1', 02:57:59 INFO - 'TERM': 'linux', 02:57:59 INFO - 'TMOUT': '86400', 02:57:59 INFO - 'USER': 'cltbld', 02:57:59 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:59 INFO - '_': '/tools/buildbot/bin/python'} 02:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 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)) 02:57:59 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:57: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 02:57: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 02:57: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 02:57: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 02:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:58:01 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)) 02:58:01 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)) 02:58:01 INFO - Installing collected packages: simplejson 02:58:01 INFO - Running setup.py install for simplejson 02:58:01 INFO - building 'simplejson._speedups' extension 02:58:01 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 02:58:02 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 02:58:02 INFO - Successfully installed simplejson 02:58:02 INFO - Cleaning up... 02:58:02 INFO - Return code: 0 02:58:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:02 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 0x29781f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b40b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ce59c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', '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 02:58:02 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 02:58:02 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 02:58:02 INFO - Using env: {'DISPLAY': ':0', 02:58:02 INFO - 'HOME': '/home/cltbld', 02:58:02 INFO - 'LANG': 'en_US.UTF-8', 02:58:02 INFO - 'LANGUAGE': 'en_US:en', 02:58:02 INFO - 'LOGNAME': 'cltbld', 02:58:02 INFO - 'MAIL': '/var/mail/cltbld', 02:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:02 INFO - 'MOZ_NO_REMOTE': '1', 02:58:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:02 INFO - 'NO_EM_RESTART': '1', 02:58:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:02 INFO - 'PWD': '/builds/slave/test', 02:58:02 INFO - 'SHELL': '/bin/bash', 02:58:02 INFO - 'SHLVL': '1', 02:58:02 INFO - 'TERM': 'linux', 02:58:02 INFO - 'TMOUT': '86400', 02:58:02 INFO - 'USER': 'cltbld', 02:58:02 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:02 INFO - '_': '/tools/buildbot/bin/python'} 02:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:02 INFO - Cleaning up... 02:58:02 INFO - Return code: 0 02:58:02 INFO - Running post-action listener: _resource_record_post_action 02:58:02 INFO - Running post-action listener: _start_resource_monitoring 02:58:02 INFO - Starting resource monitoring. 02:58:02 INFO - [mozharness: 2017-10-02 09:58:02.739315Z] Finished create-virtualenv step (success) 02:58:02 INFO - [mozharness: 2017-10-02 09:58:02.739831Z] Running install step. 02:58:02 INFO - Running pre-action listener: _resource_record_pre_action 02:58:02 INFO - Running main action method: install 02:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:02 INFO - Reading from file tmpfile_stdout 02:58:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:03 INFO - Reading from file tmpfile_stdout 02:58:03 INFO - Output received: 02:58:03 INFO - Usage: mozinstall [options] installer 02:58:03 INFO - Options: 02:58:03 INFO - -h, --help show this help message and exit 02:58:03 INFO - -d DEST, --destination=DEST 02:58:03 INFO - Directory to install application into. [default: 02:58:03 INFO - "/builds/slave/test"] 02:58:03 INFO - --app=APP Application being installed. [default: firefox] 02:58:03 INFO - mkdir: /builds/slave/test/build/application 02:58:03 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'] 02:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:58:20 INFO - Reading from file tmpfile_stdout 02:58:20 INFO - Output received: 02:58:20 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:20 INFO - Running post-action listener: _resource_record_post_action 02:58:20 INFO - [mozharness: 2017-10-02 09:58:20.950769Z] Finished install step (success) 02:58:20 INFO - [mozharness: 2017-10-02 09:58:20.950915Z] Running setup-mitmproxy step. 02:58:20 INFO - Running pre-action listener: _resource_record_pre_action 02:58:20 INFO - Running main action method: setup_mitmproxy 02:58:20 INFO - Skipping: mitmproxy is not required 02:58:20 INFO - Running post-action listener: _resource_record_post_action 02:58:20 INFO - [mozharness: 2017-10-02 09:58:20.951755Z] Finished setup-mitmproxy step (success) 02:58:20 INFO - [mozharness: 2017-10-02 09:58:20.951976Z] Running run-tests step. 02:58:20 INFO - Running pre-action listener: _resource_record_pre_action 02:58:20 INFO - Running pre-action listener: _set_gcov_prefix 02:58:20 INFO - Running main action method: run_tests 02:58:20 WARNING - Try message not found. 02:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:20 INFO - Python 2.7.3 02:58:20 INFO - Return code: 0 02:58:20 INFO - grabbing minidump binary from tooltool 02:58:20 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')]} 02:58:20 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 0x2ce2d60>, '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 0x2ce3a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ce3ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:20 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 02:58:20 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 02:58:20 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 02:58:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:21 INFO - Return code: 0 02:58:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:21 INFO - ENV: RUST_BACKTRACE is now full 02:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:21 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/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 02:58:21 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/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 02:58:21 INFO - Using env: {'DISPLAY': ':0', 02:58:21 INFO - 'HOME': '/home/cltbld', 02:58:21 INFO - 'LANG': 'en_US.UTF-8', 02:58:21 INFO - 'LANGUAGE': 'en_US:en', 02:58:21 INFO - 'LOGNAME': 'cltbld', 02:58:21 INFO - 'MAIL': '/var/mail/cltbld', 02:58:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:21 INFO - 'MOZ_NO_REMOTE': '1', 02:58:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:21 INFO - 'NO_EM_RESTART': '1', 02:58:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:21 INFO - 'PWD': '/builds/slave/test', 02:58:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:21 INFO - 'RUST_BACKTRACE': 'full', 02:58:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:21 INFO - 'SHELL': '/bin/bash', 02:58:21 INFO - 'SHLVL': '1', 02:58:21 INFO - 'TERM': 'linux', 02:58:21 INFO - 'TMOUT': '86400', 02:58:21 INFO - 'USER': 'cltbld', 02:58:21 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:21 INFO - '_': '/tools/buildbot/bin/python'} 02:58:21 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/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 02:58:21 INFO - mozversion application_buildid: 20171002090256 02:58:21 INFO - mozversion application_changeset: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 02:58:21 INFO - mozversion application_display_name: FirefoxNightly 02:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:21 INFO - mozversion application_name: Firefox 02:58:21 INFO - mozversion application_remotingname: firefox 02:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:58:21 INFO - mozversion application_vendor: Mozilla 02:58:21 INFO - mozversion application_version: 58.0a1 02:58:21 INFO - mozversion platform_buildid: 20171002090256 02:58:21 INFO - mozversion platform_changeset: 0a2877a3738c35b1cb9c6073d6c5be76f9c07656 02:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:58:21 INFO - mozversion platform_version: 58.0a1 02:58:21 INFO - using testdate: 1506938301 02:58:21 INFO - actual date: 1506938301 02:58:21 INFO - starting webserver on 'localhost:35970' 02:58:21 INFO - SUITE-START | Running 2 tests 02:58:21 INFO - TEST-START | dromaeo_css 02:58:21 INFO - Initialising browser for dromaeo_css test... 02:58:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35970/getInfo.html -profile /tmp/tmpytGW9j/profile 02:58:21 INFO - TEST-INFO | started process 7482 (/builds/slave/test/build/application/firefox/firefox http://localhost:35970/getInfo.html) 02:58:27 INFO - TEST-INFO | 7482: exit 0 02:58:27 INFO - Browser initialized. 02:58:27 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:27 INFO - Using env: {'DISPLAY': ':0', 02:58:27 INFO - 'HOME': '/home/cltbld', 02:58:27 INFO - 'JSGC_DISABLE_POISONING': '1', 02:58:27 INFO - 'LANG': 'en_US.UTF-8', 02:58:27 INFO - 'LANGUAGE': 'en_US:en', 02:58:27 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 02:58:27 INFO - 'LOGNAME': 'cltbld', 02:58:27 INFO - 'MAIL': '/var/mail/cltbld', 02:58:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:27 INFO - 'MOZ_CRASHREPORTER': '1', 02:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:27 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 02:58:27 INFO - 'MOZ_NO_REMOTE': '1', 02:58:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:27 INFO - 'NO_EM_RESTART': '1', 02:58:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:27 INFO - 'PWD': '/builds/slave/test', 02:58:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:27 INFO - 'RUST_BACKTRACE': 'full', 02:58:27 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:58:27 INFO - 'SHELL': '/bin/bash', 02:58:27 INFO - 'SHLVL': '1', 02:58:27 INFO - 'STYLO_FORCE_DISABLED': '1', 02:58:27 INFO - 'TERM': 'linux', 02:58:27 INFO - 'TMOUT': '86400', 02:58:27 INFO - 'USER': 'cltbld', 02:58:27 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 02:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:27 INFO - '_': '/tools/buildbot/bin/python'} 02:58:27 INFO - TEST-INFO | started process 7719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpytGW9j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:28 INFO - PID 7719 | 02:58:28 INFO - PID 7719 | (/builds/slave/test/build/application/firefox/firefox:7768): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:58:28 INFO - PID 7719 | 02:58:38 INFO - PID 7719 | RSS: Main: 151703552 02:58:38 INFO - PID 7719 | 03:01:36 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35970/tests/dromaeo/cssquery-ext.html) 03:01:37 INFO - PID 7719 | RSS: Main: 149942272 03:01:37 INFO - PID 7719 | 03:04:39 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-ext.html (next: http://localhost:35970/tests/dromaeo/cssquery-jquery.html) 03:04:39 INFO - PID 7719 | RSS: Main: 148811776 03:04:39 INFO - PID 7719 | 03:07:41 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35970/tests/dromaeo/cssquery-mootools.html) 03:07:42 INFO - PID 7719 | RSS: Main: 151420928 03:07:42 INFO - PID 7719 | 03:10:44 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35970/tests/dromaeo/cssquery-prototype.html) 03:10:44 INFO - PID 7719 | RSS: Main: 151556096 03:10:44 INFO - PID 7719 | 03:13:47 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35970/tests/dromaeo/cssquery-yui.html) 03:13:48 INFO - PID 7719 | RSS: Main: 154640384 03:13:48 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | Cycle 1(1): loaded http://localhost:35970/tests/dromaeo/cssquery-yui.html (next: http://localhost:35970/tests/dromaeo/cssquery-dojo.html) 03:16:50 INFO - PID 7719 | RSS: Main: 154140672 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | __start_tp_report 03:16:50 INFO - PID 7719 | _x_x_mozilla_page_load 03:16:50 INFO - PID 7719 | _x_x_mozilla_page_load_details 03:16:50 INFO - PID 7719 | |i|pagename|runs| 03:16:50 INFO - PID 7719 | |0;dojo.html;3184.172115250035;3184.474561697319;3220.8872689455875;3221.9850747014675;3232.1273256220807;6293.150424692665;6449.419552240297;6478.611283322998;6500.902486462701;6506;6355.5233357498255;6377.521685873567;6444.677766111688;6525.086487891699;6544;5831.854203644901;5866.794662186824;5964.612300200484;5971.134185543094;5995.700214989255;5889.440503152194;5923.703814809264;5995.100734889779;6032.306284777241;6039.486643635274;5745.626534275259;5828.621139625953;5836.941630583682;5888.64668119912;5890.5582081343855;5813.157092221646;5858.179854820329;5861.062230043172;5876.911846322266;5883.735231914574;5779.3642699303045;5826.650400975955;5844.503217226498;5855.121731740231;5888.411158884121;6248.593841400339;6372.553921225516;6396.072569477446;6437.806865794034;6470.57941233823;6823.488238382141;6847.1783385994;6940.895886561706;6981.581105133658;6996.195437524699;6933.618650974195;6976.162860456778;6998.440124790005;7057.082579264663;7057.576545407292;6170.413810687977;6390.616563006234;6440.323766004549;6495.707693153772;6502.479801615859;7013.2986701329455;7034.40207582351;7046.612436316052;7047.295270473014;7078.964605177044;6622.63575503352;6657;6669.666516674147;6722.596644201363;6850.623215723183;6934.029235906977;6945.2707465715375;6947.305269473113;6963.582185068912;6978.057962175041;6823.624700641512;6829.795106146824;6832.726690932307;6893.586384816927;6905.033295338657;6639.236487803964;6800.65996700163;6870.072540207108;6884.586924784529;6964.965175174092;5422.810201642924;5432.239486471897;5437.864053398696;5440.102383106743;5440.646357986719;4682.157211701926;4760;4773.427188737373;4789.928151077736;4795.040991801584;5861.384554621789;5871.970640146772;5888.263967004124;5956.910646340309;5960.225170727865;6966.825829354307;6979.546329488567;6981.406580440618;6988.19635741886;6999.30006999296;5894.67579283135;5943.910841337383;5954.374790647006;5958.612690175125;5959.016762234182;5883.294004719461;5898.557608179403;5961;5977.551683623746;5998.25021872266;6515.153030106056;6515.185601799775;6550.148480697479;6656.034874943203;6754.493412994045;6920.8961865573065;6936.445084393337;6941.548799328028;6968.616726080114;6979.057827193264;6635.402813746786;6642.767503137367;6709.496787740842;6716.529842910949;6723.596584204964;6768.9661551691925;6774.153230846145;6774.593524388552;6863.588184708734;6871.759488417882;6799.252082271045;6884.51808373409;6902.930970690229;6909.654517274217;6998.090248267693;6617.205935287796;6624.56940298879;6627.502937279627;6629.105070815378;6629.502787291069;6521.869562608626;6627.801165965029;6665.166854143232;6769.559978601375;6791.3548212919695;6623.635700036544;6634.867302654016;6698.028785826125;6709.630970296681;6717.261101278953;6768.492363072691;6772.492063095386;6789.89815152783;6855.245922948372;6857.382835544626;6331.398517140864;6435.356464353715;6477.481801455967;6603.735850565923;6626.602403855784 03:16:50 INFO - PID 7719 | |1;ext.html;870.2726223584385;879.49993329903;896.4621227263642;919.4804935211607;922.3773952582002;40198.19603607926;40902.59097409025;40974.9756256093;41614;41667;41384.17231655365;41565.58434415655;41656.58343416565;41691;41694.791526042325;7925.405594580401;8069.919300806975;8071.515709057446;8081.272685458308;8082.959585202066;7953;7962.6416811243635;8042.798930026737;8052.355811535063;8054.476459030174;8037.196280371974;8070.71752488663;8082.878756818623;8085.878711819328;8097.716579919704;7967.402444816604;8000.199980001982;8001.7199398021085;8031.879521807177;8040.597970101471;7845.37237021037;7875.6062196889925;7903;7937.285644292041;7939.483933544301;36378.45432318517;36826.63173368259;36833.631663683555;36834;36931.63068369309;3475.6350583188905;3508.7543871928974;3511.841967111486;3512.666296701809;3512.8067956262394;31020.37959240825;31025;31104.688953110406;31146.844265778753;31176.376472470423;4998.550130488237;5107.974460127675;5121.436641969381;5155.458676838915;5180.222966555047;186580;189424.0528797361;189750;190097;190179;47187.76406117948;47263.76368118137;47482.52517474781;47649.76175119171;47748.28377574339;57648.71175644095;57766.71116644474;58548;58560.4143958555;58561.70719146462;15529.68940621204;15532.301046452936;15573.688526229413;15658.608534786494;15665.216739162996;11676.941615292038;11863.228890122115;11911.10666700001;11912.880871191177;11945.761084778256;15108.924455377872;15176.317065732068;15291.464798731991;15335.539933802003;15480.148591827332;5972.85067873298;6018.458338749533;6043.516518678495;6087.96956015226;6088.238970128734;1012.5089331674133;1026.2764750850633;1026.3636545341787;1026.90757831794;1027.4862568715641;22770.43073923165;23015.769842301364;23099.422514436937;23305.650415243785;23595.646065309033;1111.8499002634542;1113.6826004588654;1116.8771435142128;1122.865256169265;1122.927009744364;12252.039673652172;12493.250404975548;12560.874391255971;12662;12711.364431778375;229345;229413;229429;232446;237134;56394.154087688716;56844;57088;57111;57217.713911430175;1404.5505438259659;1441.654003039284;1458.912465252067;1461.1306272767686;1465.2014652014677;26521.734782652697;26616;26773.732262677124;26795.598066029415;26949;35989.640103599675;36224.456633149995;36323.45514817333;36331;36335.27329453449;190046;190708.55748655126;190944;191116;192701;33469.16327091842;34619.48070778991;34879;35031;35144.824275878455;41414.58585414107;42719.35920961126;42803;42806.78596606997;42851.357229640955;31103.377932441676;31771.20571985719;31810;31907.840460798478;32164.19589510281;30405.239869003453;30427.54358684577;30511.389772204875;30802;30960.22599434942;35639.64360356363;35655;35675.10812229715;35705.28589428249;35898.8205058973;30624;30739.53890691597;30761.384772304875;31221.687783121877;31631.683683163796;23088.307350779505;23129.421764456023;23302.3009309721;23587.646185307578;23851.403714907265 03:16:50 INFO - PID 7719 | |2;jquery.html;591.6065816232206;596.2695697770232;601.3265143039795;608.8873558391695;609.1532769450465;22312.21907233247;23046.308610741664;23086.88456557719;23109.19117830874;23150.421239469;24875.75124248757;25259.74740252597;26417.60373594393;26699.733002669967;26777;6762.222344430392;6948.0272761813385;6949.965250173742;6953.582785032889;6953.652317384136;5941.88116237675;6185.690715464231;6209.5032397408095;6772.187337519505;6887.070245516841;6179.629222246657;6191.504679625642;6202.534809889254;6211.440970312671;6212.534059945499;6187.195664563623;6194.132821405007;6206.6586337751405;6213.316535181127;6429.8392540186405;5991.970040149771;6007.489363404072;6013.248343957005;6017.157597936292;6019.909701354483;29903.252418689488;30423.087307380814;30434.695653043407;30466.84766576175;30472.390552188834;2092.184048221195;2111.8944052797297;2116.8094871461644;2117.9364619061453;2118.470382404399;18472.445826625222;18600.53498662531;18602.44192674222;19078.713819292723;20558.177672893067;2431.477232395026;2449.2774631483753;2492.6011838105815;2500.362407586054;2510.497900419905;118049;122504.38747806204;123626;140525;147204;15121.412251713631;15142.470013549693;15351.692966140838;15498.5350439487;15929.840701593068;24345.391365215655;24446.26661200167;24462.633060504108;24481.877590611934;24638.13766518163;10339.63811266602;10426.635067772591;10477.895221047844;10482.737931551772;10520.368777873353;9571.760705982406;9638.710838674851;9645.614175433044;9680.419174849532;9770.658026969022;9283.25733941283;9366.203872670763;9518.95240523793;9535.856962145574;9624.75938101539;2670.5593577059567;2738.904138355148;2779.027340430833;2828.3918957424253;2831.80177387585;942.5240253671852;967.1972263021676;969.3956501989219;969.8742147749113;975.8097171051719;19963.401097967086;19970;20014.69977950332;20247;20297.086631101636;1021.5147804792664;1034.2760067952463;1041.390786389955;1043.76515284062;1053.931494452858;11046.723831904266;11072.280301780358;11111.611093611846;11182.273152245078;11191.608293709682;464505;472562;500745;503556;503996;117438.41280793713;117520;120459.39770301092;121572.39213804051;121855.39072304581;1041.9947900260602;1102.6306187427301;1156.0982433701727;1156.4333476596576;1209.6975756060808;21255.797217335457;21599.46001349979;21753;21835.253179745265;21842.563148737256;54743;55376.446235538744;55749.44250557443;56767;57575.71212143912;69216.6539167301;69390;70238;70283;71072;14958.252087395369;14973.802095832525;14999.175045372609;15259.771103433235;15290.923545382648;23350.53298933978;23718;23782.16762413307;23877;23939.28182154538;19085.809141908958;19146.425607231806;19267.710984334964;19524.21903123859;19529.21883124659;17190.054547000036;17205.56986075358;17315.653686926442;17762.644747105245;17932.820671793113;18982.620347592696;19517.51206219856;19656.606867862276;19807.405777826687;19864.205431782568;14998;15080.170590617183;15130.773038404213;15130.848691512943;15131.848681513044;19047.904760476664;19086.23655053838;19144.329948451737;19269.325573604856;19271 03:16:50 INFO - PID 7719 | |3;mootools.html;1341.2824139085587;1414.5614859393588;1424.3661570601084;1427.9571612851619;1429.7640889253273;14533.781993270097;15159.696806063886;15172.848271517296;15193.316300766464;15197.088174709525;14663.193524356157;14700.779488307684;14731.337089830957;14777.704445911075;14799.926000369984;2651.761341479262;2772.3207814085577;2782.833030018195;2783.3876547159593;2785.7492825645686;2747.8900843966317;2797.496450638884;2800.8179468334597;2807.7753779697573;2810.4800611886867;2631;2829.985850070747;2844.1183233197776;2845.5873898284735;2847.800653954224;2648.2982009767234;2693.5555633320478;2697.393086555529;2715.6198132261497;2720.7143249958767;2686.637303963979;2699.4870974514974;2730.931726706828;2839.54567269238;2851.4867323881695;14198.574042778733;14237.216953067576;14309.57071287863;14354.354054067591;14386.35261413239;7850.175731548219;8129.634166462523;8136.511809291403;8139.226773456512;8189.71336003243;5399.730013499348;5404;5478.150886612581;5588.720563971826;5680.147977803321;1879.4831421359236;1886.8396186324178;1888.5656299051159;1907.265702704455;1911.5030092175996;21840.563188736138;22075.227367042076;22094.88952555227;22124.6681299779;22141.557168856532;6598.241202261801;6757.391834734897;6836.863262734817;6984.406325462291;6999.545029573062;15979.920100399657;16392.75410868838;16400.835991640168;16988.235529401205;17118.40085597023;7526.661300241502;7713.961430192813;7722.42081843864;7722.45942784011;7727;7042.6830792614455;7113.502054856111;7133.678984445713;7137.607431591208;7178.533395329287;5212.244224587414;5314.7608357624;5349.491798279158;5366.758495867695;5384.353877534721;1516.3555488917166;1520.9163496007825;1527.9847201528064;1531.111955066059;1533.7776022476678;896.8878890138733;902.3638334973828;923.9538023098818;924.4222361024359;932.9253659707207;7601.885971710429;7610.9238907611325;7684.807879803049;7685.269899359552;7713.190115037953;721.2967356827156;745.8023623739713;748.7341993592305;753.3069575990103;762.0360244290977;4890.82882099132;5254.395744489356;5340.118880384693;5359.276497672842;5441.319835020622;20356.69464958027;20373.185072597225;20787.896060519903;21129.89435052815;21236.25673101434;19227.230910763694;19672.606547868963;20124.19503219855;20139.39581812548;20160.092795824225;10796.838047429295;10805.729856753644;10963.177761667748;10979.451027448597;10981.670549883516;8157.265846073882;8209.71266005687;8247.505149691038;8258.958705206436;8430.620622072143;17354.04552749611;17612.55968600744;17830.108494575477;17933.910330448263;18275.81724182741;17513.124343782503;17814.198361074043;17835.554111147325;17870.642587147926;18076.457706268833;10694.144468442662;10712;10788.352698838095;10814.837777433502;10879.836802448128;13073.738525229632;13262.071654984058;13278;13286.402111904794;13319.800202997156;11262.38056906878;11314.264572802742;11332.433378331216;11399.20205585601;11502.82745758831;10752;10786.298890572089;10869.402182880018;10996.450177491253;11192.944035279772;9208.401453905475;9358.251339892928;9360.4383736976;9373.062693730571;9373.765655858659;6896.069030680794;6912.585244885323;6947.201071876597;6971.337722916315;7009.439244860501;6977.755778547727;7018.473614478832;7047.7180912762915;7112.608806515691;7187.2453392393045 03:16:50 INFO - PID 7719 | |4;prototype.html;508.5100655080615;535.2132365422827;538.3217146395543;539.8677324055606;542.6282996147639;6422.903656445157;6436.613803171807;6456.548041637081;6515.967420162892;6539.280679125304;6298.8898718929095;6307.936920630792;6339.6830158492;6355.396237357455;6389.680515974194;5293.947060529403;5300.337457817773;5307.2569840222395;5318.005747844558;5339.22581225722;5295.4969277918535;5316.149416093426;5334.893302133955;5346.518813306801;5377.9512994966;4958.281049247875;5125.692458452486;5128.8974220515565;5135.204043373283;5156.664816786915;5070.974645126787;5120.795168193268;5128.25640282157;5136.178211486163;5144.4083930348115;4589.839355622537;4598.241290187115;4602.88492787683;4628.004978929513;4644.86065418038;6224.502039836802;6265.373462653743;6305.716242769086;6329.36706329368;6365.777197798101;5867.119932010232;5869.7652093916195;5920.437558431942;5925.762969481216;5927.733252003627;6589.93410065898;6650.667466626649;6676.399124078807;6725.66371681414;6730.206964109938;4980.651354405193;4983.950160498385;4986.67586606873;4989.426215985171;5035.496450354935;6724.596524208514;6823.965880170567;6891.620960847152;6916.3429474200375;7025.578465292099;5085.338905942203;5119.180931051088;5119.846404607868;5142.228665700175;5184.533391994739;5143.27994080829;5153.974230128825;5179.300794392784;5198.090334191501;5274.3143391359645;5745.482906538432;5775.422457754275;5827.79602713903;5869;5869.119632055226;6661;6668.86662266752;6681.986212408774;6724.3611856874495;6786;1771.7076682347526;1802.738602902598;1809.8280663336961;1811;1837.090640133116;1172.3903570143477;1235.8269842222096;1238.4303220518661;1245.5765039886483;1270.9491620335268;5677.602567820296;5744.626599271034;5768.451997060272;5854.765809367577;5862.560307976919;6608.966955165193;6714.597124172566;6823.69293381799;6843.520953533304;6849.2465828758795;5630.60585758993;5639.915401268984;5674.2339784129435;5691.430856914276;5732;3565.714742820568;3600.2079542501133;3617.2403795203304;3626.401643728808;3635.8547057676747;6169.475594574422;6469.838254043592;6509.056186852879;6551.4103730664465;6614.933850661432;6824.761133360308;6834.350736680008;6850.143732033496;6866.9999999999;6982.860342793218;6497.18785151856;6500.674966251574;6536.182977127859;6543.476521878333;6601.504887133484;6723.294054124247;6797.5581587196675;6842.076319696777;6846.657667116525;6857.074294970314;6811.761588344384;6811.8978215325815;6814.829629259309;6816.591004539743;6833.829154270984;6554.31179726141;6571.310012448624;6609.4712423007;6610.173728283965;6624.8343791405605;5098.1842905135;5099;5147.768350424165;5149.755653937995;5166.4316925138955;6497.4477169441125;6617.371349721769;6629.867402651824;6710.698018589273;6745.448546834354;6486.383793539606;6538.313477085027;6609.900851487136;6637.601743895381;6666.866662666816;6415.294317624965;6541.542092053511;6543;6558.146971241343;6583.30875258091;6509.283978762427;6526.9020964686515;6552.180977377828;6585.670716464253;6602.6698665067515;6555.70499327541;6587.440067594116;6699.196096468455;6703.29615390377;6717.9328206719265;6435.967820161057;6474.967625161844;6475.579087359307;6492.156019717407;6546.443552298108 03:16:50 INFO - PID 7719 | |5;yui.html;908.2688435809171;908.4413085952139;936.433457758056;936.7517607833926;938.3056538161762;19701;20699.482512937186;20721.481962950915;20753.792462075377;20809.479763005915;16519.66960660789;16582.170891455407;16630.75053874193;16647.084410357427;16650.58373540662;965.5172413793103;967.9370840895336;978.1001478639669;978.2516374973151;980.8871979722352;971.1259866120478;971.1745016735754;972.4602845420789;974.8342781727088;981.5533932060931;983.965561205358;997.6308765756644;1005.2008653120787;1021.8518314844343;1023.4780262066325;1015.2537884654773;1017.0897047142765;1019.1031891935124;1019.8521214423904;1021.8671572695539;714.1465948191913;741.6217728958217;744.326384621918;745.0649434959091;750.6697053296532;20129.295474658462;20207.090680919246;20264.290749823835;20298.18807247708;20315;21533.784662153335;21583.892080539496;22222.11111555536;22293.66559501609;22301.553968920693;16428.507144785675;16629.750553741702;16707.331706731715;16879.24043418049;16880.493585192464;3765.7363984521094;3800.1259710266795;3806.143617686026;3806.6574008339107;3810.1427178884805;102642;139880;140048.59951400457;140953;141823;17823.910880445514;18102.275908963493;18239.817601824077;18335.35826246075;18346;32614.836925815693;32669;32780.508292375634;32786.50820237699;32876.67123328736;8918.464892106365;9213.585388657526;9224.7693807654;9267.25861931044;9405.294602904809;4193.266178418826;4276.294411422143;4291.485021797404;4295.763732994653;4300.032492689183;5632.577556683265;5727.770889164387;5734.827955161351;5739.081746920556;5741.167530708024;1100.4552746390589;1101.146611376174;1120.781447617723;1121.9551217951355;1123.1800785426685;684.6234570985938;695.84343522708;696.4324075878143;713.464901324007;716.5987047253554;11707;12364.690882728004;12498;13544.593662189953;13670.453181872614;681.6659836680091;685.5543896467336;695.7912626212218;699.2448155991517;704.3097764191122;5875.559333050039;5941.31674857397;5950.7917222896995;5960.612560183574;6049.485793707584;124167.37916310542;124904;127026.36486817691;128172;131436.3428182853;108383;111400;112129;112360.43819780849;115455;93909;96207.51896240473;98055.50972245236;98368.50815746018;99028.5048574767;10874.293170943864;10936.726581835199;10941.507632156732;11008.889911100787;11139.10887129044;45288.32067518924;45716.314255285535;45759.77120114378;46246.306305404774;46431.30353044639;57173.14240286316;58713;58800.70599646975;59094.40905590889;59721;15386.307616157075;15447;15631.06213627186;15720.92139539295;15912.283947222171;16839.24223409974;17899.105044747972;17954.371596994042;18039.819601803814;18073.36743213981;15907.840921590636;16061.036337819769;16186.67626647484;16263.837361626705;16301.184940752677;16240.918795405947;16275.918620406823;16361.263743131349;16688;16741.24664390081;15553.84446155524;15845.366185352917;15865.841341586436;15876.285567149736;16026.278817453009;11705.590304339306;11849.940750296193;11993.40032998364;12025.518979240733;12132.211406258564;11575.942120289345;11677.649670509898;11733.237339573241;11941.701457463285;12065.215760975509 03:16:50 INFO - PID 7719 | __end_tp_report 03:16:50 INFO - PID 7719 | __start_cc_report 03:16:50 INFO - PID 7719 | _x_x_mozilla_cycle_collect,272 03:16:50 INFO - PID 7719 | __end_cc_report 03:16:50 INFO - PID 7719 | __startTimestamp1506939410421__endTimestamp 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | ------- Summary: start ------- 03:16:50 INFO - PID 7719 | Number of tests: 6 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#0] dojo.html Cycles:165 Average:6328.33 Median:6603.74 stddev:764.13 (11.6%) stddev-sans-first:725.58 03:16:50 INFO - PID 7719 | Values: 3184.2 3184.5 3220.9 3222.0 3232.1 6293.2 6449.4 6478.6 6500.9 6506.0 6355.5 6377.5 6444.7 6525.1 6544.0 5831.9 5866.8 5964.6 5971.1 5995.7 5889.4 5923.7 5995.1 6032.3 6039.5 5745.6 5828.6 5836.9 5888.6 5890.6 5813.2 5858.2 5861.1 5876.9 5883.7 5779.4 5826.7 5844.5 5855.1 5888.4 6248.6 6372.6 6396.1 6437.8 6470.6 6823.5 6847.2 6940.9 6981.6 6996.2 6933.6 6976.2 6998.4 7057.1 7057.6 6170.4 6390.6 6440.3 6495.7 6502.5 7013.3 7034.4 7046.6 7047.3 7079.0 6622.6 6657.0 6669.7 6722.6 6850.6 6934.0 6945.3 6947.3 6963.6 6978.1 6823.6 6829.8 6832.7 6893.6 6905.0 6639.2 6800.7 6870.1 6884.6 6965.0 5422.8 5432.2 5437.9 5440.1 5440.6 4682.2 4760.0 4773.4 4789.9 4795.0 5861.4 5872.0 5888.3 5956.9 5960.2 6966.8 6979.5 6981.4 6988.2 6999.3 5894.7 5943.9 5954.4 5958.6 5959.0 5883.3 5898.6 5961.0 5977.6 5998.3 6515.2 6515.2 6550.1 6656.0 6754.5 6920.9 6936.4 6941.5 6968.6 6979.1 6635.4 6642.8 6709.5 6716.5 6723.6 6769.0 6774.2 6774.6 6863.6 6871.8 6799.3 6884.5 6902.9 6909.7 6998.1 6617.2 6624.6 6627.5 6629.1 6629.5 6521.9 6627.8 6665.2 6769.6 6791.4 6623.6 6634.9 6698.0 6709.6 6717.3 6768.5 6772.5 6789.9 6855.2 6857.4 6331.4 6435.4 6477.5 6603.7 6626.6 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#1] ext.html Cycles:180 Average:37644.72 Median:3510.30 stddev:53122.64 (1513.3%) stddev-sans-first:53199.89 03:16:50 INFO - PID 7719 | Values: 870.3 879.5 896.5 919.5 922.4 40198.2 40902.6 40975.0 41614.0 41667.0 41384.2 41565.6 41656.6 41691.0 41694.8 7925.4 8069.9 8071.5 8081.3 8083.0 7953.0 7962.6 8042.8 8052.4 8054.5 8037.2 8070.7 8082.9 8085.9 8097.7 7967.4 8000.2 8001.7 8031.9 8040.6 7845.4 7875.6 7903.0 7937.3 7939.5 36378.5 36826.6 36833.6 36834.0 36931.6 3475.6 3508.8 3511.8 3512.7 3512.8 31020.4 31025.0 31104.7 31146.8 31176.4 4998.6 5108.0 5121.4 5155.5 5180.2 186580.0 189424.1 189750.0 190097.0 190179.0 47187.8 47263.8 47482.5 47649.8 47748.3 57648.7 57766.7 58548.0 58560.4 58561.7 15529.7 15532.3 15573.7 15658.6 15665.2 11676.9 11863.2 11911.1 11912.9 11945.8 15108.9 15176.3 15291.5 15335.5 15480.1 5972.9 6018.5 6043.5 6088.0 6088.2 1012.5 1026.3 1026.4 1026.9 1027.5 22770.4 23015.8 23099.4 23305.7 23595.6 1111.8 1113.7 1116.9 1122.9 1122.9 12252.0 12493.3 12560.9 12662.0 12711.4 229345.0 229413.0 229429.0 232446.0 237134.0 56394.2 56844.0 57088.0 57111.0 57217.7 1404.6 1441.7 1458.9 1461.1 1465.2 26521.7 26616.0 26773.7 26795.6 26949.0 35989.6 36224.5 36323.5 36331.0 36335.3 190046.0 190708.6 190944.0 191116.0 192701.0 33469.2 34619.5 34879.0 35031.0 35144.8 41414.6 42719.4 42803.0 42806.8 42851.4 31103.4 31771.2 31810.0 31907.8 32164.2 30405.2 30427.5 30511.4 30802.0 30960.2 35639.6 35655.0 35675.1 35705.3 35898.8 30624.0 30739.5 30761.4 31221.7 31631.7 23088.3 23129.4 23302.3 23587.6 23851.4 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#2] jquery.html Cycles:180 Average:34952.86 Median:23534.27 stddev:82270.53 (349.6%) stddev-sans-first:82460.87 03:16:50 INFO - PID 7719 | Values: 591.6 596.3 601.3 608.9 609.2 22312.2 23046.3 23086.9 23109.2 23150.4 24875.8 25259.7 26417.6 26699.7 26777.0 6762.2 6948.0 6950.0 6953.6 6953.7 5941.9 6185.7 6209.5 6772.2 6887.1 6179.6 6191.5 6202.5 6211.4 6212.5 6187.2 6194.1 6206.7 6213.3 6429.8 5992.0 6007.5 6013.2 6017.2 6019.9 29903.3 30423.1 30434.7 30466.8 30472.4 2092.2 2111.9 2116.8 2117.9 2118.5 18472.4 18600.5 18602.4 19078.7 20558.2 2431.5 2449.3 2492.6 2500.4 2510.5 118049.0 122504.4 123626.0 140525.0 147204.0 15121.4 15142.5 15351.7 15498.5 15929.8 24345.4 24446.3 24462.6 24481.9 24638.1 10339.6 10426.6 10477.9 10482.7 10520.4 9571.8 9638.7 9645.6 9680.4 9770.7 9283.3 9366.2 9519.0 9535.9 9624.8 2670.6 2738.9 2779.0 2828.4 2831.8 942.5 967.2 969.4 969.9 975.8 19963.4 19970.0 20014.7 20247.0 20297.1 1021.5 1034.3 1041.4 1043.8 1053.9 11046.7 11072.3 11111.6 11182.3 11191.6 464505.0 472562.0 500745.0 503556.0 503996.0 117438.4 117520.0 120459.4 121572.4 121855.4 1042.0 1102.6 1156.1 1156.4 1209.7 21255.8 21599.5 21753.0 21835.3 21842.6 54743.0 55376.4 55749.4 56767.0 57575.7 69216.7 69390.0 70238.0 70283.0 71072.0 14958.3 14973.8 14999.2 15259.8 15290.9 23350.5 23718.0 23782.2 23877.0 23939.3 19085.8 19146.4 19267.7 19524.2 19529.2 17190.1 17205.6 17315.7 17762.6 17932.8 18982.6 19517.5 19656.6 19807.4 19864.2 14998.0 15080.2 15130.8 15130.8 15131.8 19047.9 19086.2 19144.3 19269.3 19271.0 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#3] mootools.html Cycles:180 Average:8932.64 Median:2698.44 stddev:6084.04 (225.5%) stddev-sans-first:6074.36 03:16:50 INFO - PID 7719 | Values: 1341.3 1414.6 1424.4 1428.0 1429.8 14533.8 15159.7 15172.8 15193.3 15197.1 14663.2 14700.8 14731.3 14777.7 14799.9 2651.8 2772.3 2782.8 2783.4 2785.7 2747.9 2797.5 2800.8 2807.8 2810.5 2631.0 2830.0 2844.1 2845.6 2847.8 2648.3 2693.6 2697.4 2715.6 2720.7 2686.6 2699.5 2730.9 2839.5 2851.5 14198.6 14237.2 14309.6 14354.4 14386.4 7850.2 8129.6 8136.5 8139.2 8189.7 5399.7 5404.0 5478.2 5588.7 5680.1 1879.5 1886.8 1888.6 1907.3 1911.5 21840.6 22075.2 22094.9 22124.7 22141.6 6598.2 6757.4 6836.9 6984.4 6999.5 15979.9 16392.8 16400.8 16988.2 17118.4 7526.7 7714.0 7722.4 7722.5 7727.0 7042.7 7113.5 7133.7 7137.6 7178.5 5212.2 5314.8 5349.5 5366.8 5384.4 1516.4 1520.9 1528.0 1531.1 1533.8 896.9 902.4 924.0 924.4 932.9 7601.9 7610.9 7684.8 7685.3 7713.2 721.3 745.8 748.7 753.3 762.0 4890.8 5254.4 5340.1 5359.3 5441.3 20356.7 20373.2 20787.9 21129.9 21236.3 19227.2 19672.6 20124.2 20139.4 20160.1 10796.8 10805.7 10963.2 10979.5 10981.7 8157.3 8209.7 8247.5 8259.0 8430.6 17354.0 17612.6 17830.1 17933.9 18275.8 17513.1 17814.2 17835.6 17870.6 18076.5 10694.1 10712.0 10788.4 10814.8 10879.8 13073.7 13262.1 13278.0 13286.4 13319.8 11262.4 11314.3 11332.4 11399.2 11502.8 10752.0 10786.3 10869.4 10996.5 11192.9 9208.4 9358.3 9360.4 9373.1 9373.8 6896.1 6912.6 6947.2 6971.3 7009.4 6977.8 7018.5 7047.7 7112.6 7187.2 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#4] prototype.html Cycles:180 Average:5610.06 Median:6318.65 stddev:1550.23 (24.5%) stddev-sans-first:1506.54 03:16:50 INFO - PID 7719 | Values: 508.5 535.2 538.3 539.9 542.6 6422.9 6436.6 6456.5 6516.0 6539.3 6298.9 6307.9 6339.7 6355.4 6389.7 5293.9 5300.3 5307.3 5318.0 5339.2 5295.5 5316.1 5334.9 5346.5 5378.0 4958.3 5125.7 5128.9 5135.2 5156.7 5071.0 5120.8 5128.3 5136.2 5144.4 4589.8 4598.2 4602.9 4628.0 4644.9 6224.5 6265.4 6305.7 6329.4 6365.8 5867.1 5869.8 5920.4 5925.8 5927.7 6589.9 6650.7 6676.4 6725.7 6730.2 4980.7 4984.0 4986.7 4989.4 5035.5 6724.6 6824.0 6891.6 6916.3 7025.6 5085.3 5119.2 5119.8 5142.2 5184.5 5143.3 5154.0 5179.3 5198.1 5274.3 5745.5 5775.4 5827.8 5869.0 5869.1 6661.0 6668.9 6682.0 6724.4 6786.0 1771.7 1802.7 1809.8 1811.0 1837.1 1172.4 1235.8 1238.4 1245.6 1270.9 5677.6 5744.6 5768.5 5854.8 5862.6 6609.0 6714.6 6823.7 6843.5 6849.2 5630.6 5639.9 5674.2 5691.4 5732.0 3565.7 3600.2 3617.2 3626.4 3635.9 6169.5 6469.8 6509.1 6551.4 6614.9 6824.8 6834.4 6850.1 6867.0 6982.9 6497.2 6500.7 6536.2 6543.5 6601.5 6723.3 6797.6 6842.1 6846.7 6857.1 6811.8 6811.9 6814.8 6816.6 6833.8 6554.3 6571.3 6609.5 6610.2 6624.8 5098.2 5099.0 5147.8 5149.8 5166.4 6497.4 6617.4 6629.9 6710.7 6745.4 6486.4 6538.3 6609.9 6637.6 6666.9 6415.3 6541.5 6543.0 6558.1 6583.3 6509.3 6526.9 6552.2 6585.7 6602.7 6555.7 6587.4 6699.2 6703.3 6717.9 6436.0 6475.0 6475.6 6492.2 6546.4 03:16:50 INFO - PID 7719 | 03:16:50 INFO - PID 7719 | [#5] yui.html Cycles:180 Average:24645.57 Median:20235.69 stddev:35509.74 (175.5%) stddev-sans-first:35564.62 03:16:50 INFO - PID 7719 | Values: 908.3 908.4 936.4 936.8 938.3 19701.0 20699.5 20721.5 20753.8 20809.5 16519.7 16582.2 16630.8 16647.1 16650.6 965.5 967.9 978.1 978.3 980.9 971.1 971.2 972.5 974.8 981.6 984.0 997.6 1005.2 1021.9 1023.5 1015.3 1017.1 1019.1 1019.9 1021.9 714.1 741.6 744.3 745.1 750.7 20129.3 20207.1 20264.3 20298.2 20315.0 21533.8 21583.9 22222.1 22293.7 22301.6 16428.5 16629.8 16707.3 16879.2 16880.5 3765.7 3800.1 3806.1 3806.7 3810.1 102642.0 139880.0 140048.6 140953.0 141823.0 17823.9 18102.3 18239.8 18335.4 18346.0 32614.8 32669.0 32780.5 32786.5 32876.7 8918.5 9213.6 9224.8 9267.3 9405.3 4193.3 4276.3 4291.5 4295.8 4300.0 5632.6 5727.8 5734.8 5739.1 5741.2 1100.5 1101.1 1120.8 1122.0 1123.2 684.6 695.8 696.4 713.5 716.6 11707.0 12364.7 12498.0 13544.6 13670.5 681.7 685.6 695.8 699.2 704.3 5875.6 5941.3 5950.8 5960.6 6049.5 124167.4 124904.0 127026.4 128172.0 131436.3 108383.0 111400.0 112129.0 112360.4 115455.0 93909.0 96207.5 98055.5 98368.5 99028.5 10874.3 10936.7 10941.5 11008.9 11139.1 45288.3 45716.3 45759.8 46246.3 46431.3 57173.1 58713.0 58800.7 59094.4 59721.0 15386.3 15447.0 15631.1 15720.9 15912.3 16839.2 17899.1 17954.4 18039.8 18073.4 15907.8 16061.0 16186.7 16263.8 16301.2 16240.9 16275.9 16361.3 16688.0 16741.2 15553.8 15845.4 15865.8 15876.3 16026.3 11705.6 11849.9 11993.4 12025.5 12132.2 11575.9 11677.6 11733.2 11941.7 12065.2 03:16:50 INFO - PID 7719 | -------- Summary: end -------- 03:16:50 INFO - PID 7719 | 03:16:50 INFO - TEST-INFO | 7719: exit 0 03:16:50 INFO - TEST-OK | dromaeo_css | took 1109605ms 03:16:50 INFO - TEST-START | kraken 03:16:50 INFO - Initialising browser for kraken test... 03:16:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35970/getInfo.html -profile /tmp/tmpaQp4ae/profile 03:16:50 INFO - TEST-INFO | started process 8081 (/builds/slave/test/build/application/firefox/firefox http://localhost:35970/getInfo.html) 03:16:56 INFO - TEST-INFO | 8081: exit 0 03:16:56 INFO - Browser initialized. 03:16:56 INFO - Running cycle 1/1 for kraken test... 03:16:56 INFO - Using env: {'DISPLAY': ':0', 03:16:56 INFO - 'HOME': '/home/cltbld', 03:16:56 INFO - 'JSGC_DISABLE_POISONING': '1', 03:16:56 INFO - 'LANG': 'en_US.UTF-8', 03:16:56 INFO - 'LANGUAGE': 'en_US:en', 03:16:56 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:16:56 INFO - 'LOGNAME': 'cltbld', 03:16:56 INFO - 'MAIL': '/var/mail/cltbld', 03:16:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:16:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:16:56 INFO - 'MOZ_CRASHREPORTER': '1', 03:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:16:56 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:16:56 INFO - 'MOZ_NO_REMOTE': '1', 03:16:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:16:56 INFO - 'NO_EM_RESTART': '1', 03:16:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:16:56 INFO - 'PWD': '/builds/slave/test', 03:16:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:16:56 INFO - 'RUST_BACKTRACE': 'full', 03:16:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:16:56 INFO - 'SHELL': '/bin/bash', 03:16:56 INFO - 'SHLVL': '1', 03:16:56 INFO - 'STYLO_FORCE_DISABLED': '1', 03:16:56 INFO - 'TERM': 'linux', 03:16:56 INFO - 'TMOUT': '86400', 03:16:56 INFO - 'USER': 'cltbld', 03:16:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052', 03:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:16:56 INFO - '_': '/tools/buildbot/bin/python'} 03:16:56 INFO - TEST-INFO | started process 8316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaQp4ae/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:57 INFO - PID 8316 | 03:16:57 INFO - PID 8316 | (/builds/slave/test/build/application/firefox/firefox:8365): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:16:57 INFO - PID 8316 | 03:17:07 INFO - PID 8316 | RSS: Main: 151453696 03:17:07 INFO - PID 8316 | 03:17:10 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35970/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:11 INFO - PID 8316 | RSS: Main: 158674944 03:17:11 INFO - PID 8316 | 03:17:13 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35970/tests/kraken/driver.html?testName=audio-dft) 03:17:14 INFO - PID 8316 | RSS: Main: 158908416 03:17:14 INFO - PID 8316 | 03:17:17 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35970/tests/kraken/driver.html?testName=audio-fft) 03:17:18 INFO - PID 8316 | RSS: Main: 155488256 03:17:18 INFO - PID 8316 | 03:17:20 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35970/tests/kraken/driver.html?testName=audio-oscillator) 03:17:20 INFO - PID 8316 | RSS: Main: 155226112 03:17:20 INFO - PID 8316 | 03:17:22 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35970/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:23 INFO - PID 8316 | RSS: Main: 155201536 03:17:23 INFO - PID 8316 | 03:17:26 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35970/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:27 INFO - PID 8316 | RSS: Main: 158322688 03:17:27 INFO - PID 8316 | 03:17:30 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35970/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:31 INFO - PID 8316 | RSS: Main: 159006720 03:17:31 INFO - PID 8316 | 03:17:34 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35970/tests/kraken/driver.html?testName=json-parse-financial) 03:17:35 INFO - PID 8316 | RSS: Main: 158384128 03:17:35 INFO - PID 8316 | 03:17:36 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35970/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:37 INFO - PID 8316 | RSS: Main: 158248960 03:17:37 INFO - PID 8316 | 03:17:38 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:39 INFO - PID 8316 | RSS: Main: 158306304 03:17:39 INFO - PID 8316 | 03:17:41 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:42 INFO - PID 8316 | RSS: Main: 155385856 03:17:42 INFO - PID 8316 | 03:17:44 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:45 INFO - PID 8316 | RSS: Main: 155136000 03:17:45 INFO - PID 8316 | 03:17:48 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:48 INFO - PID 8316 | RSS: Main: 155545600 03:17:48 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | Cycle 1(1): loaded http://localhost:35970/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35970/tests/kraken/driver.html?testName=ai-astar) 03:17:50 INFO - PID 8316 | RSS: Main: 156274688 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | __start_tp_report 03:17:50 INFO - PID 8316 | _x_x_mozilla_page_load 03:17:50 INFO - PID 8316 | _x_x_mozilla_page_load_details 03:17:50 INFO - PID 8316 | |i|pagename|runs| 03:17:50 INFO - PID 8316 | |0;ai-astar;107;107;105;107;110;106;107;107;107;110 03:17:50 INFO - PID 8316 | |1;audio-beat-detection;119;114;116;142;116;119;116;118;139;117 03:17:50 INFO - PID 8316 | |2;audio-dft;167;162;164;163;162;162;163;164;168;165 03:17:50 INFO - PID 8316 | |3;audio-fft;75;73;74;74;78;75;73;73;74;75 03:17:50 INFO - PID 8316 | |4;audio-oscillator;80;79;78;79;79;80;79;79;85;78 03:17:50 INFO - PID 8316 | |5;imaging-gaussian-blur;117;111;112;113;111;111;110;110;111;112 03:17:50 INFO - PID 8316 | |6;imaging-darkroom;149;149;148;149;149;149;149;148;150;149 03:17:50 INFO - PID 8316 | |7;imaging-desaturate;99;98;94;98;98;94;95;98;94;94 03:17:50 INFO - PID 8316 | |8;json-parse-financial;51;52;52;53;53;51;52;51;51;49 03:17:50 INFO - PID 8316 | |9;json-stringify-tinderbox;37;37;37;36;36;37;37;37;37;37 03:17:50 INFO - PID 8316 | |10;stanford-crypto-aes;73;80;78;76;80;72;74;79;75;78 03:17:50 INFO - PID 8316 | |11;stanford-crypto-ccm;108;106;114;112;114;109;111;118;111;117 03:17:50 INFO - PID 8316 | |12;stanford-crypto-pbkdf2;166;165;173;171;165;169;169;161;161;161 03:17:50 INFO - PID 8316 | |13;stanford-crypto-sha256-iterative;64;69;65;64;63;65;67;64;64;64 03:17:50 INFO - PID 8316 | __end_tp_report 03:17:50 INFO - PID 8316 | __start_cc_report 03:17:50 INFO - PID 8316 | _x_x_mozilla_cycle_collect,765 03:17:50 INFO - PID 8316 | __end_cc_report 03:17:50 INFO - PID 8316 | __startTimestamp1506939470973__endTimestamp 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | ------- Summary: start ------- 03:17:50 INFO - PID 8316 | Number of tests: 14 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.00 stddev:1.57 (1.5%) stddev-sans-first:1.66 03:17:50 INFO - PID 8316 | Values: 107.0 107.0 105.0 107.0 110.0 106.0 107.0 107.0 107.0 110.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#1] audio-beat-detection Cycles:10 Average:121.60 Median:118.50 stddev:10.10 (8.5%) stddev-sans-first:10.67 03:17:50 INFO - PID 8316 | Values: 119.0 114.0 116.0 142.0 116.0 119.0 116.0 118.0 139.0 117.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#2] audio-dft Cycles:10 Average:164.00 Median:164.00 stddev:2.11 (1.3%) stddev-sans-first:1.94 03:17:50 INFO - PID 8316 | Values: 167.0 162.0 164.0 163.0 162.0 162.0 163.0 164.0 168.0 165.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#3] audio-fft Cycles:10 Average:74.40 Median:74.50 stddev:1.51 (2.0%) stddev-sans-first:1.58 03:17:50 INFO - PID 8316 | Values: 75.0 73.0 74.0 74.0 78.0 75.0 73.0 73.0 74.0 75.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#4] audio-oscillator Cycles:10 Average:79.60 Median:79.00 stddev:2.01 (2.5%) stddev-sans-first:2.13 03:17:50 INFO - PID 8316 | Values: 80.0 79.0 78.0 79.0 79.0 80.0 79.0 79.0 85.0 78.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#5] imaging-gaussian-blur Cycles:10 Average:111.80 Median:111.50 stddev:2.04 (1.8%) stddev-sans-first:0.97 03:17:50 INFO - PID 8316 | Values: 117.0 111.0 112.0 113.0 111.0 111.0 110.0 110.0 111.0 112.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 03:17:50 INFO - PID 8316 | Values: 149.0 149.0 148.0 149.0 149.0 149.0 149.0 148.0 150.0 149.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:98.00 stddev:2.15 (2.2%) stddev-sans-first:2.03 03:17:50 INFO - PID 8316 | Values: 99.0 98.0 94.0 98.0 98.0 94.0 95.0 98.0 94.0 94.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#8] json-parse-financial Cycles:10 Average:51.50 Median:52.00 stddev:1.18 (2.3%) stddev-sans-first:1.24 03:17:50 INFO - PID 8316 | Values: 51.0 52.0 52.0 53.0 53.0 51.0 52.0 51.0 51.0 49.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#9] json-stringify-tinderbox Cycles:10 Average:36.80 Median:37.00 stddev:0.42 (1.1%) stddev-sans-first:0.44 03:17:50 INFO - PID 8316 | Values: 37.0 37.0 37.0 36.0 36.0 37.0 37.0 37.0 37.0 37.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:78.00 stddev:2.92 (3.7%) stddev-sans-first:2.80 03:17:50 INFO - PID 8316 | Values: 73.0 80.0 78.0 76.0 80.0 72.0 74.0 79.0 75.0 78.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#11] stanford-crypto-ccm Cycles:10 Average:112.00 Median:113.00 stddev:3.83 (3.4%) stddev-sans-first:3.78 03:17:50 INFO - PID 8316 | Values: 108.0 106.0 114.0 112.0 114.0 109.0 111.0 118.0 111.0 117.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:167.50 stddev:4.33 (2.6%) stddev-sans-first:4.59 03:17:50 INFO - PID 8316 | Values: 166.0 165.0 173.0 171.0 165.0 169.0 169.0 161.0 161.0 161.0 03:17:50 INFO - PID 8316 | 03:17:50 INFO - PID 8316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:1.79 (2.8%) stddev-sans-first:1.87 03:17:50 INFO - PID 8316 | Values: 64.0 69.0 65.0 64.0 63.0 65.0 67.0 64.0 64.0 64.0 03:17:50 INFO - PID 8316 | -------- Summary: end -------- 03:17:50 INFO - PID 8316 | 03:17:51 INFO - PID 8316 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:17:51 INFO - TEST-INFO | 8316: exit 0 03:17:51 INFO - TEST-OK | kraken | took 60664ms 03:17:51 INFO - SUITE-END | took 1170s 03:17:51 INFO - Completed test suite (00:19:30) 03:17:51 INFO - javascript benchmark 03:17:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8595.245863220038, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3184.172115250035, 3184.474561697319, 3220.8872689455875, 3221.9850747014675, 3232.1273256220807, 6293.150424692665, 6449.419552240297, 6478.611283322998, 6500.902486462701, 6506.0, 6355.5233357498255, 6377.521685873567, 6444.677766111688, 6525.086487891699, 6544.0, 5831.854203644901, 5866.794662186824, 5964.612300200484, 5971.134185543094, 5995.700214989255, 5889.440503152194, 5923.703814809264, 5995.100734889779, 6032.306284777241, 6039.486643635274, 5745.626534275259, 5828.621139625953, 5836.941630583682, 5888.64668119912, 5890.5582081343855, 5813.157092221646, 5858.179854820329, 5861.062230043172, 5876.911846322266, 5883.735231914574, 5779.3642699303045, 5826.650400975955, 5844.503217226498, 5855.121731740231, 5888.411158884121, 6248.593841400339, 6372.553921225516, 6396.072569477446, 6437.806865794034, 6470.57941233823, 6823.488238382141, 6847.1783385994, 6940.895886561706, 6981.581105133658, 6996.195437524699, 6933.618650974195, 6976.162860456778, 6998.440124790005, 7057.082579264663, 7057.576545407292, 6170.413810687977, 6390.616563006234, 6440.323766004549, 6495.707693153772, 6502.479801615859, 7013.2986701329455, 7034.40207582351, 7046.612436316052, 7047.295270473014, 7078.964605177044, 6622.63575503352, 6657.0, 6669.666516674147, 6722.596644201363, 6850.623215723183, 6934.029235906977, 6945.2707465715375, 6947.305269473113, 6963.582185068912, 6978.057962175041, 6823.624700641512, 6829.795106146824, 6832.726690932307, 6893.586384816927, 6905.033295338657, 6639.236487803964, 6800.65996700163, 6870.072540207108, 6884.586924784529, 6964.965175174092, 5422.810201642924, 5432.239486471897, 5437.864053398696, 5440.102383106743, 5440.646357986719, 4682.157211701926, 4760.0, 4773.427188737373, 4789.928151077736, 4795.040991801584, 5861.384554621789, 5871.970640146772, 5888.263967004124, 5956.910646340309, 5960.225170727865, 6966.825829354307, 6979.546329488567, 6981.406580440618, 6988.19635741886, 6999.30006999296, 5894.67579283135, 5943.910841337383, 5954.374790647006, 5958.612690175125, 5959.016762234182, 5883.294004719461, 5898.557608179403, 5961.0, 5977.551683623746, 5998.25021872266, 6515.153030106056, 6515.185601799775, 6550.148480697479, 6656.034874943203, 6754.493412994045, 6920.8961865573065, 6936.445084393337, 6941.548799328028, 6968.616726080114, 6979.057827193264, 6635.402813746786, 6642.767503137367, 6709.496787740842, 6716.529842910949, 6723.596584204964, 6768.9661551691925, 6774.153230846145, 6774.593524388552, 6863.588184708734, 6871.759488417882, 6799.252082271045, 6884.51808373409, 6902.930970690229, 6909.654517274217, 6998.090248267693, 6617.205935287796, 6624.56940298879, 6627.502937279627, 6629.105070815378, 6629.502787291069, 6521.869562608626, 6627.801165965029, 6665.166854143232, 6769.559978601375, 6791.3548212919695, 6623.635700036544, 6634.867302654016, 6698.028785826125, 6709.630970296681, 6717.261101278953, 6768.492363072691, 6772.492063095386, 6789.89815152783, 6855.245922948372, 6857.382835544626, 6331.398517140864, 6435.356464353715, 6477.481801455967, 6603.735850565923, 6626.602403855784], "value": 6269.680833910499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [870.2726223584385, 879.49993329903, 896.4621227263642, 919.4804935211607, 922.3773952582002, 40198.19603607926, 40902.59097409025, 40974.9756256093, 41614.0, 41667.0, 41384.17231655365, 41565.58434415655, 41656.58343416565, 41691.0, 41694.791526042325, 7925.405594580401, 8069.919300806975, 8071.515709057446, 8081.272685458308, 8082.959585202066, 7953.0, 7962.6416811243635, 8042.798930026737, 8052.355811535063, 8054.476459030174, 8037.196280371974, 8070.71752488663, 8082.878756818623, 8085.878711819328, 8097.716579919704, 7967.402444816604, 8000.199980001982, 8001.7199398021085, 8031.879521807177, 8040.597970101471, 7845.37237021037, 7875.6062196889925, 7903.0, 7937.285644292041, 7939.483933544301, 36378.45432318517, 36826.63173368259, 36833.631663683555, 36834.0, 36931.63068369309, 3475.6350583188905, 3508.7543871928974, 3511.841967111486, 3512.666296701809, 3512.8067956262394, 31020.37959240825, 31025.0, 31104.688953110406, 31146.844265778753, 31176.376472470423, 4998.550130488237, 5107.974460127675, 5121.436641969381, 5155.458676838915, 5180.222966555047, 186580.0, 189424.0528797361, 189750.0, 190097.0, 190179.0, 47187.76406117948, 47263.76368118137, 47482.52517474781, 47649.76175119171, 47748.28377574339, 57648.71175644095, 57766.71116644474, 58548.0, 58560.4143958555, 58561.70719146462, 15529.68940621204, 15532.301046452936, 15573.688526229413, 15658.608534786494, 15665.216739162996, 11676.941615292038, 11863.228890122115, 11911.10666700001, 11912.880871191177, 11945.761084778256, 15108.924455377872, 15176.317065732068, 15291.464798731991, 15335.539933802003, 15480.148591827332, 5972.85067873298, 6018.458338749533, 6043.516518678495, 6087.96956015226, 6088.238970128734, 1012.5089331674133, 1026.2764750850633, 1026.3636545341787, 1026.90757831794, 1027.4862568715641, 22770.43073923165, 23015.769842301364, 23099.422514436937, 23305.650415243785, 23595.646065309033, 1111.8499002634542, 1113.6826004588654, 1116.8771435142128, 1122.865256169265, 1122.927009744364, 12252.039673652172, 12493.250404975548, 12560.874391255971, 12662.0, 12711.364431778375, 229345.0, 229413.0, 229429.0, 232446.0, 237134.0, 56394.154087688716, 56844.0, 57088.0, 57111.0, 57217.713911430175, 1404.5505438259659, 1441.654003039284, 1458.912465252067, 1461.1306272767686, 1465.2014652014677, 26521.734782652697, 26616.0, 26773.732262677124, 26795.598066029415, 26949.0, 35989.640103599675, 36224.456633149995, 36323.45514817333, 36331.0, 36335.27329453449, 190046.0, 190708.55748655126, 190944.0, 191116.0, 192701.0, 33469.16327091842, 34619.48070778991, 34879.0, 35031.0, 35144.824275878455, 41414.58585414107, 42719.35920961126, 42803.0, 42806.78596606997, 42851.357229640955, 31103.377932441676, 31771.20571985719, 31810.0, 31907.840460798478, 32164.19589510281, 30405.239869003453, 30427.54358684577, 30511.389772204875, 30802.0, 30960.22599434942, 35639.64360356363, 35655.0, 35675.10812229715, 35705.28589428249, 35898.8205058973, 30624.0, 30739.53890691597, 30761.384772304875, 31221.687783121877, 31631.683683163796, 23088.307350779505, 23129.421764456023, 23302.3009309721, 23587.646185307578, 23851.403714907265], "value": 17339.376603632336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.6065816232206, 596.2695697770232, 601.3265143039795, 608.8873558391695, 609.1532769450465, 22312.21907233247, 23046.308610741664, 23086.88456557719, 23109.19117830874, 23150.421239469, 24875.75124248757, 25259.74740252597, 26417.60373594393, 26699.733002669967, 26777.0, 6762.222344430392, 6948.0272761813385, 6949.965250173742, 6953.582785032889, 6953.652317384136, 5941.88116237675, 6185.690715464231, 6209.5032397408095, 6772.187337519505, 6887.070245516841, 6179.629222246657, 6191.504679625642, 6202.534809889254, 6211.440970312671, 6212.534059945499, 6187.195664563623, 6194.132821405007, 6206.6586337751405, 6213.316535181127, 6429.8392540186405, 5991.970040149771, 6007.489363404072, 6013.248343957005, 6017.157597936292, 6019.909701354483, 29903.252418689488, 30423.087307380814, 30434.695653043407, 30466.84766576175, 30472.390552188834, 2092.184048221195, 2111.8944052797297, 2116.8094871461644, 2117.9364619061453, 2118.470382404399, 18472.445826625222, 18600.53498662531, 18602.44192674222, 19078.713819292723, 20558.177672893067, 2431.477232395026, 2449.2774631483753, 2492.6011838105815, 2500.362407586054, 2510.497900419905, 118049.0, 122504.38747806204, 123626.0, 140525.0, 147204.0, 15121.412251713631, 15142.470013549693, 15351.692966140838, 15498.5350439487, 15929.840701593068, 24345.391365215655, 24446.26661200167, 24462.633060504108, 24481.877590611934, 24638.13766518163, 10339.63811266602, 10426.635067772591, 10477.895221047844, 10482.737931551772, 10520.368777873353, 9571.760705982406, 9638.710838674851, 9645.614175433044, 9680.419174849532, 9770.658026969022, 9283.25733941283, 9366.203872670763, 9518.95240523793, 9535.856962145574, 9624.75938101539, 2670.5593577059567, 2738.904138355148, 2779.027340430833, 2828.3918957424253, 2831.80177387585, 942.5240253671852, 967.1972263021676, 969.3956501989219, 969.8742147749113, 975.8097171051719, 19963.401097967086, 19970.0, 20014.69977950332, 20247.0, 20297.086631101636, 1021.5147804792664, 1034.2760067952463, 1041.390786389955, 1043.76515284062, 1053.931494452858, 11046.723831904266, 11072.280301780358, 11111.611093611846, 11182.273152245078, 11191.608293709682, 464505.0, 472562.0, 500745.0, 503556.0, 503996.0, 117438.41280793713, 117520.0, 120459.39770301092, 121572.39213804051, 121855.39072304581, 1041.9947900260602, 1102.6306187427301, 1156.0982433701727, 1156.4333476596576, 1209.6975756060808, 21255.797217335457, 21599.46001349979, 21753.0, 21835.253179745265, 21842.563148737256, 54743.0, 55376.446235538744, 55749.44250557443, 56767.0, 57575.71212143912, 69216.6539167301, 69390.0, 70238.0, 70283.0, 71072.0, 14958.252087395369, 14973.802095832525, 14999.175045372609, 15259.771103433235, 15290.923545382648, 23350.53298933978, 23718.0, 23782.16762413307, 23877.0, 23939.28182154538, 19085.809141908958, 19146.425607231806, 19267.710984334964, 19524.21903123859, 19529.21883124659, 17190.054547000036, 17205.56986075358, 17315.653686926442, 17762.644747105245, 17932.820671793113, 18982.620347592696, 19517.51206219856, 19656.606867862276, 19807.405777826687, 19864.205431782568, 14998.0, 15080.170590617183, 15130.773038404213, 15130.848691512943, 15131.848681513044, 19047.904760476664, 19086.23655053838, 19144.329948451737, 19269.325573604856, 19271.0], "value": 12194.676860902322, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1341.2824139085587, 1414.5614859393588, 1424.3661570601084, 1427.9571612851619, 1429.7640889253273, 14533.781993270097, 15159.696806063886, 15172.848271517296, 15193.316300766464, 15197.088174709525, 14663.193524356157, 14700.779488307684, 14731.337089830957, 14777.704445911075, 14799.926000369984, 2651.761341479262, 2772.3207814085577, 2782.833030018195, 2783.3876547159593, 2785.7492825645686, 2747.8900843966317, 2797.496450638884, 2800.8179468334597, 2807.7753779697573, 2810.4800611886867, 2631.0, 2829.985850070747, 2844.1183233197776, 2845.5873898284735, 2847.800653954224, 2648.2982009767234, 2693.5555633320478, 2697.393086555529, 2715.6198132261497, 2720.7143249958767, 2686.637303963979, 2699.4870974514974, 2730.931726706828, 2839.54567269238, 2851.4867323881695, 14198.574042778733, 14237.216953067576, 14309.57071287863, 14354.354054067591, 14386.35261413239, 7850.175731548219, 8129.634166462523, 8136.511809291403, 8139.226773456512, 8189.71336003243, 5399.730013499348, 5404.0, 5478.150886612581, 5588.720563971826, 5680.147977803321, 1879.4831421359236, 1886.8396186324178, 1888.5656299051159, 1907.265702704455, 1911.5030092175996, 21840.563188736138, 22075.227367042076, 22094.88952555227, 22124.6681299779, 22141.557168856532, 6598.241202261801, 6757.391834734897, 6836.863262734817, 6984.406325462291, 6999.545029573062, 15979.920100399657, 16392.75410868838, 16400.835991640168, 16988.235529401205, 17118.40085597023, 7526.661300241502, 7713.961430192813, 7722.42081843864, 7722.45942784011, 7727.0, 7042.6830792614455, 7113.502054856111, 7133.678984445713, 7137.607431591208, 7178.533395329287, 5212.244224587414, 5314.7608357624, 5349.491798279158, 5366.758495867695, 5384.353877534721, 1516.3555488917166, 1520.9163496007825, 1527.9847201528064, 1531.111955066059, 1533.7776022476678, 896.8878890138733, 902.3638334973828, 923.9538023098818, 924.4222361024359, 932.9253659707207, 7601.885971710429, 7610.9238907611325, 7684.807879803049, 7685.269899359552, 7713.190115037953, 721.2967356827156, 745.8023623739713, 748.7341993592305, 753.3069575990103, 762.0360244290977, 4890.82882099132, 5254.395744489356, 5340.118880384693, 5359.276497672842, 5441.319835020622, 20356.69464958027, 20373.185072597225, 20787.896060519903, 21129.89435052815, 21236.25673101434, 19227.230910763694, 19672.606547868963, 20124.19503219855, 20139.39581812548, 20160.092795824225, 10796.838047429295, 10805.729856753644, 10963.177761667748, 10979.451027448597, 10981.670549883516, 8157.265846073882, 8209.71266005687, 8247.505149691038, 8258.958705206436, 8430.620622072143, 17354.04552749611, 17612.55968600744, 17830.108494575477, 17933.910330448263, 18275.81724182741, 17513.124343782503, 17814.198361074043, 17835.554111147325, 17870.642587147926, 18076.457706268833, 10694.144468442662, 10712.0, 10788.352698838095, 10814.837777433502, 10879.836802448128, 13073.738525229632, 13262.071654984058, 13278.0, 13286.402111904794, 13319.800202997156, 11262.38056906878, 11314.264572802742, 11332.433378331216, 11399.20205585601, 11502.82745758831, 10752.0, 10786.298890572089, 10869.402182880018, 10996.450177491253, 11192.944035279772, 9208.401453905475, 9358.251339892928, 9360.4383736976, 9373.062693730571, 9373.765655858659, 6896.069030680794, 6912.585244885323, 6947.201071876597, 6971.337722916315, 7009.439244860501, 6977.755778547727, 7018.473614478832, 7047.7180912762915, 7112.608806515691, 7187.2453392393045], "value": 6493.585908552552, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [508.5100655080615, 535.2132365422827, 538.3217146395543, 539.8677324055606, 542.6282996147639, 6422.903656445157, 6436.613803171807, 6456.548041637081, 6515.967420162892, 6539.280679125304, 6298.8898718929095, 6307.936920630792, 6339.6830158492, 6355.396237357455, 6389.680515974194, 5293.947060529403, 5300.337457817773, 5307.2569840222395, 5318.005747844558, 5339.22581225722, 5295.4969277918535, 5316.149416093426, 5334.893302133955, 5346.518813306801, 5377.9512994966, 4958.281049247875, 5125.692458452486, 5128.8974220515565, 5135.204043373283, 5156.664816786915, 5070.974645126787, 5120.795168193268, 5128.25640282157, 5136.178211486163, 5144.4083930348115, 4589.839355622537, 4598.241290187115, 4602.88492787683, 4628.004978929513, 4644.86065418038, 6224.502039836802, 6265.373462653743, 6305.716242769086, 6329.36706329368, 6365.777197798101, 5867.119932010232, 5869.7652093916195, 5920.437558431942, 5925.762969481216, 5927.733252003627, 6589.93410065898, 6650.667466626649, 6676.399124078807, 6725.66371681414, 6730.206964109938, 4980.651354405193, 4983.950160498385, 4986.67586606873, 4989.426215985171, 5035.496450354935, 6724.596524208514, 6823.965880170567, 6891.620960847152, 6916.3429474200375, 7025.578465292099, 5085.338905942203, 5119.180931051088, 5119.846404607868, 5142.228665700175, 5184.533391994739, 5143.27994080829, 5153.974230128825, 5179.300794392784, 5198.090334191501, 5274.3143391359645, 5745.482906538432, 5775.422457754275, 5827.79602713903, 5869.0, 5869.119632055226, 6661.0, 6668.86662266752, 6681.986212408774, 6724.3611856874495, 6786.0, 1771.7076682347526, 1802.738602902598, 1809.8280663336961, 1811.0, 1837.090640133116, 1172.3903570143477, 1235.8269842222096, 1238.4303220518661, 1245.5765039886483, 1270.9491620335268, 5677.602567820296, 5744.626599271034, 5768.451997060272, 5854.765809367577, 5862.560307976919, 6608.966955165193, 6714.597124172566, 6823.69293381799, 6843.520953533304, 6849.2465828758795, 5630.60585758993, 5639.915401268984, 5674.2339784129435, 5691.430856914276, 5732.0, 3565.714742820568, 3600.2079542501133, 3617.2403795203304, 3626.401643728808, 3635.8547057676747, 6169.475594574422, 6469.838254043592, 6509.056186852879, 6551.4103730664465, 6614.933850661432, 6824.761133360308, 6834.350736680008, 6850.143732033496, 6866.9999999999, 6982.860342793218, 6497.18785151856, 6500.674966251574, 6536.182977127859, 6543.476521878333, 6601.504887133484, 6723.294054124247, 6797.5581587196675, 6842.076319696777, 6846.657667116525, 6857.074294970314, 6811.761588344384, 6811.8978215325815, 6814.829629259309, 6816.591004539743, 6833.829154270984, 6554.31179726141, 6571.310012448624, 6609.4712423007, 6610.173728283965, 6624.8343791405605, 5098.1842905135, 5099.0, 5147.768350424165, 5149.755653937995, 5166.4316925138955, 6497.4477169441125, 6617.371349721769, 6629.867402651824, 6710.698018589273, 6745.448546834354, 6486.383793539606, 6538.313477085027, 6609.900851487136, 6637.601743895381, 6666.866662666816, 6415.294317624965, 6541.542092053511, 6543.0, 6558.146971241343, 6583.30875258091, 6509.283978762427, 6526.9020964686515, 6552.180977377828, 6585.670716464253, 6602.6698665067515, 6555.70499327541, 6587.440067594116, 6699.196096468455, 6703.29615390377, 6717.9328206719265, 6435.967820161057, 6474.967625161844, 6475.579087359307, 6492.156019717407, 6546.443552298108], "value": 5154.489816404766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [908.2688435809171, 908.4413085952139, 936.433457758056, 936.7517607833926, 938.3056538161762, 19701.0, 20699.482512937186, 20721.481962950915, 20753.792462075377, 20809.479763005915, 16519.66960660789, 16582.170891455407, 16630.75053874193, 16647.084410357427, 16650.58373540662, 965.5172413793103, 967.9370840895336, 978.1001478639669, 978.2516374973151, 980.8871979722352, 971.1259866120478, 971.1745016735754, 972.4602845420789, 974.8342781727088, 981.5533932060931, 983.965561205358, 997.6308765756644, 1005.2008653120787, 1021.8518314844343, 1023.4780262066325, 1015.2537884654773, 1017.0897047142765, 1019.1031891935124, 1019.8521214423904, 1021.8671572695539, 714.1465948191913, 741.6217728958217, 744.326384621918, 745.0649434959091, 750.6697053296532, 20129.295474658462, 20207.090680919246, 20264.290749823835, 20298.18807247708, 20315.0, 21533.784662153335, 21583.892080539496, 22222.11111555536, 22293.66559501609, 22301.553968920693, 16428.507144785675, 16629.750553741702, 16707.331706731715, 16879.24043418049, 16880.493585192464, 3765.7363984521094, 3800.1259710266795, 3806.143617686026, 3806.6574008339107, 3810.1427178884805, 102642.0, 139880.0, 140048.59951400457, 140953.0, 141823.0, 17823.910880445514, 18102.275908963493, 18239.817601824077, 18335.35826246075, 18346.0, 32614.836925815693, 32669.0, 32780.508292375634, 32786.50820237699, 32876.67123328736, 8918.464892106365, 9213.585388657526, 9224.7693807654, 9267.25861931044, 9405.294602904809, 4193.266178418826, 4276.294411422143, 4291.485021797404, 4295.763732994653, 4300.032492689183, 5632.577556683265, 5727.770889164387, 5734.827955161351, 5739.081746920556, 5741.167530708024, 1100.4552746390589, 1101.146611376174, 1120.781447617723, 1121.9551217951355, 1123.1800785426685, 684.6234570985938, 695.84343522708, 696.4324075878143, 713.464901324007, 716.5987047253554, 11707.0, 12364.690882728004, 12498.0, 13544.593662189953, 13670.453181872614, 681.6659836680091, 685.5543896467336, 695.7912626212218, 699.2448155991517, 704.3097764191122, 5875.559333050039, 5941.31674857397, 5950.7917222896995, 5960.612560183574, 6049.485793707584, 124167.37916310542, 124904.0, 127026.36486817691, 128172.0, 131436.3428182853, 108383.0, 111400.0, 112129.0, 112360.43819780849, 115455.0, 93909.0, 96207.51896240473, 98055.50972245236, 98368.50815746018, 99028.5048574767, 10874.293170943864, 10936.726581835199, 10941.507632156732, 11008.889911100787, 11139.10887129044, 45288.32067518924, 45716.314255285535, 45759.77120114378, 46246.306305404774, 46431.30353044639, 57173.14240286316, 58713.0, 58800.70599646975, 59094.40905590889, 59721.0, 15386.307616157075, 15447.0, 15631.06213627186, 15720.92139539295, 15912.283947222171, 16839.24223409974, 17899.105044747972, 17954.371596994042, 18039.819601803814, 18073.36743213981, 15907.840921590636, 16061.036337819769, 16186.67626647484, 16263.837361626705, 16301.184940752677, 16240.918795405947, 16275.918620406823, 16361.263743131349, 16688.0, 16741.24664390081, 15553.84446155524, 15845.366185352917, 15865.841341586436, 15876.285567149736, 16026.278817453009, 11705.590304339306, 11849.940750296193, 11993.40032998364, 12025.518979240733, 12132.211406258564, 11575.942120289345, 11677.649670509898, 11733.237339573241, 11941.701457463285, 12065.215760975509], "value": 9086.667742588694, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1411.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 105.0, 107.0, 110.0, 106.0, 107.0, 107.0, 107.0, 110.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 114.0, 116.0, 142.0, 116.0, 119.0, 116.0, 118.0, 139.0, 117.0], "value": 121.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 162.0, 164.0, 163.0, 162.0, 162.0, 163.0, 164.0, 168.0, 165.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 74.0, 78.0, 75.0, 73.0, 73.0, 74.0, 75.0], "value": 74.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 79.0, 79.0, 80.0, 79.0, 79.0, 85.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 112.0, 113.0, 111.0, 111.0, 110.0, 110.0, 111.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 150.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 94.0, 98.0, 98.0, 94.0, 95.0, 98.0, 94.0, 94.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 53.0, 53.0, 51.0, 52.0, 51.0, 51.0, 49.0], "value": 51.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [37.0, 37.0, 37.0, 36.0, 36.0, 37.0, 37.0, 37.0, 37.0, 37.0], "value": 36.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 80.0, 78.0, 76.0, 80.0, 72.0, 74.0, 79.0, 75.0, 78.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 106.0, 114.0, 112.0, 114.0, 109.0, 111.0, 118.0, 111.0, 117.0], "value": 112.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 173.0, 171.0, 165.0, 169.0, 169.0, 161.0, 161.0, 161.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 65.0, 64.0, 63.0, 65.0, 67.0, 64.0, 64.0, 64.0], "value": 64.9, "unit": "score"}]}]} 03:17:51 INFO - Return code: 0 03:17:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:51 INFO - # TBPL SUCCESS # 03:17:51 INFO - Running post-action listener: _package_coverage_data 03:17:51 INFO - Running post-action listener: _resource_record_post_action 03:17:51 INFO - [mozharness: 2017-10-02 10:17:51.795932Z] Finished run-tests step (success) 03:17:51 INFO - Running post-run listener: _resource_record_post_run 03:17:51 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 479232; Write bytes: 401702912; Read time: 384; Write time: 289540 03:17:51 INFO - TinderboxPrint: CPU usage
13.1% 03:17:51 INFO - TinderboxPrint: I/O read bytes / time
479,232 / 384 03:17:51 INFO - TinderboxPrint: I/O write bytes / time
401,702,912 / 289,540 03:17:51 INFO - TinderboxPrint: CPU idle
8,235.2 (86.9%) 03:17:51 INFO - TinderboxPrint: CPU user
1,193.0 (12.6%) 03:17:51 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 74592256; Read time: 0; Write time: 47724 03:17:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:17:51 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 475136; Write bytes: 327110656; Read time: 368; Write time: 241816 03:17:52 INFO - Running post-run listener: _upload_blobber_files 03:17:52 INFO - Blob upload gear active. 03:17:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:52 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 03:17:52 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'] 03:17:52 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 03:17:52 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 03:17:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 03:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:54 INFO - (blobuploader) - INFO - Done attempting. 03:17:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:17:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:55 INFO - (blobuploader) - INFO - Done attempting. 03:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 03:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 03:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:56 INFO - (blobuploader) - INFO - Done attempting. 03:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:03 INFO - (blobuploader) - INFO - Done attempting. 03:18:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:03 INFO - Return code: 0 03:18:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:03 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bef2a9582e40fc08164b3a1e27e6b74cc6ea2dcfb8bf4941ee24551ea1ab7dd448bb49e3ac920a4d2a9a6bf26e788903f2869674591f3c535d304a20dd5a765b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5673cece4257bd1bec3868027bd4c32edf87bcb80c1abb39d4145bce2006306372b816f6623c873edd4d1d9e8f086db351dd568ce5bc82cc7f637bfaf510ed76", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7bc316758073738cc99d6a8b4e56ef3254a89fe0b49348c5b4767ce85b78fc61a5e4ded95e20473c9495f8d4bfabec985b7fbfb7ea94979a229f274ae92143c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/856952c56d0895f48e5d5d70d82c7637afdb307cd177a9d71b3b506d5576a6d50e520db43f0a3d6492c25738793123fcc208d6322488654d908abc52cd2ee068"} 03:18:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:03 INFO - Contents: 03:18:03 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bef2a9582e40fc08164b3a1e27e6b74cc6ea2dcfb8bf4941ee24551ea1ab7dd448bb49e3ac920a4d2a9a6bf26e788903f2869674591f3c535d304a20dd5a765b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5673cece4257bd1bec3868027bd4c32edf87bcb80c1abb39d4145bce2006306372b816f6623c873edd4d1d9e8f086db351dd568ce5bc82cc7f637bfaf510ed76", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7bc316758073738cc99d6a8b4e56ef3254a89fe0b49348c5b4767ce85b78fc61a5e4ded95e20473c9495f8d4bfabec985b7fbfb7ea94979a229f274ae92143c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/856952c56d0895f48e5d5d70d82c7637afdb307cd177a9d71b3b506d5576a6d50e520db43f0a3d6492c25738793123fcc208d6322488654d908abc52cd2ee068"} 03:18:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:03 INFO - Copying logs to upload dir... 03:18:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.110570 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2017-10-02 03:18:03.751756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:18:03.756174) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 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/bef2a9582e40fc08164b3a1e27e6b74cc6ea2dcfb8bf4941ee24551ea1ab7dd448bb49e3ac920a4d2a9a6bf26e788903f2869674591f3c535d304a20dd5a765b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5673cece4257bd1bec3868027bd4c32edf87bcb80c1abb39d4145bce2006306372b816f6623c873edd4d1d9e8f086db351dd568ce5bc82cc7f637bfaf510ed76", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7bc316758073738cc99d6a8b4e56ef3254a89fe0b49348c5b4767ce85b78fc61a5e4ded95e20473c9495f8d4bfabec985b7fbfb7ea94979a229f274ae92143c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/856952c56d0895f48e5d5d70d82c7637afdb307cd177a9d71b3b506d5576a6d50e520db43f0a3d6492c25738793123fcc208d6322488654d908abc52cd2ee068"} build_url:https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011181 build_url: 'https://queue.taskcluster.net/v1/task/PYtAjz9HRZeMO2pXV7pH9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bef2a9582e40fc08164b3a1e27e6b74cc6ea2dcfb8bf4941ee24551ea1ab7dd448bb49e3ac920a4d2a9a6bf26e788903f2869674591f3c535d304a20dd5a765b", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5673cece4257bd1bec3868027bd4c32edf87bcb80c1abb39d4145bce2006306372b816f6623c873edd4d1d9e8f086db351dd568ce5bc82cc7f637bfaf510ed76", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7bc316758073738cc99d6a8b4e56ef3254a89fe0b49348c5b4767ce85b78fc61a5e4ded95e20473c9495f8d4bfabec985b7fbfb7ea94979a229f274ae92143c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/856952c56d0895f48e5d5d70d82c7637afdb307cd177a9d71b3b506d5576a6d50e520db43f0a3d6492c25738793123fcc208d6322488654d908abc52cd2ee068"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 03:18:03.787708) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:18:03.788098) ========= 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=c6927cf182745ad25b1d38b9000001fe-1506937952.495989-409130052 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 03:18:03.869803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:18:03.870147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 03:18:03.870510) ========= ========= Total master_lag: 0.34 =========