builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-041 starttime: 1506559636.11 results: success (0) revision: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.108212) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.108651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.108935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.126252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.126553) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-27 17:47:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-09-27 17:47:16 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119800 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.264988) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.265311) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019796 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.317612) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.317945) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 --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 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-27 17:47:16,343 truncating revision to first 12 chars 2017-09-27 17:47:16,343 Setting DEBUG logging. 2017-09-27 17:47:16,343 attempt 1/10 2017-09-27 17:47:16,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ebe2e8980c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-27 17:47:16,615 unpacking tar archive at: mozilla-central-5ebe2e8980c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.534665 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.871848) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.872149) ========= script_repo_revision: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.872522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.872782) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-27 17:47:16.889645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-27 17:47:16.889972) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:47:17 INFO - MultiFileLogger online at 20170927 17:47:17 in /builds/slave/test 17:47:17 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 17:47:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:47:17 INFO - {'append_to_log': False, 17:47:17 INFO - 'base_work_dir': '/builds/slave/test', 17:47:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:47:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:47:17 INFO - 'branch': 'Firefox-Non-PGO', 17:47:17 INFO - 'buildbot_json_path': 'buildprops.json', 17:47:17 INFO - 'code_coverage': False, 17:47:17 INFO - 'config_files': ('talos/linux_config.py',), 17:47:17 INFO - 'default_actions': ('clobber', 17:47:17 INFO - 'read-buildbot-config', 17:47:17 INFO - 'download-and-extract', 17:47:17 INFO - 'populate-webroot', 17:47:17 INFO - 'create-virtualenv', 17:47:17 INFO - 'install', 17:47:17 INFO - 'setup-mitmproxy', 17:47:17 INFO - 'run-tests'), 17:47:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:47:17 INFO - 'disable_ccov_upload': False, 17:47:17 INFO - 'disable_stylo': False, 17:47:17 INFO - 'download_minidump_stackwalk': True, 17:47:17 INFO - 'download_symbols': 'ondemand', 17:47:17 INFO - 'enable_stylo': False, 17:47:17 INFO - 'enable_webrender': False, 17:47:17 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 17:47:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:47:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:47:17 INFO - 'gecko_profile': False, 17:47:17 INFO - 'gecko_profile_interval': 0, 17:47:17 INFO - 'installer_path': 'installer.exe', 17:47:17 INFO - 'log_level': 'info', 17:47:17 INFO - 'log_name': 'talos', 17:47:17 INFO - 'log_to_console': True, 17:47:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:47:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:47:17 INFO - 'opt_config_files': (), 17:47:17 INFO - 'pip_index': False, 17:47:17 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 17:47:17 INFO - 'system_bits': '32', 17:47:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:47:17 INFO - 'title': 'talos-linux64-ix-041', 17:47:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:47:17 INFO - 'use_talos_json': True, 17:47:17 INFO - 'verify': 'False', 17:47:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:47:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:47:17 INFO - 'work_dir': 'build'} 17:47:17 INFO - [mozharness: 2017-09-28 00:47:17.064150Z] Running clobber step. 17:47:17 INFO - Running pre-action listener: _resource_record_pre_action 17:47:17 INFO - Running main action method: clobber 17:47:17 INFO - rmtree: /builds/slave/test/build 17:47:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:47:18 INFO - Running post-action listener: _resource_record_post_action 17:47:18 INFO - [mozharness: 2017-09-28 00:47:18.174400Z] Finished clobber step (success) 17:47:18 INFO - [mozharness: 2017-09-28 00:47:18.174498Z] Running read-buildbot-config step. 17:47:18 INFO - Running pre-action listener: _resource_record_pre_action 17:47:18 INFO - Running main action method: read_buildbot_config 17:47:18 INFO - Using buildbot properties: 17:47:18 INFO - { 17:47:18 INFO - "project": "", 17:47:18 INFO - "product": "firefox", 17:47:18 INFO - "who": "kwierso@gmail.com", 17:47:18 INFO - "installer_path": "public/build/target.tar.bz2", 17:47:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 17:47:18 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 17:47:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 17:47:18 INFO - "stage_platform": "linux64", 17:47:18 INFO - "basedir": "/builds/slave/test", 17:47:18 INFO - "buildnumber": 74, 17:47:18 INFO - "platform": "ubuntu64_hw", 17:47:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:47:18 INFO - "slavebuilddir": "test", 17:47:18 INFO - "taskId": "CMpikR8YQqeP54Z1aSV25g", 17:47:18 INFO - "branch": "mozilla-central", 17:47:18 INFO - "script_repo_revision": "production", 17:47:18 INFO - "revision": "5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369", 17:47:18 INFO - "slavename": "talos-linux64-ix-041", 17:47:18 INFO - "repo_path": "mozilla-central" 17:47:18 INFO - } 17:47:18 INFO - Finding installer, test and symbols from parent task. 17:47:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMpikR8YQqeP54Z1aSV25g'}, attempt #1 17:47:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CMpikR8YQqeP54Z1aSV25g'}, attempt #1 17:47:19 INFO - Task dependencies: ROcRQ0zqS7mg-39GJg0GHQ 17:47:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ'}, attempt #1 17:47:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 17:47:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.test_packages.json 17:47:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.crashreporter-symbols.zip 17:47:19 INFO - Running post-action listener: _resource_record_post_action 17:47:19 INFO - [mozharness: 2017-09-28 00:47:19.512351Z] Finished read-buildbot-config step (success) 17:47:19 INFO - [mozharness: 2017-09-28 00:47:19.512570Z] Running download-and-extract step. 17:47:19 INFO - Running pre-action listener: _resource_record_pre_action 17:47:19 INFO - Running main action method: download_and_extract 17:47:19 INFO - mkdir: /builds/slave/test/build/tests 17:47:19 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')]} 17:47:19 INFO - trying https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.test_packages.json 17:47:19 INFO - Downloading https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:47:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:47:20 INFO - Downloaded 989 bytes. 17:47:20 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:47:20 INFO - Using the following test package requirements: 17:47:20 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:47:20 INFO - u'common': [u'target.common.tests.zip'], 17:47:20 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:47:20 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:47:20 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:47:20 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:47:20 INFO - u'mozbase': [u'target.common.tests.zip'], 17:47:20 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:47:20 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:47:20 INFO - u'web-platform': [u'target.common.tests.zip', 17:47:20 INFO - u'target.web-platform.tests.tar.gz'], 17:47:20 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:47:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 17:47:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.common.tests.zip 17:47:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:47:20 INFO - Fetch https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.common.tests.zip into memory 17:47:21 INFO - Content-Length response header: 54946002 17:47:21 INFO - Bytes received: 54946002 17:47:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.talos.tests.zip 17:47:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:47:31 INFO - Fetch https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.talos.tests.zip into memory 17:47:32 INFO - Content-Length response header: 14521162 17:47:32 INFO - Bytes received: 14521162 17:47:32 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')]} 17:47:32 INFO - trying https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 17:47:32 INFO - Downloading https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:47:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:47:33 INFO - Downloaded 61824142 bytes. 17:47:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 17:47:33 INFO - mkdir: /builds/slave/test/properties 17:47:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:47:33 INFO - Writing to file /builds/slave/test/properties/build_url 17:47:33 INFO - Contents: 17:47:33 INFO - build_url:https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 17:47:33 INFO - Running post-action listener: _resource_record_post_action 17:47:33 INFO - Running post-action listener: find_tests_for_verification 17:47:33 INFO - Running post-action listener: set_extra_try_arguments 17:47:33 INFO - [mozharness: 2017-09-28 00:47:33.919884Z] Finished download-and-extract step (success) 17:47:33 INFO - [mozharness: 2017-09-28 00:47:33.919980Z] Running populate-webroot step. 17:47:33 INFO - Running pre-action listener: _resource_record_pre_action 17:47:33 INFO - Running main action method: populate_webroot 17:47:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:47:33 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['tresize', 17:47:33 INFO - 'tcanvasmark']}, 17:47:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:47:33 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['dromaeo_css', 17:47:33 INFO - 'kraken']}, 17:47:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:33 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:47:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'tests': ['damp', 'tps']}, 17:47:33 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['damp', 'tps']}, 17:47:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:47:33 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['dromaeo_dom']}, 17:47:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:47:33 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['basic_compositor_video', 17:47:33 INFO - 'glvideo']}, 17:47:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:47:33 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['ts_paint_webext', 17:47:33 INFO - 'tp5o_webext']}, 17:47:33 INFO - 'other-e10s': {'tests': ['a11yr', 17:47:33 INFO - 'ts_paint', 17:47:33 INFO - 'tpaint', 17:47:33 INFO - 'sessionrestore', 17:47:33 INFO - 'sessionrestore_many_windows', 17:47:33 INFO - 'sessionrestore_no_auto_restore', 17:47:33 INFO - 'tabpaint', 17:47:33 INFO - 'cpstartup']}, 17:47:33 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['a11yr', 17:47:33 INFO - 'ts_paint', 17:47:33 INFO - 'tpaint', 17:47:33 INFO - 'sessionrestore', 17:47:33 INFO - 'sessionrestore_many_windows', 17:47:33 INFO - 'sessionrestore_no_auto_restore', 17:47:33 INFO - 'tabpaint', 17:47:33 INFO - 'cpstartup']}, 17:47:33 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 17:47:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 17:47:33 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['perf_reftest_singletons']}, 17:47:33 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['perf_reftest']}, 17:47:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:47:33 INFO - 'tsvgr_opacity', 17:47:33 INFO - 'tart', 17:47:33 INFO - 'tscrollx', 17:47:33 INFO - 'tsvg_static']}, 17:47:33 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['tsvgx', 17:47:33 INFO - 'tsvgr_opacity', 17:47:33 INFO - 'tart', 17:47:33 INFO - 'tscrollx', 17:47:33 INFO - 'tsvg_static']}, 17:47:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:47:33 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--disable-stylo'], 17:47:33 INFO - 'tests': ['tp5o']}, 17:47:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:47:33 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:47:33 INFO - 'talos_options': ['--mitmproxy', 17:47:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:47:33 INFO - '--firstNonBlankPaint'], 17:47:33 INFO - 'tests': ['tp6_google', 17:47:33 INFO - 'tp6_youtube', 17:47:33 INFO - 'tp6_amazon', 17:47:33 INFO - 'tp6_facebook']}, 17:47:33 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:47:33 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:47:33 INFO - 'talos_options': ['--disable-stylo', 17:47:33 INFO - '--mitmproxy', 17:47:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:47:33 INFO - '--firstNonBlankPaint'], 17:47:33 INFO - 'tests': ['tp6_google', 17:47:33 INFO - 'tp6_youtube', 17:47:33 INFO - 'tp6_amazon', 17:47:33 INFO - 'tp6_facebook']}, 17:47:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:47:33 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 17:47:33 INFO - 'talos_options': ['--stylo-threads=1', 17:47:33 INFO - '--mitmproxy', 17:47:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:47:33 INFO - '--firstNonBlankPaint'], 17:47:33 INFO - 'tests': ['tp6_google', 17:47:33 INFO - 'tp6_youtube', 17:47:33 INFO - 'tp6_amazon', 17:47:33 INFO - 'tp6_facebook']}, 17:47:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--xperf_path', 17:47:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:33 INFO - 'tests': ['tp5n']}, 17:47:33 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 17:47:33 INFO - 'talos_options': ['--disable-stylo', 17:47:33 INFO - '--xperf_path', 17:47:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:47:33 INFO - 'tests': ['tp5n']}}} 17:47:33 INFO - Running post-action listener: _resource_record_post_action 17:47:33 INFO - [mozharness: 2017-09-28 00:47:33.936322Z] Finished populate-webroot step (success) 17:47:33 INFO - [mozharness: 2017-09-28 00:47:33.936429Z] Running create-virtualenv step. 17:47:33 INFO - Running pre-action listener: _resource_record_pre_action 17:47:33 INFO - Running main action method: create_virtualenv 17:47:33 INFO - Creating virtualenv /builds/slave/test/build/venv 17:47:33 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:47:33 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 17:47:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:47:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:47:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:47:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:47:34 INFO - Installing pip...............done. 17:47:34 INFO - Return code: 0 17:47:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:47:34 INFO - Reading from file tmpfile_stdout 17:47:34 INFO - Output received: 17:47:34 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 17:47:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:47:34 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')]} 17:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:34 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')]} 17:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:34 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:34 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 17:47:34 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 17:47:34 INFO - Using env: {'DISPLAY': ':0', 17:47:34 INFO - 'HOME': '/home/cltbld', 17:47:34 INFO - 'LANG': 'en_US.UTF-8', 17:47:34 INFO - 'LANGUAGE': 'en_US:en', 17:47:34 INFO - 'LOGNAME': 'cltbld', 17:47:34 INFO - 'MAIL': '/var/mail/cltbld', 17:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:34 INFO - 'MOZ_NO_REMOTE': '1', 17:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:34 INFO - 'NO_EM_RESTART': '1', 17:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:34 INFO - 'PWD': '/builds/slave/test', 17:47:34 INFO - 'SHELL': '/bin/bash', 17:47:34 INFO - 'SHLVL': '1', 17:47:34 INFO - 'TERM': 'linux', 17:47:34 INFO - 'TMOUT': '86400', 17:47:34 INFO - 'USER': 'cltbld', 17:47:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:34 INFO - '_': '/tools/buildbot/bin/python'} 17:47:36 INFO - Ignoring indexes: http://pypi.python.org/simple/ 17:47:36 INFO - Downloading/unpacking pip>=1.5 17:47:36 INFO - Running setup.py egg_info for package pip 17:47:36 INFO - warning: no files found matching 'pip/cacert.pem' 17:47:36 INFO - warning: no files found matching '*.html' under directory 'docs' 17:47:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:47:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:47:36 INFO - Installing collected packages: pip 17:47:36 INFO - Found existing installation: pip 1.1 17:47:36 INFO - Uninstalling pip: 17:47:36 INFO - Successfully uninstalled pip 17:47:36 INFO - Running setup.py install for pip 17:47:36 INFO - warning: no files found matching 'pip/cacert.pem' 17:47:36 INFO - warning: no files found matching '*.html' under directory 'docs' 17:47:36 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 17:47:36 INFO - no previously-included directories found matching 'docs/_build/_sources' 17:47:36 INFO - Installing pip script to /builds/slave/test/build/venv/bin 17:47:36 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 17:47:36 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 17:47:36 INFO - Successfully installed pip 17:47:36 INFO - Cleaning up... 17:47:36 INFO - Return code: 0 17:47:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:47:36 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')]} 17:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:36 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')]} 17:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:36 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:36 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 17:47:36 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 17:47:36 INFO - Using env: {'DISPLAY': ':0', 17:47:36 INFO - 'HOME': '/home/cltbld', 17:47:36 INFO - 'LANG': 'en_US.UTF-8', 17:47:36 INFO - 'LANGUAGE': 'en_US:en', 17:47:36 INFO - 'LOGNAME': 'cltbld', 17:47:36 INFO - 'MAIL': '/var/mail/cltbld', 17:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:36 INFO - 'MOZ_NO_REMOTE': '1', 17:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:36 INFO - 'NO_EM_RESTART': '1', 17:47:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:36 INFO - 'PWD': '/builds/slave/test', 17:47:36 INFO - 'SHELL': '/bin/bash', 17:47:36 INFO - 'SHLVL': '1', 17:47:36 INFO - 'TERM': 'linux', 17:47:36 INFO - 'TMOUT': '86400', 17:47:36 INFO - 'USER': 'cltbld', 17:47:36 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:36 INFO - '_': '/tools/buildbot/bin/python'} 17:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:36 INFO - Downloading/unpacking psutil>=3.1.1 17:47:36 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 17:47:36 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 17:47:36 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 17:47:36 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 17:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:37 INFO - Installing collected packages: psutil 17:47:37 INFO - Running setup.py install for psutil 17:47:37 INFO - building 'psutil._psutil_linux' extension 17:47:37 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 17:47:37 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 17:47:37 INFO - building 'psutil._psutil_posix' extension 17:47:37 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 17:47:37 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 17:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:47:38 INFO - Successfully installed psutil 17:47:38 INFO - Cleaning up... 17:47:38 INFO - Return code: 0 17:47:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:47:38 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')]} 17:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:38 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')]} 17:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:38 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:38 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 17:47:38 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 17:47:38 INFO - Using env: {'DISPLAY': ':0', 17:47:38 INFO - 'HOME': '/home/cltbld', 17:47:38 INFO - 'LANG': 'en_US.UTF-8', 17:47:38 INFO - 'LANGUAGE': 'en_US:en', 17:47:38 INFO - 'LOGNAME': 'cltbld', 17:47:38 INFO - 'MAIL': '/var/mail/cltbld', 17:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:38 INFO - 'MOZ_NO_REMOTE': '1', 17:47:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:38 INFO - 'NO_EM_RESTART': '1', 17:47:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:38 INFO - 'PWD': '/builds/slave/test', 17:47:38 INFO - 'SHELL': '/bin/bash', 17:47:38 INFO - 'SHLVL': '1', 17:47:38 INFO - 'TERM': 'linux', 17:47:38 INFO - 'TMOUT': '86400', 17:47:38 INFO - 'USER': 'cltbld', 17:47:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:38 INFO - '_': '/tools/buildbot/bin/python'} 17:47:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:47:38 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 17:47:38 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 17:47:38 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 17:47:38 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 17:47:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:47:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:47:39 INFO - Installing collected packages: mozsystemmonitor 17:47:39 INFO - Running setup.py install for mozsystemmonitor 17:47:39 INFO - Successfully installed mozsystemmonitor 17:47:39 INFO - Cleaning up... 17:47:40 INFO - Return code: 0 17:47:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:47:40 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')]} 17:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:40 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')]} 17:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:40 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:40 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 17:47:40 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 17:47:40 INFO - Using env: {'DISPLAY': ':0', 17:47:40 INFO - 'HOME': '/home/cltbld', 17:47:40 INFO - 'LANG': 'en_US.UTF-8', 17:47:40 INFO - 'LANGUAGE': 'en_US:en', 17:47:40 INFO - 'LOGNAME': 'cltbld', 17:47:40 INFO - 'MAIL': '/var/mail/cltbld', 17:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:40 INFO - 'MOZ_NO_REMOTE': '1', 17:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:40 INFO - 'NO_EM_RESTART': '1', 17:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:40 INFO - 'PWD': '/builds/slave/test', 17:47:40 INFO - 'SHELL': '/bin/bash', 17:47:40 INFO - 'SHLVL': '1', 17:47:40 INFO - 'TERM': 'linux', 17:47:40 INFO - 'TMOUT': '86400', 17:47:40 INFO - 'USER': 'cltbld', 17:47:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:40 INFO - '_': '/tools/buildbot/bin/python'} 17:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:40 INFO - Downloading/unpacking jsonschema==2.5.1 17:47:40 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 17:47:40 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 17:47:40 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 17:47:40 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 17:47:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:47:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:47:41 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 17:47:41 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 17:47:41 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 17:47:41 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 17:47:42 INFO - Downloading functools32-3.2.3-2.tar.gz 17:47:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:47:42 INFO - warning: no files found matching '*.txt' 17:47:42 INFO - no previously-included directories found matching 'build' 17:47:42 INFO - no previously-included directories found matching 'dist' 17:47:42 INFO - no previously-included directories found matching '.git*' 17:47:42 INFO - Installing collected packages: jsonschema, functools32 17:47:42 INFO - Running setup.py install for functools32 17:47:42 INFO - warning: no files found matching '*.txt' 17:47:42 INFO - no previously-included directories found matching 'build' 17:47:42 INFO - no previously-included directories found matching 'dist' 17:47:42 INFO - no previously-included directories found matching '.git*' 17:47:42 INFO - Successfully installed jsonschema functools32 17:47:42 INFO - Cleaning up... 17:47:42 INFO - Return code: 0 17:47:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:42 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:42 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 17:47:42 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 17:47:42 INFO - Using env: {'DISPLAY': ':0', 17:47:42 INFO - 'HOME': '/home/cltbld', 17:47:42 INFO - 'LANG': 'en_US.UTF-8', 17:47:42 INFO - 'LANGUAGE': 'en_US:en', 17:47:42 INFO - 'LOGNAME': 'cltbld', 17:47:42 INFO - 'MAIL': '/var/mail/cltbld', 17:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:42 INFO - 'MOZ_NO_REMOTE': '1', 17:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:42 INFO - 'NO_EM_RESTART': '1', 17:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:42 INFO - 'PWD': '/builds/slave/test', 17:47:42 INFO - 'SHELL': '/bin/bash', 17:47:42 INFO - 'SHLVL': '1', 17:47:42 INFO - 'TERM': 'linux', 17:47:42 INFO - 'TMOUT': '86400', 17:47:42 INFO - 'USER': 'cltbld', 17:47:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:42 INFO - '_': '/tools/buildbot/bin/python'} 17:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:47:42 INFO - Cleaning up... 17:47:42 INFO - Return code: 0 17:47:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:42 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:42 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 17:47:42 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 17:47:42 INFO - Using env: {'DISPLAY': ':0', 17:47:42 INFO - 'HOME': '/home/cltbld', 17:47:42 INFO - 'LANG': 'en_US.UTF-8', 17:47:42 INFO - 'LANGUAGE': 'en_US:en', 17:47:42 INFO - 'LOGNAME': 'cltbld', 17:47:42 INFO - 'MAIL': '/var/mail/cltbld', 17:47:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:42 INFO - 'MOZ_NO_REMOTE': '1', 17:47:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:42 INFO - 'NO_EM_RESTART': '1', 17:47:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:42 INFO - 'PWD': '/builds/slave/test', 17:47:42 INFO - 'SHELL': '/bin/bash', 17:47:42 INFO - 'SHLVL': '1', 17:47:42 INFO - 'TERM': 'linux', 17:47:42 INFO - 'TMOUT': '86400', 17:47:42 INFO - 'USER': 'cltbld', 17:47:42 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:42 INFO - '_': '/tools/buildbot/bin/python'} 17:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:42 INFO - Downloading/unpacking blobuploader==1.2.4 17:47:42 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 17:47:42 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 17:47:42 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 17:47:42 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 17:47:43 INFO - Downloading blobuploader-1.2.4.tar.gz 17:47:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:47:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:47:43 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 17:47:43 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 17:47:43 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 17:47:43 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 17:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:47:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:47: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 17:47: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 17:47: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 17:47: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 17:47:44 INFO - Downloading docopt-0.6.1.tar.gz 17:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:47:44 INFO - Installing collected packages: blobuploader, requests, docopt 17:47:44 INFO - Running setup.py install for blobuploader 17:47:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:47:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:47:44 INFO - Running setup.py install for requests 17:47:45 INFO - Running setup.py install for docopt 17:47:45 INFO - Successfully installed blobuploader requests docopt 17:47:45 INFO - Cleaning up... 17:47:45 INFO - Return code: 0 17:47:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:45 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:45 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 17:47:45 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 17:47:45 INFO - Using env: {'DISPLAY': ':0', 17:47:45 INFO - 'HOME': '/home/cltbld', 17:47:45 INFO - 'LANG': 'en_US.UTF-8', 17:47:45 INFO - 'LANGUAGE': 'en_US:en', 17:47:45 INFO - 'LOGNAME': 'cltbld', 17:47:45 INFO - 'MAIL': '/var/mail/cltbld', 17:47:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:45 INFO - 'MOZ_NO_REMOTE': '1', 17:47:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:45 INFO - 'NO_EM_RESTART': '1', 17:47:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:45 INFO - 'PWD': '/builds/slave/test', 17:47:45 INFO - 'SHELL': '/bin/bash', 17:47:45 INFO - 'SHLVL': '1', 17:47:45 INFO - 'TERM': 'linux', 17:47:45 INFO - 'TMOUT': '86400', 17:47:45 INFO - 'USER': 'cltbld', 17:47:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:45 INFO - '_': '/tools/buildbot/bin/python'} 17:47:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:45 INFO - Running setup.py (path:/tmp/pip-KqNSC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:45 INFO - Running setup.py (path:/tmp/pip-CqWDXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:45 INFO - Running setup.py (path:/tmp/pip-BEVfBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:45 INFO - Running setup.py (path:/tmp/pip-IzDEG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:45 INFO - Running setup.py (path:/tmp/pip-iCGIgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:45 INFO - Running setup.py (path:/tmp/pip-Lu_nlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:45 INFO - Running setup.py (path:/tmp/pip-zjz0m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:45 INFO - Running setup.py (path:/tmp/pip-jEH2_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:45 INFO - Running setup.py (path:/tmp/pip-gOAbq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:46 INFO - Running setup.py (path:/tmp/pip-gzQu6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:46 INFO - Running setup.py (path:/tmp/pip-7ly6zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:46 INFO - Running setup.py (path:/tmp/pip-Tcxj3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:46 INFO - Running setup.py (path:/tmp/pip-WcGeL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:46 INFO - Running setup.py (path:/tmp/pip-m16w6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:46 INFO - Running setup.py (path:/tmp/pip-JU2RpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:46 INFO - Running setup.py (path:/tmp/pip-SWXI5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:46 INFO - Running setup.py (path:/tmp/pip-8hZFb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:47:46 INFO - Running setup.py install for manifestparser 17:47:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:47:46 INFO - Running setup.py install for mozcrash 17:47:46 INFO - Running setup.py install for mozdebug 17:47:46 INFO - Running setup.py install for mozdevice 17:47:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozfile 17:47:47 INFO - Running setup.py install for mozhttpd 17:47:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozinfo 17:47:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozInstall 17:47:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozleak 17:47:47 INFO - Running setup.py install for mozlog 17:47:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for moznetwork 17:47:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozprocess 17:47:47 INFO - Running setup.py install for mozprofile 17:47:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:47:47 INFO - Running setup.py install for mozrunner 17:47:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:47:48 INFO - Running setup.py install for mozscreenshot 17:47:48 INFO - Running setup.py install for moztest 17:47:48 INFO - Running setup.py install for mozversion 17:47:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:47:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:47:48 INFO - Cleaning up... 17:47:48 INFO - Return code: 0 17:47:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47: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')]} 17:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47: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')]} 17:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:48 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:48 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 17:47:48 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 17:47:48 INFO - Using env: {'DISPLAY': ':0', 17:47:48 INFO - 'HOME': '/home/cltbld', 17:47:48 INFO - 'LANG': 'en_US.UTF-8', 17:47:48 INFO - 'LANGUAGE': 'en_US:en', 17:47:48 INFO - 'LOGNAME': 'cltbld', 17:47:48 INFO - 'MAIL': '/var/mail/cltbld', 17:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:48 INFO - 'MOZ_NO_REMOTE': '1', 17:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:48 INFO - 'NO_EM_RESTART': '1', 17:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:48 INFO - 'PWD': '/builds/slave/test', 17:47:48 INFO - 'SHELL': '/bin/bash', 17:47:48 INFO - 'SHLVL': '1', 17:47:48 INFO - 'TERM': 'linux', 17:47:48 INFO - 'TMOUT': '86400', 17:47:48 INFO - 'USER': 'cltbld', 17:47:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:48 INFO - '_': '/tools/buildbot/bin/python'} 17:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:47:48 INFO - Running setup.py (path:/tmp/pip-DXU9C2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:47:48 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)) 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:47:48 INFO - Running setup.py (path:/tmp/pip-V4FhLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:47:48 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)) 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:47:48 INFO - Running setup.py (path:/tmp/pip-UseUvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:47:48 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)) 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:47:48 INFO - Running setup.py (path:/tmp/pip-J2ZEj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:47:48 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)) 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:47:48 INFO - Running setup.py (path:/tmp/pip-lYjHu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:47:48 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)) 17:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:47:48 INFO - Running setup.py (path:/tmp/pip-jqu4uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:47:49 INFO - Running setup.py (path:/tmp/pip-xGAFHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:47:49 INFO - Running setup.py (path:/tmp/pip-R8i5En-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:47:49 INFO - Running setup.py (path:/tmp/pip-dRYOAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:47:49 INFO - Running setup.py (path:/tmp/pip-j9EUAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:47:49 INFO - Running setup.py (path:/tmp/pip-iDqYF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:47:49 INFO - Running setup.py (path:/tmp/pip-EAlUE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:47:49 INFO - Running setup.py (path:/tmp/pip-hEVEH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:47:49 INFO - Running setup.py (path:/tmp/pip-yBTlxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:49 INFO - Running setup.py (path:/tmp/pip-rhxCGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:47:49 INFO - Running setup.py (path:/tmp/pip-gQsrzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:47:49 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)) 17:47:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:47:49 INFO - Running setup.py (path:/tmp/pip-_mmYQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:47:49 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)) 17:47:49 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)) 17:47:49 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)) 17:47:49 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)) 17:47:49 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)) 17:47:49 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)) 17:47:49 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)) 17:47:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:47: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 17:47: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 17:47: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 17:47: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 17:47:50 INFO - Downloading blessings-1.6.tar.gz 17:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:47:51 INFO - Installing collected packages: blessings 17:47:51 INFO - Running setup.py install for blessings 17:47:51 INFO - Successfully installed blessings 17:47:51 INFO - Cleaning up... 17:47:51 INFO - Return code: 0 17:47:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:47:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:51 INFO - Reading from file tmpfile_stdout 17:47:51 INFO - Current package versions: 17:47:51 INFO - argparse == 1.2.1 17:47:51 INFO - blessings == 1.6 17:47:51 INFO - blobuploader == 1.2.4 17:47:51 INFO - docopt == 0.6.1 17:47:51 INFO - functools32 == 3.2.3-2 17:47:51 INFO - jsonschema == 2.5.1 17:47:51 INFO - manifestparser == 1.1 17:47:51 INFO - mozInstall == 1.13 17:47:51 INFO - mozcrash == 1.0 17:47:51 INFO - mozdebug == 0.1 17:47:51 INFO - mozdevice == 0.51 17:47:51 INFO - mozfile == 1.2 17:47:51 INFO - mozhttpd == 0.7 17:47:51 INFO - mozinfo == 0.10 17:47:51 INFO - mozleak == 0.1 17:47:51 INFO - mozlog == 3.5 17:47:51 INFO - moznetwork == 0.27 17:47:51 INFO - mozprocess == 0.25 17:47:51 INFO - mozprofile == 0.28 17:47:51 INFO - mozrunner == 6.13 17:47:51 INFO - mozscreenshot == 0.1 17:47:51 INFO - mozsystemmonitor == 0.3 17:47:51 INFO - moztest == 0.8 17:47:51 INFO - mozversion == 1.4 17:47:51 INFO - psutil == 3.1.1 17:47:51 INFO - requests == 1.2.3 17:47:51 INFO - wsgiref == 0.1.2 17:47:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:51 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 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:51 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 17:47:51 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 17:47:51 INFO - Using env: {'DISPLAY': ':0', 17:47:51 INFO - 'HOME': '/home/cltbld', 17:47:51 INFO - 'LANG': 'en_US.UTF-8', 17:47:51 INFO - 'LANGUAGE': 'en_US:en', 17:47:51 INFO - 'LOGNAME': 'cltbld', 17:47:51 INFO - 'MAIL': '/var/mail/cltbld', 17:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:51 INFO - 'MOZ_NO_REMOTE': '1', 17:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:51 INFO - 'NO_EM_RESTART': '1', 17:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:51 INFO - 'PWD': '/builds/slave/test', 17:47:51 INFO - 'SHELL': '/bin/bash', 17:47:51 INFO - 'SHLVL': '1', 17:47:51 INFO - 'TERM': 'linux', 17:47:51 INFO - 'TMOUT': '86400', 17:47:51 INFO - 'USER': 'cltbld', 17:47:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:51 INFO - '_': '/tools/buildbot/bin/python'} 17:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 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)) 17:47:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:47: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 17:47: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 17:47: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 17:47: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 17:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:47:53 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)) 17:47:53 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)) 17:47:53 INFO - Installing collected packages: simplejson 17:47:53 INFO - Running setup.py install for simplejson 17:47:53 INFO - building 'simplejson._speedups' extension 17:47:53 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 17:47:54 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 17:47:54 INFO - Successfully installed simplejson 17:47:54 INFO - Cleaning up... 17:47:54 INFO - Return code: 0 17:47:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:47:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26871f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284fb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f49c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', '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 17:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:47:54 INFO - Using env: {'DISPLAY': ':0', 17:47:54 INFO - 'HOME': '/home/cltbld', 17:47:54 INFO - 'LANG': 'en_US.UTF-8', 17:47:54 INFO - 'LANGUAGE': 'en_US:en', 17:47:54 INFO - 'LOGNAME': 'cltbld', 17:47:54 INFO - 'MAIL': '/var/mail/cltbld', 17:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:47:54 INFO - 'MOZ_NO_REMOTE': '1', 17:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:47:54 INFO - 'NO_EM_RESTART': '1', 17:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:47:54 INFO - 'PWD': '/builds/slave/test', 17:47:54 INFO - 'SHELL': '/bin/bash', 17:47:54 INFO - 'SHLVL': '1', 17:47:54 INFO - 'TERM': 'linux', 17:47:54 INFO - 'TMOUT': '86400', 17:47:54 INFO - 'USER': 'cltbld', 17:47:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:47:54 INFO - '_': '/tools/buildbot/bin/python'} 17:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:47:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:47:55 INFO - Cleaning up... 17:47:55 INFO - Return code: 0 17:47:55 INFO - Running post-action listener: _resource_record_post_action 17:47:55 INFO - Running post-action listener: _start_resource_monitoring 17:47:55 INFO - Starting resource monitoring. 17:47:55 INFO - [mozharness: 2017-09-28 00:47:55.129156Z] Finished create-virtualenv step (success) 17:47:55 INFO - [mozharness: 2017-09-28 00:47:55.129673Z] Running install step. 17:47:55 INFO - Running pre-action listener: _resource_record_pre_action 17:47:55 INFO - Running main action method: install 17:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:47:55 INFO - Reading from file tmpfile_stdout 17:47:55 INFO - Detecting whether we're running mozinstall >=1.0... 17:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:47:55 INFO - Reading from file tmpfile_stdout 17:47:55 INFO - Output received: 17:47:55 INFO - Usage: mozinstall [options] installer 17:47:55 INFO - Options: 17:47:55 INFO - -h, --help show this help message and exit 17:47:55 INFO - -d DEST, --destination=DEST 17:47:55 INFO - Directory to install application into. [default: 17:47:55 INFO - "/builds/slave/test"] 17:47:55 INFO - --app=APP Application being installed. [default: firefox] 17:47:55 INFO - mkdir: /builds/slave/test/build/application 17:47:55 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'] 17:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:48:13 INFO - Reading from file tmpfile_stdout 17:48:13 INFO - Output received: 17:48:13 INFO - /builds/slave/test/build/application/firefox/firefox 17:48:13 INFO - Running post-action listener: _resource_record_post_action 17:48:13 INFO - [mozharness: 2017-09-28 00:48:13.412171Z] Finished install step (success) 17:48:13 INFO - [mozharness: 2017-09-28 00:48:13.412317Z] Running setup-mitmproxy step. 17:48:13 INFO - Running pre-action listener: _resource_record_pre_action 17:48:13 INFO - Running main action method: setup_mitmproxy 17:48:13 INFO - Skipping: mitmproxy is not required 17:48:13 INFO - Running post-action listener: _resource_record_post_action 17:48:13 INFO - [mozharness: 2017-09-28 00:48:13.412862Z] Finished setup-mitmproxy step (success) 17:48:13 INFO - [mozharness: 2017-09-28 00:48:13.412966Z] Running run-tests step. 17:48:13 INFO - Running pre-action listener: _resource_record_pre_action 17:48:13 INFO - Running pre-action listener: _set_gcov_prefix 17:48:13 INFO - Running main action method: run_tests 17:48:13 WARNING - Try message not found. 17:48:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:48:13 INFO - Python 2.7.3 17:48:13 INFO - Return code: 0 17:48:13 INFO - grabbing minidump binary from tooltool 17:48:13 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')]} 17:48:13 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 0x29f1d60>, '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 0x29f2a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f2ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:48:13 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 17:48:13 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 17:48:13 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 17:48:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:48:13 INFO - Return code: 0 17:48:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:48:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:48:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:48:13 INFO - ENV: RUST_BACKTRACE is now full 17:48:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:48:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:48:13 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/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 17:48:13 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/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 17:48:13 INFO - Using env: {'DISPLAY': ':0', 17:48:13 INFO - 'HOME': '/home/cltbld', 17:48:13 INFO - 'LANG': 'en_US.UTF-8', 17:48:13 INFO - 'LANGUAGE': 'en_US:en', 17:48:13 INFO - 'LOGNAME': 'cltbld', 17:48:13 INFO - 'MAIL': '/var/mail/cltbld', 17:48:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:48:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:48:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:13 INFO - 'MOZ_NO_REMOTE': '1', 17:48:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:48:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:13 INFO - 'NO_EM_RESTART': '1', 17:48:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:13 INFO - 'PWD': '/builds/slave/test', 17:48:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:48:13 INFO - 'RUST_BACKTRACE': 'full', 17:48:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:48:13 INFO - 'SHELL': '/bin/bash', 17:48:13 INFO - 'SHLVL': '1', 17:48:13 INFO - 'TERM': 'linux', 17:48:13 INFO - 'TMOUT': '86400', 17:48:13 INFO - 'USER': 'cltbld', 17:48:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:48:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:13 INFO - '_': '/tools/buildbot/bin/python'} 17:48:13 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/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 17:48:13 INFO - mozversion application_buildid: 20170927235256 17:48:13 INFO - mozversion application_changeset: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 17:48:13 INFO - mozversion application_display_name: Nightly 17:48:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:48:13 INFO - mozversion application_name: Firefox 17:48:13 INFO - mozversion application_remotingname: firefox 17:48:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:48:13 INFO - mozversion application_vendor: Mozilla 17:48:13 INFO - mozversion application_version: 58.0a1 17:48:13 INFO - mozversion platform_buildid: 20170927235256 17:48:13 INFO - mozversion platform_changeset: 5ebe2e8980c6fd3ede2b6617bbbc4073dd9b0369 17:48:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:48:13 INFO - mozversion platform_version: 58.0a1 17:48:13 INFO - using testdate: 1506559693 17:48:13 INFO - actual date: 1506559693 17:48:13 INFO - starting webserver on 'localhost:55751' 17:48:13 INFO - SUITE-START | Running 2 tests 17:48:13 INFO - TEST-START | dromaeo_css 17:48:13 INFO - Initialising browser for dromaeo_css test... 17:48:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55751/getInfo.html -profile /tmp/tmpVlfyFZ/profile 17:48:13 INFO - TEST-INFO | started process 17933 (/builds/slave/test/build/application/firefox/firefox http://localhost:55751/getInfo.html) 17:48:19 INFO - TEST-INFO | 17933: exit 0 17:48:19 INFO - Browser initialized. 17:48:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:48:19 INFO - Using env: {'DISPLAY': ':0', 17:48:19 INFO - 'HOME': '/home/cltbld', 17:48:19 INFO - 'JSGC_DISABLE_POISONING': '1', 17:48:19 INFO - 'LANG': 'en_US.UTF-8', 17:48:19 INFO - 'LANGUAGE': 'en_US:en', 17:48:19 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 17:48:19 INFO - 'LOGNAME': 'cltbld', 17:48:19 INFO - 'MAIL': '/var/mail/cltbld', 17:48:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:48:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:48:19 INFO - 'MOZ_CRASHREPORTER': '1', 17:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:48:19 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 17:48:19 INFO - 'MOZ_NO_REMOTE': '1', 17:48:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:48:19 INFO - 'NO_EM_RESTART': '1', 17:48:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:48:19 INFO - 'PWD': '/builds/slave/test', 17:48:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:48:19 INFO - 'RUST_BACKTRACE': 'full', 17:48:19 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:48:19 INFO - 'SHELL': '/bin/bash', 17:48:19 INFO - 'SHLVL': '1', 17:48:19 INFO - 'STYLO_FORCE_DISABLED': '1', 17:48:19 INFO - 'TERM': 'linux', 17:48:19 INFO - 'TMOUT': '86400', 17:48:19 INFO - 'USER': 'cltbld', 17:48:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 17:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:48:19 INFO - '_': '/tools/buildbot/bin/python'} 17:48:19 INFO - TEST-INFO | started process 18169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVlfyFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:20 INFO - PID 18169 | 17:48:20 INFO - PID 18169 | (/builds/slave/test/build/application/firefox/firefox:18219): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:48:20 INFO - PID 18169 | 17:48:31 INFO - PID 18169 | RSS: Main: 151429120 17:48:31 INFO - PID 18169 | 17:51:27 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55751/tests/dromaeo/cssquery-ext.html) 17:51:28 INFO - PID 18169 | RSS: Main: 149848064 17:51:28 INFO - PID 18169 | 17:54:30 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-ext.html (next: http://localhost:55751/tests/dromaeo/cssquery-jquery.html) 17:54:31 INFO - PID 18169 | RSS: Main: 151175168 17:54:31 INFO - PID 18169 | 17:57:32 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55751/tests/dromaeo/cssquery-mootools.html) 17:57:33 INFO - PID 18169 | RSS: Main: 151535616 17:57:33 INFO - PID 18169 | 18:00:35 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55751/tests/dromaeo/cssquery-prototype.html) 18:00:35 INFO - PID 18169 | RSS: Main: 149975040 18:00:35 INFO - PID 18169 | 18:03:39 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55751/tests/dromaeo/cssquery-yui.html) 18:03:39 INFO - PID 18169 | RSS: Main: 154374144 18:03:39 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | Cycle 1(1): loaded http://localhost:55751/tests/dromaeo/cssquery-yui.html (next: http://localhost:55751/tests/dromaeo/cssquery-dojo.html) 18:06:41 INFO - PID 18169 | RSS: Main: 154689536 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | __start_tp_report 18:06:41 INFO - PID 18169 | _x_x_mozilla_page_load 18:06:41 INFO - PID 18169 | _x_x_mozilla_page_load_details 18:06:41 INFO - PID 18169 | |i|pagename|runs| 18:06:41 INFO - PID 18169 | |0;dojo.html;3173.174974506628;3207.9198020049494;3214.8392580370974;3218.0667606394145;3252.2844974105697;6109.480694141003;6216.5959212651205;6228.595141315811;6234.875302493947;6384.265809431911;6152.5693201475915;6154.723037463314;6192.752289908398;6209.472194863431;6232.750689972407;5688.345840228385;5712.143178523234;5728.455796699307;5741.885162296751;5856.47291743743;5746.051901436258;5748.913766293509;5803.506701930341;5811.825645230629;5815.418458154193;94.50126048417184;5785.2189954356045;5830.883382332351;5851.970740146293;5877.265341832271;5674.035413979634;5703.54371650267;5709.486146246816;5779.479846813765;5811.128330750379;5684;5696.3733989261145;5731.598788084836;5761.308642962829;5792.275965504312;6221.844453888643;6221.96889015552;6225.315215326311;6286.025666021774;6348.079528468346;6635.402813746738;6672.499562532781;6690.063391125246;6740.359665831738;6758.493113016543;6577.736890524373;6747.257801641816;6795.116634837489;6806.149231346082;6833.692483838239;6199.721012554401;6247.062940558907;6331.050342448623;6332.430081292706;6368.904466433008;6848.9657551711925;6868.313168683092;6942.271061538516;6963.651817409109;6965.686544105527;6537.411632952962;6572.704228309737;6623.07276981223;6625.635590042498;6660.267370589231;6506.991416330382;6627;6627.039079333566;6629.436497897733;6661.533692641468;6581.243157036906;6607.900881486781;6647.335266473314;6660.966695166493;6713.597184168965;6629.900551491732;6648.03603477493;6720.4287635550545;6734.326567343226;6750.054992301082;4870.366852309177;4897.363342765418;4923.679960802537;4925.162722337212;4937.679050861682;4216.936745948813;4307.07397909451;4319.805608747614;4329.328954012133;4334.111507141029;5702.116171993348;5757.88484230313;5800.564957628195;5805.216295800097;5806.274215723035;6605.70274337656;6696.330366963362;6785.660716964132;6789.830254243585;6812.557183783038;5616.129499927518;5711.971440142773;5730.541556675456;5814.738336774855;5819.73811178498;5656.575756818255;5686.97156514223;5765;5767.942320576824;5779.768809247667;6328.810135695937;6477.125588045647;6554.3117972613145;6573.802785916335;6576.572522786004;6614.536982411185;6617.53677242598;6656.968169933668;6730.730770769114;6735.225449073419;6468.482521398183;6481.060246264359;6557.803265902031;6560.114384558024;6576.342365763386;6464.838379040561;6509.349065093453;6539.247986481616;6541.182352205974;6547.410733034049;6619.172603424572;6665.9001264792705;6716.664166791738;6721.327867213435;6726.192856857208;6414.358564143548;6444.516661250331;6482.254540727688;6483.578567393104;6513.902291465537;6379.266384365857;6460.741570337133;6500.414962653384;6503.317151699003;6503.447206987459;6406.519511036598;6491.1236983008575;6491.156149700509;6493.318201588765;6534.673266336569;6545.967270163809;6556.704948277244;6595.835104122435;6604.933950660432;6616.371444712745;6294.087357333253;6320.051992201206;6375.489960803217;6379.840503987438;6400.839979000562 18:06:41 INFO - PID 18169 | |1;ext.html;875.7695437909739;879.2658130461065;886.9290456763458;896.2784958108724;921.6866265469739;39838.40242396363;40450.595494045054;40494;40527.392089118686;40545;36261.81869090651;36272.818635906784;36318.818405908;36469.270614587695;36525.634743652554;7296.160941491717;7416.517926334798;7421.183669796318;7422.331990120888;7424.294692004251;7320.194778574352;7353.558786472802;7389.963050184769;7393.3345998860095;7400.851982960337;7904.920950790504;8146;8147.470414423044;8150.75547733566;8154.714584989527;8028.157043510435;8052.2752952234;8080.111187769341;8096.635651395702;8100.432969692124;7821.726239581644;7970.4819186752675;7980.281774640311;7997.400194985399;8011.95994020032;37894;38104.618953810386;38142.42786358207;38212.61787382118;38349.80825095884;3537.0449978505917;3580.9283814323567;3584;3585.4084076127406;3586.33652774235;31721.206969825707;31795.364092718246;31880.20299492508;32029.1992700182;32156.517652235234;5229.712365819878;5238.633295669305;5251.789928402859;5253.9737301313635;5260.368755749335;191590;192250;193564;195346;195491;48933.51066489289;49190.262146067835;49423.25865112026;49489.50510494849;49785;51552.74223628933;51731;51777.7411112942;51790;51878.740606297484;16250.593735156715;16387.918060409622;16482.505524834272;16485.423010194827;16486.6702665946;13484.528041518695;13575.796363054562;13591.252481113435;13614.251216183206;13618.38717257706;14095.154290742588;14304.85695143056;14312.85687143136;14329.140251584939;14463.638409039859;5700.572457065737;5760.543673795689;5763.9135412968835;5767.509761670221;5845.473907348359;990.3364745620452;996.6960077176386;1007.2093406675724;1020.7907378987289;1031.2832581355885;21954.560908781736;22163;22292.55414891693;22377.440563985703;22554.210602628827;1103.5475455063386;1114.2701530497536;1118.1166878166157;1134.8921852424007;1135.2300387055723;12014.97872680832;12031.458584363725;12144.33206173669;12147.514099435924;12227.755444891052;223766;224472;225328;225444;225580;40246.39630405546;40835;51911.48088519142;53262.73368633132;53488.732556337745;1438.5252866554013;1457.5408746244898;1458.4749490183526;1467.9339429725687;1472.7790831375164;26507.867460662572;26872.462550748485;26969.460610787282;27180.456390872467;27376.72623273742;37626.62373376231;37676.2464750709;37718.8114059428;37809.432858507695;37827.432588510645;195203;196420;197100;197625;198244;33976.83011584926;34072.1481962943;34197.65802341945;34201.14497137492;34335.14162145966;40225;42257.78871105625;42428.151436971704;42483.575164249196;42626.78686606547;30658.386832262782;31244.843775780977;31350.52974205343;31487.52768708517;31502.527462088547;31554.842225788725;31625.5256171153;31695.36609267848;31821.20446988751;31911.521327179646;34848.47727284143;35347.29305413826;35429.1142721434;35455.64544354523;35461.11347216237;30812.845935770176;30857.382852343275;31016.53475197919;31198.68801311958;32056.679433206304;22807.543849122594;23037.424064398525;23185.420364491023;23398;23579.174728884405 18:06:41 INFO - PID 18169 | |2;jquery.html;581.1979468333699;590.1767034986192;594.2957595249627;607.5959486941184;624.1012941364436;22096.116155353786;22782.88608556957;22856.200032998848;22935.082596696113;22969.770302296973;22965.311040668767;22977.310680679606;23069.884650576725;23134.768652313473;23711.850426175395;6664.2002959644915;6753.966230168842;6793.490488213379;6794.558353707018;6801.251862295144;6659.467242620579;6744.325567443266;6749.763758268462;6876.7593134240315;7143.571385716874;7149.606771627558;7151.463640227003;7152.499325047223;7156.928430715704;7159.677814498334;6965.65171741416;7082.468814838908;7104.076470058885;7148.606826624534;7154.713811447536;7022.016917631536;7086.893696594555;7092.326229008236;7109.8933515997305;7112.933060040984;30239.395212095857;30633.693663063306;30634.23414414635;30663.693363066308;30718.38563228723;2073.6785798201304;2096.989515052415;2098.7691353951054;2103.5582527669208;2106.283863486422;19054.714179287323;19512.609747804963;19651.115699793543;19665.410037698894;19849.30527431533;2378.7383387827326;2393.234165067179;2437.183543512925;2451.056343307839;2457.1154384421593;129035;134400;139127.30436347856;145757.2712136443;150730.24634876754;19786.90106549487;20559.280425185047;21005.68491472629;21155.8942205288;22654.75398853079;42196.36705449421;42821.92945176333;42829.78585107055;42883.35674964878;43005;11075.944620277009;11142.944285278521;11226.494807733672;11238.831417528743;11303.208775385809;9187.356885018118;9240.122188392092;9330.673426430043;9343.159115679486;9400.482973436527;10883.346999180074;10953.397563134104;11098.944505277583;11156.944215278872;11569.537218511165;3742;3805.2708345820697;4330.404147766681;4332.480102387671;4454.017962006876;947.4599478297305;961.1397798969883;963.3208587945621;974.2985050763439;984.1585444444896;19253;19288.80711192898;19361.419157425298;19788.60422791565;20015.699764503544;1028.1825948371063;1032.5043978890023;1035.5961175141701;1043.1811028342715;1048.7220886465093;10762.461876906124;10807.729806754736;10816.351018938889;10992.340459572451;11240.044596209415;456912;462656;470001;489272;490682;109523.45238273758;115942;117166;118743;119105;1029.7013865978931;1105.3533682795494;1144.6035836279725;1174.7944109780753;1176.2883455509464;20066.19735210575;20436;20572.485687857923;20603.381898543066;20725.031122043383;55099.72450137723;55227.44772552223;56097;56202;57495.7125214388;68808.6559567199;68940.3105968934;69463.65268173626;69987;70357;19452.513687157934;19991.100400482304;20052.59894802125;20284.898575507617;20289.79710202879;22021.22925697593;22159.556808864054;22447.43881402978;22634.773652263266;22760.31719048431;17694.380696675555;17800.91099544494;18293.634127317113;18416.17127229251;18425.07874606291;16003.679926401639;16342.428015019417;16505.17474126313;16509.17454127313;16907.323707052074;18399.264029438673;18448.262069517605;18458.81541184571;18534.536636583653;18785.966771827134;19434.319798806973;19698.50753731168;19710.507237319183;19754.60490790205;19938;17970.460886173434;18020.639587208443;18129.184186711893;18145.727814083064;18180.81819181791 18:06:41 INFO - PID 18169 | |3;mootools.html;1315.7039666075132;1366.3603675589295;1367.0908845617664;1371.4856928651755;1372.0669944437782;14923.626909327273;15590.220488975549;15591.532254032398;15600.297986590602;15608.765868511982;15274.083554986708;15425.228738563083;15429.922850385732;15439.768403473929;15443.382264709426;2787.1499192746205;2826.8869245230167;2844.5590933405356;2845.260232339586;2867.268846444154;2788.5538313869783;2815.7747380209635;2824.6045553622507;2835.2061422801544;2836.7305106015;2484.35406794233;2773.0987429085626;2784.7076057013924;2794.762445192151;2811.0863969209986;2753.2703833484043;2767.3635063935208;2782.20707098477;2815.183596756938;2822.350859302372;2517.785988191006;2613.163787587973;2703.175531462903;2717.320669832542;2721.2788611018095;15211.923940380339;15305;15332;15344.616384590363;15367;8005.359571234288;8311.210435008665;8315.251627353508;8323.292520135796;8330.416870819045;5549.1676248562635;5680.886382272372;5694.572907031989;5807.245058142415;5862.472377486004;1954.8045195480338;1980.8118228768244;1993.6810110382414;2012;2030.309694703793;27342.316442088908;27387.31531711723;27535.586966195522;27551.035713750123;27556.173314800588;6609.504287178384;6874.5219777748025;6894.896576551356;7044.049053377831;7056.15326160864;17413.390531331344;17450.82549174492;17584.38454654081;17590.384336548414;17602.207900644502;7857.1357150713375;8029.1970802920405;8045.919540804517;8082.878756818653;8099.797505062421;7002.3697867192195;7317.890231646529;7441.702331906663;7499.737509187262;7503.512271702322;5169.224616307584;5294.7352632369;5348.304720386403;5352.91970620441;5372.597055220874;1473.992630036843;1491.828439729445;1501.3769285746293;1506.563096701966;1522.2464879884308;863.1368631368631;906.8821053263166;913.4519288426891;917.9403338783092;920.6593560382702;7789.298963093349;7791.4156438267355;7801.921980780119;7899.091604465445;7953.960230198928;699.0702365853402;707.6921539130494;709.7090193020837;712.7434123715458;723;4785.282207668877;4911.754412279443;5650.463205995424;5697.491068042531;5705.971470142623;20567.38297851067;22079.779202208094;22210;22215.22246721357;22236;20882.895585522278;21486.570268594853;21790.128394864343;22392.55214895693;22394.776052239267;11478.311301321948;11641;11645.184837061493;11692.415379231004;11703.414829258503;8159;8189.959050204711;8432.494050356998;8434.481174014412;8571.82856342882;18744.625107498046;19138;19545;19571.51071223231;19828.60342793165;19144.619136623234;19208.519787004876;19378.224871005565;19439.125239364545;19515.902420487808;11071;11095.167862410513;11133.55465781392;11152.330860148417;11189.72025699364;13941;13963.720725585228;14184.858151418353;14196.787048194079;14249.786253206417;11226;11357.37534435614;11361.488733006869;11544.538218471167;11592.88407115918;10847.186461015614;10847.728806779895;11008.559657613927;11104.167187461135;11268.549258029587;10231.897681023393;10265.743356415851;10333.534990925276;10378.844317335095;10380.377177369382;7486.625668716433;7738.148803631483;7744.883826742716;7775.805604859924;7870.09493908185;7514.586697731677;7714.382849372149;7865.174156713691;7878.487898286593;7938.841223175619 18:06:41 INFO - PID 18169 | |4;prototype.html;517.681625800133;521.2415934814844;547.6358221782514;554.7753159970214;556.2462862820878;6084.330723620398;6233.563650544464;6293.118963345135;6338.366163383659;6371.394717501841;6219.657918814475;6263.937360626393;6285.73713463154;6314.652694101823;6315.557910946236;5218.556422704075;5274.837316700154;5276.287701160332;5280.419153893069;5336.332958380202;4914.680545764531;5095.210242412413;5105.259737338084;5271.973640131813;5282.498162674539;5007.148784706608;5034.42104158021;5045.117104506715;5092.898142037157;5109.974450127745;4982.302477653131;4995.775190116454;5001.8249361272365;5011.523905228997;5027.245913113025;4535.682502224846;4545.636349092065;4563.498015218323;4578.130155270488;4602.424696912886;6164.137020817089;6204.937950620526;6226.688665566749;6229.1001244620375;6240.095186198021;5716.742746576414;5738.995675756768;5771.134329850514;5781.566382521328;5794.420557944214;6507.869842603169;6519.380658837403;6522.5760325578685;6579.967100164468;6619.238787539446;4916.434610019858;4926.950730492685;4953.504649535053;4966.180580204298;4983;6728.192616886005;6882.7591034313555;6895.655217239118;6911.308869113099;6999.650017499104;5026.4973502649445;5045.899082018339;5061.291419201241;5062.215356619657;5073.797048118107;5111.309973153651;5138.434772175057;5143.537081662668;5159.871003224949;5191.6884986900905;5620.831375058755;5723.513501352349;5754.4533269339345;5768.538516918637;5774.162746401832;6260.843478913063;6554.4756419487285;6581.80254592363;6647.767328143492;6665.700043498055;1672.3895778040928;1689.991550042242;1728.3345911824038;1745.9039752813462;1761.4803632928317;1201.6995751062234;1218.670958841108;1243.7450322683828;1250.693580072888;1251.4305990774176;5625.184348269478;5636.887262254732;5657.803341112341;5726.885462290731;5756.309242890796;6545.803625891231;6630.204375474974;6705.6982435790505;6753.49348798842;6798.252192258848;5719.628224165499;5748.9425105748405;5752.25220721312;5773.913391299134;5776.5089967352405;3492.3189977954057;3516.613172551017;3519.1378112362636;3535.4696795480368;3584.5160903277724;6452.064450654629;6508.707108180143;6537;6538;6598.241202261705;6796.946473296647;6818.761343352959;6871.415929646036;6873.621950792754;6882.483813713991;6509.674516274262;6597;6646.803575356482;6658.833529161713;6673.733050677918;6697.856685860478;6742.561733487308;6772.458203343819;6800.625965571941;6835.350641689031;6643.501737369813;6684.799456016132;6689.799306020827;6697.899531506934;6732.192136943598;6522.804315870531;6542.2149342077355;6579.407853293226;6580.407763301326;6581.703823328057;5025.949740502549;5036.722980236123;5038.722870242172;5052.69683818972;5059.519345662156;6442.677866106769;6621.33786621334;6691.933080669326;6746.797596072126;6797.830054248683;6286.177008667435;6379.393957574023;6492.935070649233;6559.114519539801;6589.4069533742195;6463.676816159079;6544.9672751635935;6545.2800191979795;6581.407673309425;6616.106825578678;6470.773522926675;6495.642739649365;6510.707018184288;6519.478441724746;6523.445507131947;6514.218293804774;6526.021096835512;6619.900701489385;6621.3047629998155;6693;6271.4669253114;6358.395952384516;6384.138141350858;6389.169407976933;6453.580517266362 18:06:41 INFO - PID 18169 | |5;yui.html;897.1432282170528;916.3310783128317;928.2481190235906;929.1126973740074;936.9203617692496;19378.70931936022;20453;20484.385468435972;20540.89729551354;20543;17987.280508779666;18146.727799083023;18229.908850455762;19441.902790486063;19654.606907861835;965.888922773883;978.8923218445965;983.695054533097;983.7393090830935;985.1084768284678;958.4105774948426;985.7929834734679;987.3631507677544;988.4217732626422;990.1039559198937;1057.5663977769116;1064.4837253931837;1064.5050051725946;1064.669952314785;1065.3820783945332;1046.7540128069973;1054.3146954479573;1054.3515737821263;1055.1400608504082;1056.7252514346249;728.6466063959028;744.2334395572515;748.3339827553482;748.5433885329944;749.4454103963083;19511.609767804708;19666.115024823917;19694.606107877906;19769.604607907906;19787.703184452246;21989.67015494769;22018.339449816533;22475.77524224753;22626.434339141488;22629.434264143365;17984.550386240448;18033.54916127094;18336.724949125775;18420;18471.630567388576;3746.2882052409955;3763.5860055393887;3766.5480142382817;3769.792661403622;3787.621237876218;142145;143788;144961;147553;148844;16801.663966720596;16903.23935422909;17202.483925482255;17244.655106897793;17286.308547658205;31534.863265632168;32110.839445802623;32290.515642265385;32319.51520727191;32347.35305293928;8794.252488538546;8863.955680221557;8931.464112153291;8951.239144672645;8976.910230897607;4465.821367145278;4567.3377360282575;4582.060677561092;4588.49526552079;4588.816447342136;5499.862503437446;5615.101583746581;5615.691136987423;5616;5617.971910140505;1022.4887556221889;1054.8048611006989;1058.4496062047692;1067.3542506783285;1073.1736562846565;688.4561196654587;688.8725585766649;697.5082566790401;709.6877373955443;713.4435140590348;11052.336859788438;11439.88560114405;11740.658000609703;12911.5480958166;13007.869921300666;671.5668393885916;672.1027428383065;683.962382068991;690.9585424874524;692.2281655953575;5592.328920529562;5700.489370316869;5772.3938986406665;5783.219265399117;5795.246617939641;118240;119737;122268;123376;123738.38130809469;110220;110280;110284;112623;117776.41111794386;90098.54950725204;91442.54278728696;91800;92601.5369923146;92850.53574732083;10780.946095269474;10941.343519388862;11115.555377784798;11157.66527004191;11288.887111129112;42700;43087;44393.780310983675;44770.10459790851;45504.31743523916;58388.70805645944;58637.706811467375;58949.115763264446;59410.40589594049;61196;13919;13955.860441395862;13968.930155349159;14362.784558231844;14401.351939162554;15817.762733559235;15862.44481443144;16014.039157650579;16112;16270.593235169215;15747.921260393625;15811;15855;15942.202889855229;15949.362025519313;14244.21656808844;14505.419783208554;14583.343749531085;14665.340059697126;14695.41218351254;14350.56948291511;14611.196384198545;14652.12087274767;14803.703925921636;14855.182964937032;12144.75710485803;12173.939130304647;12462;12529.37353132358;12654.87345126537;11308.7738245233;11568.884311157117;11672.766544669228;11685.182037257651;11908.987736042533 18:06:41 INFO - PID 18169 | __end_tp_report 18:06:41 INFO - PID 18169 | __start_cc_report 18:06:41 INFO - PID 18169 | _x_x_mozilla_cycle_collect,267 18:06:41 INFO - PID 18169 | __end_cc_report 18:06:41 INFO - PID 18169 | __startTimestamp1506560801490__endTimestamp 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | ------- Summary: start ------- 18:06:41 INFO - PID 18169 | Number of tests: 6 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#0] dojo.html Cycles:165 Average:6099.02 Median:6414.36 stddev:894.31 (13.9%) stddev-sans-first:867.10 18:06:41 INFO - PID 18169 | Values: 3173.2 3207.9 3214.8 3218.1 3252.3 6109.5 6216.6 6228.6 6234.9 6384.3 6152.6 6154.7 6192.8 6209.5 6232.8 5688.3 5712.1 5728.5 5741.9 5856.5 5746.1 5748.9 5803.5 5811.8 5815.4 94.5 5785.2 5830.9 5852.0 5877.3 5674.0 5703.5 5709.5 5779.5 5811.1 5684.0 5696.4 5731.6 5761.3 5792.3 6221.8 6222.0 6225.3 6286.0 6348.1 6635.4 6672.5 6690.1 6740.4 6758.5 6577.7 6747.3 6795.1 6806.1 6833.7 6199.7 6247.1 6331.1 6332.4 6368.9 6849.0 6868.3 6942.3 6963.7 6965.7 6537.4 6572.7 6623.1 6625.6 6660.3 6507.0 6627.0 6627.0 6629.4 6661.5 6581.2 6607.9 6647.3 6661.0 6713.6 6629.9 6648.0 6720.4 6734.3 6750.1 4870.4 4897.4 4923.7 4925.2 4937.7 4216.9 4307.1 4319.8 4329.3 4334.1 5702.1 5757.9 5800.6 5805.2 5806.3 6605.7 6696.3 6785.7 6789.8 6812.6 5616.1 5712.0 5730.5 5814.7 5819.7 5656.6 5687.0 5765.0 5767.9 5779.8 6328.8 6477.1 6554.3 6573.8 6576.6 6614.5 6617.5 6657.0 6730.7 6735.2 6468.5 6481.1 6557.8 6560.1 6576.3 6464.8 6509.3 6539.2 6541.2 6547.4 6619.2 6665.9 6716.7 6721.3 6726.2 6414.4 6444.5 6482.3 6483.6 6513.9 6379.3 6460.7 6500.4 6503.3 6503.4 6406.5 6491.1 6491.2 6493.3 6534.7 6546.0 6556.7 6595.8 6604.9 6616.4 6294.1 6320.1 6375.5 6379.8 6400.8 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#1] ext.html Cycles:180 Average:37264.71 Median:19483.08 stddev:53183.87 (273.0%) stddev-sans-first:53262.88 18:06:41 INFO - PID 18169 | Values: 875.8 879.3 886.9 896.3 921.7 39838.4 40450.6 40494.0 40527.4 40545.0 36261.8 36272.8 36318.8 36469.3 36525.6 7296.2 7416.5 7421.2 7422.3 7424.3 7320.2 7353.6 7390.0 7393.3 7400.9 7904.9 8146.0 8147.5 8150.8 8154.7 8028.2 8052.3 8080.1 8096.6 8100.4 7821.7 7970.5 7980.3 7997.4 8012.0 37894.0 38104.6 38142.4 38212.6 38349.8 3537.0 3580.9 3584.0 3585.4 3586.3 31721.2 31795.4 31880.2 32029.2 32156.5 5229.7 5238.6 5251.8 5254.0 5260.4 191590.0 192250.0 193564.0 195346.0 195491.0 48933.5 49190.3 49423.3 49489.5 49785.0 51552.7 51731.0 51777.7 51790.0 51878.7 16250.6 16387.9 16482.5 16485.4 16486.7 13484.5 13575.8 13591.3 13614.3 13618.4 14095.2 14304.9 14312.9 14329.1 14463.6 5700.6 5760.5 5763.9 5767.5 5845.5 990.3 996.7 1007.2 1020.8 1031.3 21954.6 22163.0 22292.6 22377.4 22554.2 1103.5 1114.3 1118.1 1134.9 1135.2 12015.0 12031.5 12144.3 12147.5 12227.8 223766.0 224472.0 225328.0 225444.0 225580.0 40246.4 40835.0 51911.5 53262.7 53488.7 1438.5 1457.5 1458.5 1467.9 1472.8 26507.9 26872.5 26969.5 27180.5 27376.7 37626.6 37676.2 37718.8 37809.4 37827.4 195203.0 196420.0 197100.0 197625.0 198244.0 33976.8 34072.1 34197.7 34201.1 34335.1 40225.0 42257.8 42428.2 42483.6 42626.8 30658.4 31244.8 31350.5 31487.5 31502.5 31554.8 31625.5 31695.4 31821.2 31911.5 34848.5 35347.3 35429.1 35455.6 35461.1 30812.8 30857.4 31016.5 31198.7 32056.7 22807.5 23037.4 23185.4 23398.0 23579.2 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#2] jquery.html Cycles:180 Average:35509.85 Median:22127.84 stddev:80011.24 (361.6%) stddev-sans-first:80192.71 18:06:41 INFO - PID 18169 | Values: 581.2 590.2 594.3 607.6 624.1 22096.1 22782.9 22856.2 22935.1 22969.8 22965.3 22977.3 23069.9 23134.8 23711.9 6664.2 6754.0 6793.5 6794.6 6801.3 6659.5 6744.3 6749.8 6876.8 7143.6 7149.6 7151.5 7152.5 7156.9 7159.7 6965.7 7082.5 7104.1 7148.6 7154.7 7022.0 7086.9 7092.3 7109.9 7112.9 30239.4 30633.7 30634.2 30663.7 30718.4 2073.7 2097.0 2098.8 2103.6 2106.3 19054.7 19512.6 19651.1 19665.4 19849.3 2378.7 2393.2 2437.2 2451.1 2457.1 129035.0 134400.0 139127.3 145757.3 150730.2 19786.9 20559.3 21005.7 21155.9 22654.8 42196.4 42821.9 42829.8 42883.4 43005.0 11075.9 11142.9 11226.5 11238.8 11303.2 9187.4 9240.1 9330.7 9343.2 9400.5 10883.3 10953.4 11098.9 11156.9 11569.5 3742.0 3805.3 4330.4 4332.5 4454.0 947.5 961.1 963.3 974.3 984.2 19253.0 19288.8 19361.4 19788.6 20015.7 1028.2 1032.5 1035.6 1043.2 1048.7 10762.5 10807.7 10816.4 10992.3 11240.0 456912.0 462656.0 470001.0 489272.0 490682.0 109523.5 115942.0 117166.0 118743.0 119105.0 1029.7 1105.4 1144.6 1174.8 1176.3 20066.2 20436.0 20572.5 20603.4 20725.0 55099.7 55227.4 56097.0 56202.0 57495.7 68808.7 68940.3 69463.7 69987.0 70357.0 19452.5 19991.1 20052.6 20284.9 20289.8 22021.2 22159.6 22447.4 22634.8 22760.3 17694.4 17800.9 18293.6 18416.2 18425.1 16003.7 16342.4 16505.2 16509.2 16907.3 18399.3 18448.3 18458.8 18534.5 18786.0 19434.3 19698.5 19710.5 19754.6 19938.0 17970.5 18020.6 18129.2 18145.7 18180.8 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#3] mootools.html Cycles:180 Average:9501.69 Median:15031.80 stddev:6819.89 (45.4%) stddev-sans-first:6811.29 18:06:41 INFO - PID 18169 | Values: 1315.7 1366.4 1367.1 1371.5 1372.1 14923.6 15590.2 15591.5 15600.3 15608.8 15274.1 15425.2 15429.9 15439.8 15443.4 2787.1 2826.9 2844.6 2845.3 2867.3 2788.6 2815.8 2824.6 2835.2 2836.7 2484.4 2773.1 2784.7 2794.8 2811.1 2753.3 2767.4 2782.2 2815.2 2822.4 2517.8 2613.2 2703.2 2717.3 2721.3 15211.9 15305.0 15332.0 15344.6 15367.0 8005.4 8311.2 8315.3 8323.3 8330.4 5549.2 5680.9 5694.6 5807.2 5862.5 1954.8 1980.8 1993.7 2012.0 2030.3 27342.3 27387.3 27535.6 27551.0 27556.2 6609.5 6874.5 6894.9 7044.0 7056.2 17413.4 17450.8 17584.4 17590.4 17602.2 7857.1 8029.2 8045.9 8082.9 8099.8 7002.4 7317.9 7441.7 7499.7 7503.5 5169.2 5294.7 5348.3 5352.9 5372.6 1474.0 1491.8 1501.4 1506.6 1522.2 863.1 906.9 913.5 917.9 920.7 7789.3 7791.4 7801.9 7899.1 7954.0 699.1 707.7 709.7 712.7 723.0 4785.3 4911.8 5650.5 5697.5 5706.0 20567.4 22079.8 22210.0 22215.2 22236.0 20882.9 21486.6 21790.1 22392.6 22394.8 11478.3 11641.0 11645.2 11692.4 11703.4 8159.0 8190.0 8432.5 8434.5 8571.8 18744.6 19138.0 19545.0 19571.5 19828.6 19144.6 19208.5 19378.2 19439.1 19515.9 11071.0 11095.2 11133.6 11152.3 11189.7 13941.0 13963.7 14184.9 14196.8 14249.8 11226.0 11357.4 11361.5 11544.5 11592.9 10847.2 10847.7 11008.6 11104.2 11268.5 10231.9 10265.7 10333.5 10378.8 10380.4 7486.6 7738.1 7744.9 7775.8 7870.1 7514.6 7714.4 7865.2 7878.5 7938.8 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#4] prototype.html Cycles:180 Average:5548.70 Median:6231.33 stddev:1544.60 (24.8%) stddev-sans-first:1502.07 18:06:41 INFO - PID 18169 | Values: 517.7 521.2 547.6 554.8 556.2 6084.3 6233.6 6293.1 6338.4 6371.4 6219.7 6263.9 6285.7 6314.7 6315.6 5218.6 5274.8 5276.3 5280.4 5336.3 4914.7 5095.2 5105.3 5272.0 5282.5 5007.1 5034.4 5045.1 5092.9 5110.0 4982.3 4995.8 5001.8 5011.5 5027.2 4535.7 4545.6 4563.5 4578.1 4602.4 6164.1 6204.9 6226.7 6229.1 6240.1 5716.7 5739.0 5771.1 5781.6 5794.4 6507.9 6519.4 6522.6 6580.0 6619.2 4916.4 4927.0 4953.5 4966.2 4983.0 6728.2 6882.8 6895.7 6911.3 6999.7 5026.5 5045.9 5061.3 5062.2 5073.8 5111.3 5138.4 5143.5 5159.9 5191.7 5620.8 5723.5 5754.5 5768.5 5774.2 6260.8 6554.5 6581.8 6647.8 6665.7 1672.4 1690.0 1728.3 1745.9 1761.5 1201.7 1218.7 1243.7 1250.7 1251.4 5625.2 5636.9 5657.8 5726.9 5756.3 6545.8 6630.2 6705.7 6753.5 6798.3 5719.6 5748.9 5752.3 5773.9 5776.5 3492.3 3516.6 3519.1 3535.5 3584.5 6452.1 6508.7 6537.0 6538.0 6598.2 6796.9 6818.8 6871.4 6873.6 6882.5 6509.7 6597.0 6646.8 6658.8 6673.7 6697.9 6742.6 6772.5 6800.6 6835.4 6643.5 6684.8 6689.8 6697.9 6732.2 6522.8 6542.2 6579.4 6580.4 6581.7 5025.9 5036.7 5038.7 5052.7 5059.5 6442.7 6621.3 6691.9 6746.8 6797.8 6286.2 6379.4 6492.9 6559.1 6589.4 6463.7 6545.0 6545.3 6581.4 6616.1 6470.8 6495.6 6510.7 6519.5 6523.4 6514.2 6526.0 6619.9 6621.3 6693.0 6271.5 6358.4 6384.1 6389.2 6453.6 18:06:41 INFO - PID 18169 | 18:06:41 INFO - PID 18169 | [#5] yui.html Cycles:180 Average:24495.23 Median:19583.11 stddev:35844.11 (183.0%) stddev-sans-first:35900.87 18:06:41 INFO - PID 18169 | Values: 897.1 916.3 928.2 929.1 936.9 19378.7 20453.0 20484.4 20540.9 20543.0 17987.3 18146.7 18229.9 19441.9 19654.6 965.9 978.9 983.7 983.7 985.1 958.4 985.8 987.4 988.4 990.1 1057.6 1064.5 1064.5 1064.7 1065.4 1046.8 1054.3 1054.4 1055.1 1056.7 728.6 744.2 748.3 748.5 749.4 19511.6 19666.1 19694.6 19769.6 19787.7 21989.7 22018.3 22475.8 22626.4 22629.4 17984.6 18033.5 18336.7 18420.0 18471.6 3746.3 3763.6 3766.5 3769.8 3787.6 142145.0 143788.0 144961.0 147553.0 148844.0 16801.7 16903.2 17202.5 17244.7 17286.3 31534.9 32110.8 32290.5 32319.5 32347.4 8794.3 8864.0 8931.5 8951.2 8976.9 4465.8 4567.3 4582.1 4588.5 4588.8 5499.9 5615.1 5615.7 5616.0 5618.0 1022.5 1054.8 1058.4 1067.4 1073.2 688.5 688.9 697.5 709.7 713.4 11052.3 11439.9 11740.7 12911.5 13007.9 671.6 672.1 684.0 691.0 692.2 5592.3 5700.5 5772.4 5783.2 5795.2 118240.0 119737.0 122268.0 123376.0 123738.4 110220.0 110280.0 110284.0 112623.0 117776.4 90098.5 91442.5 91800.0 92601.5 92850.5 10780.9 10941.3 11115.6 11157.7 11288.9 42700.0 43087.0 44393.8 44770.1 45504.3 58388.7 58637.7 58949.1 59410.4 61196.0 13919.0 13955.9 13968.9 14362.8 14401.4 15817.8 15862.4 16014.0 16112.0 16270.6 15747.9 15811.0 15855.0 15942.2 15949.4 14244.2 14505.4 14583.3 14665.3 14695.4 14350.6 14611.2 14652.1 14803.7 14855.2 12144.8 12173.9 12462.0 12529.4 12654.9 11308.8 11568.9 11672.8 11685.2 11909.0 18:06:41 INFO - PID 18169 | -------- Summary: end -------- 18:06:41 INFO - PID 18169 | 18:06:42 INFO - TEST-INFO | 18169: exit 0 18:06:42 INFO - TEST-OK | dromaeo_css | took 1108257ms 18:06:42 INFO - TEST-START | kraken 18:06:42 INFO - Initialising browser for kraken test... 18:06:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55751/getInfo.html -profile /tmp/tmp2W5GXb/profile 18:06:42 INFO - TEST-INFO | started process 18527 (/builds/slave/test/build/application/firefox/firefox http://localhost:55751/getInfo.html) 18:06:47 INFO - TEST-INFO | 18527: exit 0 18:06:47 INFO - Browser initialized. 18:06:47 INFO - Running cycle 1/1 for kraken test... 18:06:47 INFO - Using env: {'DISPLAY': ':0', 18:06:47 INFO - 'HOME': '/home/cltbld', 18:06:47 INFO - 'JSGC_DISABLE_POISONING': '1', 18:06:47 INFO - 'LANG': 'en_US.UTF-8', 18:06:47 INFO - 'LANGUAGE': 'en_US:en', 18:06:47 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 18:06:47 INFO - 'LOGNAME': 'cltbld', 18:06:47 INFO - 'MAIL': '/var/mail/cltbld', 18:06:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:06:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:06:47 INFO - 'MOZ_CRASHREPORTER': '1', 18:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:06:47 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 18:06:47 INFO - 'MOZ_NO_REMOTE': '1', 18:06:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:06:47 INFO - 'NO_EM_RESTART': '1', 18:06:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:06:47 INFO - 'PWD': '/builds/slave/test', 18:06:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:06:47 INFO - 'RUST_BACKTRACE': 'full', 18:06:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:06:47 INFO - 'SHELL': '/bin/bash', 18:06:47 INFO - 'SHLVL': '1', 18:06:47 INFO - 'STYLO_FORCE_DISABLED': '1', 18:06:47 INFO - 'TERM': 'linux', 18:06:47 INFO - 'TMOUT': '86400', 18:06:47 INFO - 'USER': 'cltbld', 18:06:47 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792', 18:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:06:47 INFO - '_': '/tools/buildbot/bin/python'} 18:06:47 INFO - TEST-INFO | started process 18761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2W5GXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:06:48 INFO - PID 18761 | 18:06:48 INFO - PID 18761 | (/builds/slave/test/build/application/firefox/firefox:18811): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:06:48 INFO - PID 18761 | 18:06:58 INFO - PID 18761 | RSS: Main: 152264704 18:06:58 INFO - PID 18761 | 18:07:01 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55751/tests/kraken/driver.html?testName=audio-beat-detection) 18:07:02 INFO - PID 18761 | RSS: Main: 158707712 18:07:02 INFO - PID 18761 | 18:07:05 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55751/tests/kraken/driver.html?testName=audio-dft) 18:07:05 INFO - PID 18761 | RSS: Main: 158969856 18:07:05 INFO - PID 18761 | 18:07:08 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55751/tests/kraken/driver.html?testName=audio-fft) 18:07:09 INFO - PID 18761 | RSS: Main: 154353664 18:07:09 INFO - PID 18761 | 18:07:11 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55751/tests/kraken/driver.html?testName=audio-oscillator) 18:07:11 INFO - PID 18761 | RSS: Main: 155848704 18:07:11 INFO - PID 18761 | 18:07:14 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55751/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:07:14 INFO - PID 18761 | RSS: Main: 155631616 18:07:14 INFO - PID 18761 | 18:07:17 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55751/tests/kraken/driver.html?testName=imaging-darkroom) 18:07:18 INFO - PID 18761 | RSS: Main: 158031872 18:07:18 INFO - PID 18761 | 18:07:22 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55751/tests/kraken/driver.html?testName=imaging-desaturate) 18:07:22 INFO - PID 18761 | RSS: Main: 158253056 18:07:22 INFO - PID 18761 | 18:07:25 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55751/tests/kraken/driver.html?testName=json-parse-financial) 18:07:26 INFO - PID 18761 | RSS: Main: 158351360 18:07:26 INFO - PID 18761 | 18:07:27 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55751/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:07:28 INFO - PID 18761 | RSS: Main: 158560256 18:07:28 INFO - PID 18761 | 18:07:30 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:07:30 INFO - PID 18761 | RSS: Main: 158695424 18:07:30 INFO - PID 18761 | 18:07:32 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:07:33 INFO - PID 18761 | RSS: Main: 155926528 18:07:33 INFO - PID 18761 | 18:07:36 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:07:36 INFO - PID 18761 | RSS: Main: 155971584 18:07:36 INFO - PID 18761 | 18:07:39 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:07:40 INFO - PID 18761 | RSS: Main: 155766784 18:07:40 INFO - PID 18761 | 18:07:41 INFO - PID 18761 | Cycle 1(1): loaded http://localhost:55751/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55751/tests/kraken/driver.html?testName=ai-astar) 18:07:42 INFO - PID 18761 | RSS: Main: 156835840 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | __start_tp_report 18:07:42 INFO - PID 18761 | _x_x_mozilla_page_load 18:07:42 INFO - PID 18761 | _x_x_mozilla_page_load_details 18:07:42 INFO - PID 18761 | |i|pagename|runs| 18:07:42 INFO - PID 18761 | |0;ai-astar;109;110;108;108;108;97;108;108;106;107 18:07:42 INFO - PID 18761 | |1;audio-beat-detection;125;120;117;119;118;119;149;118;117;128 18:07:42 INFO - PID 18761 | |2;audio-dft;164;164;165;162;162;162;164;167;166;167 18:07:42 INFO - PID 18761 | |3;audio-fft;74;75;75;74;76;78;75;76;75;75 18:07:42 INFO - PID 18761 | |4;audio-oscillator;79;80;79;78;80;78;80;79;79;78 18:07:42 INFO - PID 18761 | |5;imaging-gaussian-blur;114;114;111;113;115;113;114;115;114;116 18:07:42 INFO - PID 18761 | |6;imaging-darkroom;157;149;149;148;147;151;149;149;149;149 18:07:42 INFO - PID 18761 | |7;imaging-desaturate;97;94;96;94;93;94;94;94;97;97 18:07:42 INFO - PID 18761 | |8;json-parse-financial;52;51;52;52;52;50;52;50;51;51 18:07:42 INFO - PID 18761 | |9;json-stringify-tinderbox;36;37;37;41;37;37;37;38;37;38 18:07:42 INFO - PID 18761 | |10;stanford-crypto-aes;74;73;83;78;76;76;79;77;72;73 18:07:42 INFO - PID 18761 | |11;stanford-crypto-ccm;112;109;112;117;113;114;113;108;114;112 18:07:42 INFO - PID 18761 | |12;stanford-crypto-pbkdf2;167;163;173;166;162;164;161;158;164;178 18:07:42 INFO - PID 18761 | |13;stanford-crypto-sha256-iterative;65;75;64;69;70;71;68;63;63;65 18:07:42 INFO - PID 18761 | __end_tp_report 18:07:42 INFO - PID 18761 | __start_cc_report 18:07:42 INFO - PID 18761 | _x_x_mozilla_cycle_collect,710 18:07:42 INFO - PID 18761 | __end_cc_report 18:07:42 INFO - PID 18761 | __startTimestamp1506560862172__endTimestamp 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | ------- Summary: start ------- 18:07:42 INFO - PID 18761 | Number of tests: 14 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#0] ai-astar Cycles:10 Average:106.90 Median:108.00 stddev:3.63 (3.4%) stddev-sans-first:3.77 18:07:42 INFO - PID 18761 | Values: 109.0 110.0 108.0 108.0 108.0 97.0 108.0 108.0 106.0 107.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#1] audio-beat-detection Cycles:10 Average:123.00 Median:119.50 stddev:9.82 (8.2%) stddev-sans-first:10.39 18:07:42 INFO - PID 18761 | Values: 125.0 120.0 117.0 119.0 118.0 119.0 149.0 118.0 117.0 128.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:1.95 (1.2%) stddev-sans-first:2.06 18:07:42 INFO - PID 18761 | Values: 164.0 164.0 165.0 162.0 162.0 162.0 164.0 167.0 166.0 167.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#3] audio-fft Cycles:10 Average:75.30 Median:75.00 stddev:1.16 (1.5%) stddev-sans-first:1.13 18:07:42 INFO - PID 18761 | Values: 74.0 75.0 75.0 74.0 76.0 78.0 75.0 76.0 75.0 75.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#4] audio-oscillator Cycles:10 Average:79.00 Median:79.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 18:07:42 INFO - PID 18761 | Values: 79.0 80.0 79.0 78.0 80.0 78.0 80.0 79.0 79.0 78.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:1.37 (1.2%) stddev-sans-first:1.45 18:07:42 INFO - PID 18761 | Values: 114.0 114.0 111.0 113.0 115.0 113.0 114.0 115.0 114.0 116.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:149.00 stddev:2.75 (1.8%) stddev-sans-first:1.05 18:07:42 INFO - PID 18761 | Values: 157.0 149.0 149.0 148.0 147.0 151.0 149.0 149.0 149.0 149.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.56 (1.6%) stddev-sans-first:1.48 18:07:42 INFO - PID 18761 | Values: 97.0 94.0 96.0 94.0 93.0 94.0 94.0 94.0 97.0 97.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 18:07:42 INFO - PID 18761 | Values: 52.0 51.0 52.0 52.0 52.0 50.0 52.0 50.0 51.0 51.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#9] json-stringify-tinderbox Cycles:10 Average:37.50 Median:37.00 stddev:1.35 (3.7%) stddev-sans-first:1.32 18:07:42 INFO - PID 18761 | Values: 36.0 37.0 37.0 41.0 37.0 37.0 37.0 38.0 37.0 38.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.50 stddev:3.35 (4.4%) stddev-sans-first:3.46 18:07:42 INFO - PID 18761 | Values: 74.0 73.0 83.0 78.0 76.0 76.0 79.0 77.0 72.0 73.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#11] stanford-crypto-ccm Cycles:10 Average:112.40 Median:113.00 stddev:2.55 (2.3%) stddev-sans-first:2.70 18:07:42 INFO - PID 18761 | Values: 112.0 109.0 112.0 117.0 113.0 114.0 113.0 108.0 114.0 112.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:5.91 (3.6%) stddev-sans-first:6.25 18:07:42 INFO - PID 18761 | Values: 167.0 163.0 173.0 166.0 162.0 164.0 161.0 158.0 164.0 178.0 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.50 stddev:3.97 (5.8%) stddev-sans-first:4.13 18:07:42 INFO - PID 18761 | Values: 65.0 75.0 64.0 69.0 70.0 71.0 68.0 63.0 63.0 65.0 18:07:42 INFO - PID 18761 | -------- Summary: end -------- 18:07:42 INFO - PID 18761 | 18:07:42 INFO - PID 18761 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:07:42 INFO - TEST-INFO | 18761: exit 0 18:07:42 INFO - TEST-OK | kraken | took 60849ms 18:07:42 INFO - SUITE-END | took 1169s 18:07:43 INFO - Completed test suite (00:19:29) 18:07:43 INFO - javascript benchmark 18:07:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8623.900687367657, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.174974506628, 3207.9198020049494, 3214.8392580370974, 3218.0667606394145, 3252.2844974105697, 6109.480694141003, 6216.5959212651205, 6228.595141315811, 6234.875302493947, 6384.265809431911, 6152.5693201475915, 6154.723037463314, 6192.752289908398, 6209.472194863431, 6232.750689972407, 5688.345840228385, 5712.143178523234, 5728.455796699307, 5741.885162296751, 5856.47291743743, 5746.051901436258, 5748.913766293509, 5803.506701930341, 5811.825645230629, 5815.418458154193, 94.50126048417184, 5785.2189954356045, 5830.883382332351, 5851.970740146293, 5877.265341832271, 5674.035413979634, 5703.54371650267, 5709.486146246816, 5779.479846813765, 5811.128330750379, 5684.0, 5696.3733989261145, 5731.598788084836, 5761.308642962829, 5792.275965504312, 6221.844453888643, 6221.96889015552, 6225.315215326311, 6286.025666021774, 6348.079528468346, 6635.402813746738, 6672.499562532781, 6690.063391125246, 6740.359665831738, 6758.493113016543, 6577.736890524373, 6747.257801641816, 6795.116634837489, 6806.149231346082, 6833.692483838239, 6199.721012554401, 6247.062940558907, 6331.050342448623, 6332.430081292706, 6368.904466433008, 6848.9657551711925, 6868.313168683092, 6942.271061538516, 6963.651817409109, 6965.686544105527, 6537.411632952962, 6572.704228309737, 6623.07276981223, 6625.635590042498, 6660.267370589231, 6506.991416330382, 6627.0, 6627.039079333566, 6629.436497897733, 6661.533692641468, 6581.243157036906, 6607.900881486781, 6647.335266473314, 6660.966695166493, 6713.597184168965, 6629.900551491732, 6648.03603477493, 6720.4287635550545, 6734.326567343226, 6750.054992301082, 4870.366852309177, 4897.363342765418, 4923.679960802537, 4925.162722337212, 4937.679050861682, 4216.936745948813, 4307.07397909451, 4319.805608747614, 4329.328954012133, 4334.111507141029, 5702.116171993348, 5757.88484230313, 5800.564957628195, 5805.216295800097, 5806.274215723035, 6605.70274337656, 6696.330366963362, 6785.660716964132, 6789.830254243585, 6812.557183783038, 5616.129499927518, 5711.971440142773, 5730.541556675456, 5814.738336774855, 5819.73811178498, 5656.575756818255, 5686.97156514223, 5765.0, 5767.942320576824, 5779.768809247667, 6328.810135695937, 6477.125588045647, 6554.3117972613145, 6573.802785916335, 6576.572522786004, 6614.536982411185, 6617.53677242598, 6656.968169933668, 6730.730770769114, 6735.225449073419, 6468.482521398183, 6481.060246264359, 6557.803265902031, 6560.114384558024, 6576.342365763386, 6464.838379040561, 6509.349065093453, 6539.247986481616, 6541.182352205974, 6547.410733034049, 6619.172603424572, 6665.9001264792705, 6716.664166791738, 6721.327867213435, 6726.192856857208, 6414.358564143548, 6444.516661250331, 6482.254540727688, 6483.578567393104, 6513.902291465537, 6379.266384365857, 6460.741570337133, 6500.414962653384, 6503.317151699003, 6503.447206987459, 6406.519511036598, 6491.1236983008575, 6491.156149700509, 6493.318201588765, 6534.673266336569, 6545.967270163809, 6556.704948277244, 6595.835104122435, 6604.933950660432, 6616.371444712745, 6294.087357333253, 6320.051992201206, 6375.489960803217, 6379.840503987438, 6400.839979000562], "value": 6034.369421856096, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.7695437909739, 879.2658130461065, 886.9290456763458, 896.2784958108724, 921.6866265469739, 39838.40242396363, 40450.595494045054, 40494.0, 40527.392089118686, 40545.0, 36261.81869090651, 36272.818635906784, 36318.818405908, 36469.270614587695, 36525.634743652554, 7296.160941491717, 7416.517926334798, 7421.183669796318, 7422.331990120888, 7424.294692004251, 7320.194778574352, 7353.558786472802, 7389.963050184769, 7393.3345998860095, 7400.851982960337, 7904.920950790504, 8146.0, 8147.470414423044, 8150.75547733566, 8154.714584989527, 8028.157043510435, 8052.2752952234, 8080.111187769341, 8096.635651395702, 8100.432969692124, 7821.726239581644, 7970.4819186752675, 7980.281774640311, 7997.400194985399, 8011.95994020032, 37894.0, 38104.618953810386, 38142.42786358207, 38212.61787382118, 38349.80825095884, 3537.0449978505917, 3580.9283814323567, 3584.0, 3585.4084076127406, 3586.33652774235, 31721.206969825707, 31795.364092718246, 31880.20299492508, 32029.1992700182, 32156.517652235234, 5229.712365819878, 5238.633295669305, 5251.789928402859, 5253.9737301313635, 5260.368755749335, 191590.0, 192250.0, 193564.0, 195346.0, 195491.0, 48933.51066489289, 49190.262146067835, 49423.25865112026, 49489.50510494849, 49785.0, 51552.74223628933, 51731.0, 51777.7411112942, 51790.0, 51878.740606297484, 16250.593735156715, 16387.918060409622, 16482.505524834272, 16485.423010194827, 16486.6702665946, 13484.528041518695, 13575.796363054562, 13591.252481113435, 13614.251216183206, 13618.38717257706, 14095.154290742588, 14304.85695143056, 14312.85687143136, 14329.140251584939, 14463.638409039859, 5700.572457065737, 5760.543673795689, 5763.9135412968835, 5767.509761670221, 5845.473907348359, 990.3364745620452, 996.6960077176386, 1007.2093406675724, 1020.7907378987289, 1031.2832581355885, 21954.560908781736, 22163.0, 22292.55414891693, 22377.440563985703, 22554.210602628827, 1103.5475455063386, 1114.2701530497536, 1118.1166878166157, 1134.8921852424007, 1135.2300387055723, 12014.97872680832, 12031.458584363725, 12144.33206173669, 12147.514099435924, 12227.755444891052, 223766.0, 224472.0, 225328.0, 225444.0, 225580.0, 40246.39630405546, 40835.0, 51911.48088519142, 53262.73368633132, 53488.732556337745, 1438.5252866554013, 1457.5408746244898, 1458.4749490183526, 1467.9339429725687, 1472.7790831375164, 26507.867460662572, 26872.462550748485, 26969.460610787282, 27180.456390872467, 27376.72623273742, 37626.62373376231, 37676.2464750709, 37718.8114059428, 37809.432858507695, 37827.432588510645, 195203.0, 196420.0, 197100.0, 197625.0, 198244.0, 33976.83011584926, 34072.1481962943, 34197.65802341945, 34201.14497137492, 34335.14162145966, 40225.0, 42257.78871105625, 42428.151436971704, 42483.575164249196, 42626.78686606547, 30658.386832262782, 31244.843775780977, 31350.52974205343, 31487.52768708517, 31502.527462088547, 31554.842225788725, 31625.5256171153, 31695.36609267848, 31821.20446988751, 31911.521327179646, 34848.47727284143, 35347.29305413826, 35429.1142721434, 35455.64544354523, 35461.11347216237, 30812.845935770176, 30857.382852343275, 31016.53475197919, 31198.68801311958, 32056.679433206304, 22807.543849122594, 23037.424064398525, 23185.420364491023, 23398.0, 23579.174728884405], "value": 17149.21591972961, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1979468333699, 590.1767034986192, 594.2957595249627, 607.5959486941184, 624.1012941364436, 22096.116155353786, 22782.88608556957, 22856.200032998848, 22935.082596696113, 22969.770302296973, 22965.311040668767, 22977.310680679606, 23069.884650576725, 23134.768652313473, 23711.850426175395, 6664.2002959644915, 6753.966230168842, 6793.490488213379, 6794.558353707018, 6801.251862295144, 6659.467242620579, 6744.325567443266, 6749.763758268462, 6876.7593134240315, 7143.571385716874, 7149.606771627558, 7151.463640227003, 7152.499325047223, 7156.928430715704, 7159.677814498334, 6965.65171741416, 7082.468814838908, 7104.076470058885, 7148.606826624534, 7154.713811447536, 7022.016917631536, 7086.893696594555, 7092.326229008236, 7109.8933515997305, 7112.933060040984, 30239.395212095857, 30633.693663063306, 30634.23414414635, 30663.693363066308, 30718.38563228723, 2073.6785798201304, 2096.989515052415, 2098.7691353951054, 2103.5582527669208, 2106.283863486422, 19054.714179287323, 19512.609747804963, 19651.115699793543, 19665.410037698894, 19849.30527431533, 2378.7383387827326, 2393.234165067179, 2437.183543512925, 2451.056343307839, 2457.1154384421593, 129035.0, 134400.0, 139127.30436347856, 145757.2712136443, 150730.24634876754, 19786.90106549487, 20559.280425185047, 21005.68491472629, 21155.8942205288, 22654.75398853079, 42196.36705449421, 42821.92945176333, 42829.78585107055, 42883.35674964878, 43005.0, 11075.944620277009, 11142.944285278521, 11226.494807733672, 11238.831417528743, 11303.208775385809, 9187.356885018118, 9240.122188392092, 9330.673426430043, 9343.159115679486, 9400.482973436527, 10883.346999180074, 10953.397563134104, 11098.944505277583, 11156.944215278872, 11569.537218511165, 3742.0, 3805.2708345820697, 4330.404147766681, 4332.480102387671, 4454.017962006876, 947.4599478297305, 961.1397798969883, 963.3208587945621, 974.2985050763439, 984.1585444444896, 19253.0, 19288.80711192898, 19361.419157425298, 19788.60422791565, 20015.699764503544, 1028.1825948371063, 1032.5043978890023, 1035.5961175141701, 1043.1811028342715, 1048.7220886465093, 10762.461876906124, 10807.729806754736, 10816.351018938889, 10992.340459572451, 11240.044596209415, 456912.0, 462656.0, 470001.0, 489272.0, 490682.0, 109523.45238273758, 115942.0, 117166.0, 118743.0, 119105.0, 1029.7013865978931, 1105.3533682795494, 1144.6035836279725, 1174.7944109780753, 1176.2883455509464, 20066.19735210575, 20436.0, 20572.485687857923, 20603.381898543066, 20725.031122043383, 55099.72450137723, 55227.44772552223, 56097.0, 56202.0, 57495.7125214388, 68808.6559567199, 68940.3105968934, 69463.65268173626, 69987.0, 70357.0, 19452.513687157934, 19991.100400482304, 20052.59894802125, 20284.898575507617, 20289.79710202879, 22021.22925697593, 22159.556808864054, 22447.43881402978, 22634.773652263266, 22760.31719048431, 17694.380696675555, 17800.91099544494, 18293.634127317113, 18416.17127229251, 18425.07874606291, 16003.679926401639, 16342.428015019417, 16505.17474126313, 16509.17454127313, 16907.323707052074, 18399.264029438673, 18448.262069517605, 18458.81541184571, 18534.536636583653, 18785.966771827134, 19434.319798806973, 19698.50753731168, 19710.507237319183, 19754.60490790205, 19938.0, 17970.460886173434, 18020.639587208443, 18129.184186711893, 18145.727814083064, 18180.81819181791], "value": 12877.640648325687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.7039666075132, 1366.3603675589295, 1367.0908845617664, 1371.4856928651755, 1372.0669944437782, 14923.626909327273, 15590.220488975549, 15591.532254032398, 15600.297986590602, 15608.765868511982, 15274.083554986708, 15425.228738563083, 15429.922850385732, 15439.768403473929, 15443.382264709426, 2787.1499192746205, 2826.8869245230167, 2844.5590933405356, 2845.260232339586, 2867.268846444154, 2788.5538313869783, 2815.7747380209635, 2824.6045553622507, 2835.2061422801544, 2836.7305106015, 2484.35406794233, 2773.0987429085626, 2784.7076057013924, 2794.762445192151, 2811.0863969209986, 2753.2703833484043, 2767.3635063935208, 2782.20707098477, 2815.183596756938, 2822.350859302372, 2517.785988191006, 2613.163787587973, 2703.175531462903, 2717.320669832542, 2721.2788611018095, 15211.923940380339, 15305.0, 15332.0, 15344.616384590363, 15367.0, 8005.359571234288, 8311.210435008665, 8315.251627353508, 8323.292520135796, 8330.416870819045, 5549.1676248562635, 5680.886382272372, 5694.572907031989, 5807.245058142415, 5862.472377486004, 1954.8045195480338, 1980.8118228768244, 1993.6810110382414, 2012.0, 2030.309694703793, 27342.316442088908, 27387.31531711723, 27535.586966195522, 27551.035713750123, 27556.173314800588, 6609.504287178384, 6874.5219777748025, 6894.896576551356, 7044.049053377831, 7056.15326160864, 17413.390531331344, 17450.82549174492, 17584.38454654081, 17590.384336548414, 17602.207900644502, 7857.1357150713375, 8029.1970802920405, 8045.919540804517, 8082.878756818653, 8099.797505062421, 7002.3697867192195, 7317.890231646529, 7441.702331906663, 7499.737509187262, 7503.512271702322, 5169.224616307584, 5294.7352632369, 5348.304720386403, 5352.91970620441, 5372.597055220874, 1473.992630036843, 1491.828439729445, 1501.3769285746293, 1506.563096701966, 1522.2464879884308, 863.1368631368631, 906.8821053263166, 913.4519288426891, 917.9403338783092, 920.6593560382702, 7789.298963093349, 7791.4156438267355, 7801.921980780119, 7899.091604465445, 7953.960230198928, 699.0702365853402, 707.6921539130494, 709.7090193020837, 712.7434123715458, 723.0, 4785.282207668877, 4911.754412279443, 5650.463205995424, 5697.491068042531, 5705.971470142623, 20567.38297851067, 22079.779202208094, 22210.0, 22215.22246721357, 22236.0, 20882.895585522278, 21486.570268594853, 21790.128394864343, 22392.55214895693, 22394.776052239267, 11478.311301321948, 11641.0, 11645.184837061493, 11692.415379231004, 11703.414829258503, 8159.0, 8189.959050204711, 8432.494050356998, 8434.481174014412, 8571.82856342882, 18744.625107498046, 19138.0, 19545.0, 19571.51071223231, 19828.60342793165, 19144.619136623234, 19208.519787004876, 19378.224871005565, 19439.125239364545, 19515.902420487808, 11071.0, 11095.167862410513, 11133.55465781392, 11152.330860148417, 11189.72025699364, 13941.0, 13963.720725585228, 14184.858151418353, 14196.787048194079, 14249.786253206417, 11226.0, 11357.37534435614, 11361.488733006869, 11544.538218471167, 11592.88407115918, 10847.186461015614, 10847.728806779895, 11008.559657613927, 11104.167187461135, 11268.549258029587, 10231.897681023393, 10265.743356415851, 10333.534990925276, 10378.844317335095, 10380.377177369382, 7486.625668716433, 7738.148803631483, 7744.883826742716, 7775.805604859924, 7870.09493908185, 7514.586697731677, 7714.382849372149, 7865.174156713691, 7878.487898286593, 7938.841223175619], "value": 6738.944941292517, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.681625800133, 521.2415934814844, 547.6358221782514, 554.7753159970214, 556.2462862820878, 6084.330723620398, 6233.563650544464, 6293.118963345135, 6338.366163383659, 6371.394717501841, 6219.657918814475, 6263.937360626393, 6285.73713463154, 6314.652694101823, 6315.557910946236, 5218.556422704075, 5274.837316700154, 5276.287701160332, 5280.419153893069, 5336.332958380202, 4914.680545764531, 5095.210242412413, 5105.259737338084, 5271.973640131813, 5282.498162674539, 5007.148784706608, 5034.42104158021, 5045.117104506715, 5092.898142037157, 5109.974450127745, 4982.302477653131, 4995.775190116454, 5001.8249361272365, 5011.523905228997, 5027.245913113025, 4535.682502224846, 4545.636349092065, 4563.498015218323, 4578.130155270488, 4602.424696912886, 6164.137020817089, 6204.937950620526, 6226.688665566749, 6229.1001244620375, 6240.095186198021, 5716.742746576414, 5738.995675756768, 5771.134329850514, 5781.566382521328, 5794.420557944214, 6507.869842603169, 6519.380658837403, 6522.5760325578685, 6579.967100164468, 6619.238787539446, 4916.434610019858, 4926.950730492685, 4953.504649535053, 4966.180580204298, 4983.0, 6728.192616886005, 6882.7591034313555, 6895.655217239118, 6911.308869113099, 6999.650017499104, 5026.4973502649445, 5045.899082018339, 5061.291419201241, 5062.215356619657, 5073.797048118107, 5111.309973153651, 5138.434772175057, 5143.537081662668, 5159.871003224949, 5191.6884986900905, 5620.831375058755, 5723.513501352349, 5754.4533269339345, 5768.538516918637, 5774.162746401832, 6260.843478913063, 6554.4756419487285, 6581.80254592363, 6647.767328143492, 6665.700043498055, 1672.3895778040928, 1689.991550042242, 1728.3345911824038, 1745.9039752813462, 1761.4803632928317, 1201.6995751062234, 1218.670958841108, 1243.7450322683828, 1250.693580072888, 1251.4305990774176, 5625.184348269478, 5636.887262254732, 5657.803341112341, 5726.885462290731, 5756.309242890796, 6545.803625891231, 6630.204375474974, 6705.6982435790505, 6753.49348798842, 6798.252192258848, 5719.628224165499, 5748.9425105748405, 5752.25220721312, 5773.913391299134, 5776.5089967352405, 3492.3189977954057, 3516.613172551017, 3519.1378112362636, 3535.4696795480368, 3584.5160903277724, 6452.064450654629, 6508.707108180143, 6537.0, 6538.0, 6598.241202261705, 6796.946473296647, 6818.761343352959, 6871.415929646036, 6873.621950792754, 6882.483813713991, 6509.674516274262, 6597.0, 6646.803575356482, 6658.833529161713, 6673.733050677918, 6697.856685860478, 6742.561733487308, 6772.458203343819, 6800.625965571941, 6835.350641689031, 6643.501737369813, 6684.799456016132, 6689.799306020827, 6697.899531506934, 6732.192136943598, 6522.804315870531, 6542.2149342077355, 6579.407853293226, 6580.407763301326, 6581.703823328057, 5025.949740502549, 5036.722980236123, 5038.722870242172, 5052.69683818972, 5059.519345662156, 6442.677866106769, 6621.33786621334, 6691.933080669326, 6746.797596072126, 6797.830054248683, 6286.177008667435, 6379.393957574023, 6492.935070649233, 6559.114519539801, 6589.4069533742195, 6463.676816159079, 6544.9672751635935, 6545.2800191979795, 6581.407673309425, 6616.106825578678, 6470.773522926675, 6495.642739649365, 6510.707018184288, 6519.478441724746, 6523.445507131947, 6514.218293804774, 6526.021096835512, 6619.900701489385, 6621.3047629998155, 6693.0, 6271.4669253114, 6358.395952384516, 6384.138141350858, 6389.169407976933, 6453.580517266362], "value": 5096.483118394975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [897.1432282170528, 916.3310783128317, 928.2481190235906, 929.1126973740074, 936.9203617692496, 19378.70931936022, 20453.0, 20484.385468435972, 20540.89729551354, 20543.0, 17987.280508779666, 18146.727799083023, 18229.908850455762, 19441.902790486063, 19654.606907861835, 965.888922773883, 978.8923218445965, 983.695054533097, 983.7393090830935, 985.1084768284678, 958.4105774948426, 985.7929834734679, 987.3631507677544, 988.4217732626422, 990.1039559198937, 1057.5663977769116, 1064.4837253931837, 1064.5050051725946, 1064.669952314785, 1065.3820783945332, 1046.7540128069973, 1054.3146954479573, 1054.3515737821263, 1055.1400608504082, 1056.7252514346249, 728.6466063959028, 744.2334395572515, 748.3339827553482, 748.5433885329944, 749.4454103963083, 19511.609767804708, 19666.115024823917, 19694.606107877906, 19769.604607907906, 19787.703184452246, 21989.67015494769, 22018.339449816533, 22475.77524224753, 22626.434339141488, 22629.434264143365, 17984.550386240448, 18033.54916127094, 18336.724949125775, 18420.0, 18471.630567388576, 3746.2882052409955, 3763.5860055393887, 3766.5480142382817, 3769.792661403622, 3787.621237876218, 142145.0, 143788.0, 144961.0, 147553.0, 148844.0, 16801.663966720596, 16903.23935422909, 17202.483925482255, 17244.655106897793, 17286.308547658205, 31534.863265632168, 32110.839445802623, 32290.515642265385, 32319.51520727191, 32347.35305293928, 8794.252488538546, 8863.955680221557, 8931.464112153291, 8951.239144672645, 8976.910230897607, 4465.821367145278, 4567.3377360282575, 4582.060677561092, 4588.49526552079, 4588.816447342136, 5499.862503437446, 5615.101583746581, 5615.691136987423, 5616.0, 5617.971910140505, 1022.4887556221889, 1054.8048611006989, 1058.4496062047692, 1067.3542506783285, 1073.1736562846565, 688.4561196654587, 688.8725585766649, 697.5082566790401, 709.6877373955443, 713.4435140590348, 11052.336859788438, 11439.88560114405, 11740.658000609703, 12911.5480958166, 13007.869921300666, 671.5668393885916, 672.1027428383065, 683.962382068991, 690.9585424874524, 692.2281655953575, 5592.328920529562, 5700.489370316869, 5772.3938986406665, 5783.219265399117, 5795.246617939641, 118240.0, 119737.0, 122268.0, 123376.0, 123738.38130809469, 110220.0, 110280.0, 110284.0, 112623.0, 117776.41111794386, 90098.54950725204, 91442.54278728696, 91800.0, 92601.5369923146, 92850.53574732083, 10780.946095269474, 10941.343519388862, 11115.555377784798, 11157.66527004191, 11288.887111129112, 42700.0, 43087.0, 44393.780310983675, 44770.10459790851, 45504.31743523916, 58388.70805645944, 58637.706811467375, 58949.115763264446, 59410.40589594049, 61196.0, 13919.0, 13955.860441395862, 13968.930155349159, 14362.784558231844, 14401.351939162554, 15817.762733559235, 15862.44481443144, 16014.039157650579, 16112.0, 16270.593235169215, 15747.921260393625, 15811.0, 15855.0, 15942.202889855229, 15949.362025519313, 14244.21656808844, 14505.419783208554, 14583.343749531085, 14665.340059697126, 14695.41218351254, 14350.56948291511, 14611.196384198545, 14652.12087274767, 14803.703925921636, 14855.182964937032, 12144.75710485803, 12173.939130304647, 12462.0, 12529.37353132358, 12654.87345126537, 11308.7738245233, 11568.884311157117, 11672.766544669228, 11685.182037257651, 11908.987736042533], "value": 8987.122805502368, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1417.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 110.0, 108.0, 108.0, 108.0, 97.0, 108.0, 108.0, 106.0, 107.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 117.0, 119.0, 118.0, 119.0, 149.0, 118.0, 117.0, 128.0], "value": 123.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 162.0, 162.0, 162.0, 164.0, 167.0, 166.0, 167.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 74.0, 76.0, 78.0, 75.0, 76.0, 75.0, 75.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 78.0, 80.0, 78.0, 80.0, 79.0, 79.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 111.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0, 116.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 149.0, 149.0, 148.0, 147.0, 151.0, 149.0, 149.0, 149.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 97.0, 97.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 52.0, 52.0, 50.0, 52.0, 50.0, 51.0, 51.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [36.0, 37.0, 37.0, 41.0, 37.0, 37.0, 37.0, 38.0, 37.0, 38.0], "value": 37.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 83.0, 78.0, 76.0, 76.0, 79.0, 77.0, 72.0, 73.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 112.0, 117.0, 113.0, 114.0, 113.0, 108.0, 114.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 173.0, 166.0, 162.0, 164.0, 161.0, 158.0, 164.0, 178.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 64.0, 69.0, 70.0, 71.0, 68.0, 63.0, 63.0, 65.0], "value": 67.3, "unit": "score"}]}]} 18:07:43 INFO - Return code: 0 18:07:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:07:43 INFO - # TBPL SUCCESS # 18:07:43 INFO - Running post-action listener: _package_coverage_data 18:07:43 INFO - Running post-action listener: _resource_record_post_action 18:07:43 INFO - [mozharness: 2017-09-28 01:07:43.444390Z] Finished run-tests step (success) 18:07:43 INFO - Running post-run listener: _resource_record_post_run 18:07:43 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 345382912; Read time: 20; Write time: 263500 18:07:43 INFO - TinderboxPrint: CPU usage
13.1% 18:07:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 18:07:43 INFO - TinderboxPrint: I/O write bytes / time
345,382,912 / 263,500 18:07:43 INFO - TinderboxPrint: CPU idle
8,226.8 (86.9%) 18:07:43 INFO - TinderboxPrint: CPU user
1,193.8 (12.6%) 18:07:43 INFO - TinderboxPrint: Swap in / out
0 / 0 18:07:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13185024; Read time: 0; Write time: 1352 18:07:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:07:43 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 332197888; Read time: 0; Write time: 262148 18:07:44 INFO - Running post-run listener: _upload_blobber_files 18:07:44 INFO - Blob upload gear active. 18:07:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:07:44 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 18:07:44 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'] 18:07:44 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 18:07:44 INFO - (blobuploader) - INFO - Open directory for files ... 18:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:48 INFO - (blobuploader) - INFO - Done attempting. 18:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 18:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 18:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:49 INFO - (blobuploader) - INFO - Done attempting. 18:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:50 INFO - (blobuploader) - INFO - Done attempting. 18:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 18:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 18:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:07:51 INFO - (blobuploader) - INFO - Done attempting. 18:07:51 INFO - (blobuploader) - INFO - Iteration through files over. 18:07:51 INFO - Return code: 0 18:07:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:07:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:07:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9bb77b05c82a95e796d97ee930bb77cbbdda0440473e3f3096a7477c563404ae867c67c2cf5d6c0374dd060f214019ae677ad77be0d961fe8bab7903eab033", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b7ef75538a9f584da9f0f38312fd9ef09fcc14771e4bf9239ba0d457531d406bc6f351b0429d8d14795da85c384f2def2c1ca20bbcffda1b2b3d08511cd323e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0e880ff2828e959760fe6da4698ae711f000400c5b56d06c949ea0a86af4fffb1252c40740838a2b54cc1e466962a8b9d4f3629958e87a96e3ed831149bc78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4c727799f88e7798de35e0e8de8ec24d78db678b972e3ef89e983653e7ab855ca7cadf29c14c34e048c94c6714654e20e80b0369c0e5e584007e5fba2a136b8"} 18:07:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:07:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:07:51 INFO - Contents: 18:07:51 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9bb77b05c82a95e796d97ee930bb77cbbdda0440473e3f3096a7477c563404ae867c67c2cf5d6c0374dd060f214019ae677ad77be0d961fe8bab7903eab033", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b7ef75538a9f584da9f0f38312fd9ef09fcc14771e4bf9239ba0d457531d406bc6f351b0429d8d14795da85c384f2def2c1ca20bbcffda1b2b3d08511cd323e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0e880ff2828e959760fe6da4698ae711f000400c5b56d06c949ea0a86af4fffb1252c40740838a2b54cc1e466962a8b9d4f3629958e87a96e3ed831149bc78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4c727799f88e7798de35e0e8de8ec24d78db678b972e3ef89e983653e7ab855ca7cadf29c14c34e048c94c6714654e20e80b0369c0e5e584007e5fba2a136b8"} 18:07:51 INFO - Running post-run listener: copy_logs_to_upload_dir 18:07:51 INFO - Copying logs to upload dir... 18:07:51 INFO - mkdir: /builds/slave/test/build/upload/logs 18:07:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.500527 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-09-27 18:07:51.427133) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 18:07:51.431874) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 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/5b9bb77b05c82a95e796d97ee930bb77cbbdda0440473e3f3096a7477c563404ae867c67c2cf5d6c0374dd060f214019ae677ad77be0d961fe8bab7903eab033", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b7ef75538a9f584da9f0f38312fd9ef09fcc14771e4bf9239ba0d457531d406bc6f351b0429d8d14795da85c384f2def2c1ca20bbcffda1b2b3d08511cd323e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0e880ff2828e959760fe6da4698ae711f000400c5b56d06c949ea0a86af4fffb1252c40740838a2b54cc1e466962a8b9d4f3629958e87a96e3ed831149bc78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4c727799f88e7798de35e0e8de8ec24d78db678b972e3ef89e983653e7ab855ca7cadf29c14c34e048c94c6714654e20e80b0369c0e5e584007e5fba2a136b8"} build_url:https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://queue.taskcluster.net/v1/task/ROcRQ0zqS7mg-39GJg0GHQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b9bb77b05c82a95e796d97ee930bb77cbbdda0440473e3f3096a7477c563404ae867c67c2cf5d6c0374dd060f214019ae677ad77be0d961fe8bab7903eab033", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0b7ef75538a9f584da9f0f38312fd9ef09fcc14771e4bf9239ba0d457531d406bc6f351b0429d8d14795da85c384f2def2c1ca20bbcffda1b2b3d08511cd323e", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8e0e880ff2828e959760fe6da4698ae711f000400c5b56d06c949ea0a86af4fffb1252c40740838a2b54cc1e466962a8b9d4f3629958e87a96e3ed831149bc78", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a4c727799f88e7798de35e0e8de8ec24d78db678b972e3ef89e983653e7ab855ca7cadf29c14c34e048c94c6714654e20e80b0369c0e5e584007e5fba2a136b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-27 18:07:51.464323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:07:51.464780) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1506559634.951386-1355930792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-27 18:07:51.543431) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 18:07:51.546770) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-27 18:07:51.547466) ========= ========= Total master_lag: 0.20 =========