builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s slave: talos-linux64-ix-085 starttime: 1506191174.8 results: success (0) revision: 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:14.799524) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:14.800017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:14.800297) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:14.897700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:14.897984) ========= 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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-23 11:26:14-- 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% 46.5M=0s 2017-09-23 11:26:15 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.273320 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.251752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.252053) ========= 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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015967 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.324482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.324833) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 --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 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 --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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-23 11:26:15,398 truncating revision to first 12 chars 2017-09-23 11:26:15,398 Setting DEBUG logging. 2017-09-23 11:26:15,398 attempt 1/10 2017-09-23 11:26:15,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2d9d0bebb5c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-23 11:26:15,639 unpacking tar archive at: mozilla-central-2d9d0bebb5c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.562241 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.912034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.912371) ========= script_repo_revision: 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.912807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.913101) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-23 11:26:15.926669) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-23 11:26:15.927004) ========= /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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:26:16 INFO - MultiFileLogger online at 20170923 11:26:16 in /builds/slave/test 11:26:16 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 11:26:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:16 INFO - {'append_to_log': False, 11:26:16 INFO - 'base_work_dir': '/builds/slave/test', 11:26:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:26:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:16 INFO - 'branch': 'Firefox-Non-PGO', 11:26:16 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:16 INFO - 'code_coverage': False, 11:26:16 INFO - 'config_files': ('talos/linux_config.py',), 11:26:16 INFO - 'default_actions': ('clobber', 11:26:16 INFO - 'read-buildbot-config', 11:26:16 INFO - 'download-and-extract', 11:26:16 INFO - 'populate-webroot', 11:26:16 INFO - 'create-virtualenv', 11:26:16 INFO - 'install', 11:26:16 INFO - 'setup-mitmproxy', 11:26:16 INFO - 'run-tests'), 11:26:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:16 INFO - 'disable_ccov_upload': False, 11:26:16 INFO - 'disable_stylo': False, 11:26:16 INFO - 'download_minidump_stackwalk': True, 11:26:16 INFO - 'download_symbols': 'ondemand', 11:26:16 INFO - 'enable_stylo': False, 11:26:16 INFO - 'enable_webrender': False, 11:26:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:26:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:16 INFO - 'gecko_profile': False, 11:26:16 INFO - 'gecko_profile_interval': 0, 11:26:16 INFO - 'installer_path': 'installer.exe', 11:26:16 INFO - 'log_level': 'info', 11:26:16 INFO - 'log_name': 'talos', 11:26:16 INFO - 'log_to_console': True, 11:26:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:26:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:26:16 INFO - 'opt_config_files': (), 11:26:16 INFO - 'pip_index': False, 11:26:16 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 11:26:16 INFO - 'system_bits': '32', 11:26:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:16 INFO - 'title': 'talos-linux64-ix-085', 11:26:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:16 INFO - 'use_talos_json': True, 11:26:16 INFO - 'verify': 'False', 11:26:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:16 INFO - 'work_dir': 'build'} 11:26:16 INFO - [mozharness: 2017-09-23 18:26:16.243419Z] Running clobber step. 11:26:16 INFO - Running pre-action listener: _resource_record_pre_action 11:26:16 INFO - Running main action method: clobber 11:26:16 INFO - rmtree: /builds/slave/test/build 11:26:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:17 INFO - Running post-action listener: _resource_record_post_action 11:26:17 INFO - [mozharness: 2017-09-23 18:26:17.194600Z] Finished clobber step (success) 11:26:17 INFO - [mozharness: 2017-09-23 18:26:17.194698Z] Running read-buildbot-config step. 11:26:17 INFO - Running pre-action listener: _resource_record_pre_action 11:26:17 INFO - Running main action method: read_buildbot_config 11:26:17 INFO - Using buildbot properties: 11:26:17 INFO - { 11:26:17 INFO - "project": "", 11:26:17 INFO - "product": "firefox", 11:26:17 INFO - "who": "ffxbld@noreply.mozilla.org", 11:26:17 INFO - "installer_path": "public/build/target.tar.bz2", 11:26:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 11:26:17 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:26:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-stylo-disabled-e10s", 11:26:17 INFO - "stage_platform": "linux64", 11:26:17 INFO - "basedir": "/builds/slave/test", 11:26:17 INFO - "buildnumber": 64, 11:26:17 INFO - "platform": "ubuntu64_hw", 11:26:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:26:17 INFO - "slavebuilddir": "test", 11:26:17 INFO - "taskId": "Z7wal6_gS_6JaUs0uy7vJQ", 11:26:17 INFO - "branch": "mozilla-central", 11:26:17 INFO - "script_repo_revision": "production", 11:26:17 INFO - "revision": "2d9d0bebb5c66ba3dfdffd713a888a8c49730631", 11:26:17 INFO - "slavename": "talos-linux64-ix-085", 11:26:17 INFO - "repo_path": "mozilla-central" 11:26:17 INFO - } 11:26:17 INFO - Finding installer, test and symbols from parent task. 11:26:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7wal6_gS_6JaUs0uy7vJQ'}, attempt #1 11:26:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z7wal6_gS_6JaUs0uy7vJQ'}, attempt #1 11:26:18 INFO - Task dependencies: DNUXLEF0TY6Rkrc0rZZnLg 11:26:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg'}, attempt #1 11:26:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 11:26:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.test_packages.json 11:26:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.crashreporter-symbols.zip 11:26:18 INFO - Running post-action listener: _resource_record_post_action 11:26:18 INFO - [mozharness: 2017-09-23 18:26:18.556255Z] Finished read-buildbot-config step (success) 11:26:18 INFO - [mozharness: 2017-09-23 18:26:18.556473Z] Running download-and-extract step. 11:26:18 INFO - Running pre-action listener: _resource_record_pre_action 11:26:18 INFO - Running main action method: download_and_extract 11:26:18 INFO - mkdir: /builds/slave/test/build/tests 11:26:18 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')]} 11:26:18 INFO - trying https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.test_packages.json 11:26:18 INFO - Downloading https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:26:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:26:19 INFO - Downloaded 989 bytes. 11:26:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:26:19 INFO - Using the following test package requirements: 11:26:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:26:19 INFO - u'common': [u'target.common.tests.zip'], 11:26:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:26:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:26:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:26:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:26:19 INFO - u'mozbase': [u'target.common.tests.zip'], 11:26:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:26:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:26:19 INFO - u'web-platform': [u'target.common.tests.zip', 11:26:19 INFO - u'target.web-platform.tests.tar.gz'], 11:26:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:26:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:26:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.common.tests.zip 11:26:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:26:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.common.tests.zip into memory 11:26:21 INFO - Content-Length response header: 54943881 11:26:21 INFO - Bytes received: 54943881 11:26:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.talos.tests.zip 11:26:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:26:31 INFO - Fetch https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.talos.tests.zip into memory 11:26:32 INFO - Content-Length response header: 14513823 11:26:32 INFO - Bytes received: 14513823 11:26:33 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')]} 11:26:33 INFO - trying https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 11:26:33 INFO - Downloading https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:26:38 INFO - Downloaded 61524879 bytes. 11:26:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 11:26:38 INFO - mkdir: /builds/slave/test/properties 11:26:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:26:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:26:38 INFO - Contents: 11:26:38 INFO - build_url:https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 11:26:38 INFO - Running post-action listener: _resource_record_post_action 11:26:38 INFO - Running post-action listener: find_tests_for_verification 11:26:38 INFO - Running post-action listener: set_extra_try_arguments 11:26:38 INFO - [mozharness: 2017-09-23 18:26:38.582567Z] Finished download-and-extract step (success) 11:26:38 INFO - [mozharness: 2017-09-23 18:26:38.582665Z] Running populate-webroot step. 11:26:38 INFO - Running pre-action listener: _resource_record_pre_action 11:26:38 INFO - Running main action method: populate_webroot 11:26:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:26:38 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['tresize', 11:26:38 INFO - 'tcanvasmark']}, 11:26:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:26:38 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['dromaeo_css', 11:26:38 INFO - 'kraken']}, 11:26:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:38 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:26:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'tests': ['damp', 'tps']}, 11:26:38 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['damp', 'tps']}, 11:26:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:26:38 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['dromaeo_dom']}, 11:26:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:26:38 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['basic_compositor_video', 11:26:38 INFO - 'glvideo']}, 11:26:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:26:38 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['ts_paint_webext', 11:26:38 INFO - 'tp5o_webext']}, 11:26:38 INFO - 'other-e10s': {'tests': ['a11yr', 11:26:38 INFO - 'ts_paint', 11:26:38 INFO - 'tpaint', 11:26:38 INFO - 'sessionrestore', 11:26:38 INFO - 'sessionrestore_many_windows', 11:26:38 INFO - 'sessionrestore_no_auto_restore', 11:26:38 INFO - 'tabpaint']}, 11:26:38 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['a11yr', 11:26:38 INFO - 'ts_paint', 11:26:38 INFO - 'tpaint', 11:26:38 INFO - 'sessionrestore', 11:26:38 INFO - 'sessionrestore_many_windows', 11:26:38 INFO - 'sessionrestore_no_auto_restore', 11:26:38 INFO - 'tabpaint']}, 11:26:38 INFO - 'perf-reftest-e10s': {'tests': ['perf_reftest']}, 11:26:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:26:38 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['perf_reftest_singletons']}, 11:26:38 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['perf_reftest']}, 11:26:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:26:38 INFO - 'tsvgr_opacity', 11:26:38 INFO - 'tart', 11:26:38 INFO - 'tscrollx', 11:26:38 INFO - 'tsvg_static']}, 11:26:38 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['tsvgx', 11:26:38 INFO - 'tsvgr_opacity', 11:26:38 INFO - 'tart', 11:26:38 INFO - 'tscrollx', 11:26:38 INFO - 'tsvg_static']}, 11:26:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:26:38 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--disable-stylo'], 11:26:38 INFO - 'tests': ['tp5o']}, 11:26:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:26:38 INFO - 'talos_options': ['--mitmproxy', 11:26:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:38 INFO - '--firstNonBlankPaint'], 11:26:38 INFO - 'tests': ['tp6_google', 11:26:38 INFO - 'tp6_youtube', 11:26:38 INFO - 'tp6_amazon', 11:26:38 INFO - 'tp6_facebook']}, 11:26:38 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:26:38 INFO - 'talos_options': ['--disable-stylo', 11:26:38 INFO - '--mitmproxy', 11:26:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:38 INFO - '--firstNonBlankPaint'], 11:26:38 INFO - 'tests': ['tp6_google', 11:26:38 INFO - 'tp6_youtube', 11:26:38 INFO - 'tp6_amazon', 11:26:38 INFO - 'tp6_facebook']}, 11:26:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:26:38 INFO - 'mitmproxy_release_bin_osx': 'mitmproxy-2.0.2-osx.tar.gz', 11:26:38 INFO - 'talos_options': ['--stylo-threads=1', 11:26:38 INFO - '--mitmproxy', 11:26:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:26:38 INFO - '--firstNonBlankPaint'], 11:26:38 INFO - 'tests': ['tp6_google', 11:26:38 INFO - 'tp6_youtube', 11:26:38 INFO - 'tp6_amazon', 11:26:38 INFO - 'tp6_facebook']}, 11:26:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--xperf_path', 11:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:38 INFO - 'tests': ['tp5n']}, 11:26:38 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:26:38 INFO - 'talos_options': ['--disable-stylo', 11:26:38 INFO - '--xperf_path', 11:26:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:26:38 INFO - 'tests': ['tp5n']}}} 11:26:38 INFO - Running post-action listener: _resource_record_post_action 11:26:38 INFO - [mozharness: 2017-09-23 18:26:38.603216Z] Finished populate-webroot step (success) 11:26:38 INFO - [mozharness: 2017-09-23 18:26:38.603317Z] Running create-virtualenv step. 11:26:38 INFO - Running pre-action listener: _resource_record_pre_action 11:26:38 INFO - Running main action method: create_virtualenv 11:26:38 INFO - Creating virtualenv /builds/slave/test/build/venv 11:26:38 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:26:38 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:26:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:26:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:26:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:26:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:26:40 INFO - Installing pip...............done. 11:26:40 INFO - Return code: 0 11:26:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:26:40 INFO - Reading from file tmpfile_stdout 11:26:40 INFO - Output received: 11:26:40 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:26:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26: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', 'pip>=1.5'] in /builds/slave/test/build 11:26: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 pip>=1.5 11:26:40 INFO - Using env: {'DISPLAY': ':0', 11:26:40 INFO - 'HOME': '/home/cltbld', 11:26:40 INFO - 'LANG': 'en_US.UTF-8', 11:26:40 INFO - 'LANGUAGE': 'en_US:en', 11:26:40 INFO - 'LOGNAME': 'cltbld', 11:26:40 INFO - 'MAIL': '/var/mail/cltbld', 11:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:40 INFO - 'MOZ_NO_REMOTE': '1', 11:26:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:40 INFO - 'NO_EM_RESTART': '1', 11:26:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:40 INFO - 'PWD': '/builds/slave/test', 11:26:40 INFO - 'SHELL': '/bin/bash', 11:26:40 INFO - 'SHLVL': '1', 11:26:40 INFO - 'TERM': 'linux', 11:26:40 INFO - 'TMOUT': '86400', 11:26:40 INFO - 'USER': 'cltbld', 11:26:40 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:40 INFO - '_': '/tools/buildbot/bin/python'} 11:26:42 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:26:42 INFO - Downloading/unpacking pip>=1.5 11:26:42 INFO - Running setup.py egg_info for package pip 11:26:42 INFO - warning: no files found matching 'pip/cacert.pem' 11:26:42 INFO - warning: no files found matching '*.html' under directory 'docs' 11:26:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:26:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:26:42 INFO - Installing collected packages: pip 11:26:42 INFO - Found existing installation: pip 1.1 11:26:42 INFO - Uninstalling pip: 11:26:42 INFO - Successfully uninstalled pip 11:26:42 INFO - Running setup.py install for pip 11:26:42 INFO - warning: no files found matching 'pip/cacert.pem' 11:26:42 INFO - warning: no files found matching '*.html' under directory 'docs' 11:26:42 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:26:42 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:26:42 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:26:42 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:26:42 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:26:42 INFO - Successfully installed pip 11:26:42 INFO - Cleaning up... 11:26:42 INFO - Return code: 0 11:26:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26: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', '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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:26: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 psutil>=3.1.1 11:26:42 INFO - Using env: {'DISPLAY': ':0', 11:26:42 INFO - 'HOME': '/home/cltbld', 11:26:42 INFO - 'LANG': 'en_US.UTF-8', 11:26:42 INFO - 'LANGUAGE': 'en_US:en', 11:26:42 INFO - 'LOGNAME': 'cltbld', 11:26:42 INFO - 'MAIL': '/var/mail/cltbld', 11:26:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:42 INFO - 'MOZ_NO_REMOTE': '1', 11:26:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:42 INFO - 'NO_EM_RESTART': '1', 11:26:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:42 INFO - 'PWD': '/builds/slave/test', 11:26:42 INFO - 'SHELL': '/bin/bash', 11:26:42 INFO - 'SHLVL': '1', 11:26:42 INFO - 'TERM': 'linux', 11:26:42 INFO - 'TMOUT': '86400', 11:26:42 INFO - 'USER': 'cltbld', 11:26:42 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:42 INFO - '_': '/tools/buildbot/bin/python'} 11:26:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:42 INFO - Downloading/unpacking psutil>=3.1.1 11:26: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 11:26: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 11:26: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 11:26: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 11:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:26:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:43 INFO - Installing collected packages: psutil 11:26:43 INFO - Running setup.py install for psutil 11:26:43 INFO - building 'psutil._psutil_linux' extension 11:26:43 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 11:26:44 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 11:26:44 INFO - building 'psutil._psutil_posix' extension 11:26:44 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 11:26:45 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 11:26:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:26:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:26:45 INFO - Successfully installed psutil 11:26:45 INFO - Cleaning up... 11:26:45 INFO - Return code: 0 11:26:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:26:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:26:45 INFO - Using env: {'DISPLAY': ':0', 11:26:45 INFO - 'HOME': '/home/cltbld', 11:26:45 INFO - 'LANG': 'en_US.UTF-8', 11:26:45 INFO - 'LANGUAGE': 'en_US:en', 11:26:45 INFO - 'LOGNAME': 'cltbld', 11:26:45 INFO - 'MAIL': '/var/mail/cltbld', 11:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:45 INFO - 'MOZ_NO_REMOTE': '1', 11:26:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:45 INFO - 'NO_EM_RESTART': '1', 11:26:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:45 INFO - 'PWD': '/builds/slave/test', 11:26:45 INFO - 'SHELL': '/bin/bash', 11:26:45 INFO - 'SHLVL': '1', 11:26:45 INFO - 'TERM': 'linux', 11:26:45 INFO - 'TMOUT': '86400', 11:26:45 INFO - 'USER': 'cltbld', 11:26:45 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:45 INFO - '_': '/tools/buildbot/bin/python'} 11:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:26:45 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 11:26:45 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 11:26:45 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 11:26:45 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 11:26:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:26:46 INFO - Installing collected packages: mozsystemmonitor 11:26:46 INFO - Running setup.py install for mozsystemmonitor 11:26:46 INFO - Successfully installed mozsystemmonitor 11:26:46 INFO - Cleaning up... 11:26:46 INFO - Return code: 0 11:26:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:26:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:26:46 INFO - Using env: {'DISPLAY': ':0', 11:26:46 INFO - 'HOME': '/home/cltbld', 11:26:46 INFO - 'LANG': 'en_US.UTF-8', 11:26:46 INFO - 'LANGUAGE': 'en_US:en', 11:26:46 INFO - 'LOGNAME': 'cltbld', 11:26:46 INFO - 'MAIL': '/var/mail/cltbld', 11:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:46 INFO - 'MOZ_NO_REMOTE': '1', 11:26:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:46 INFO - 'NO_EM_RESTART': '1', 11:26:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:46 INFO - 'PWD': '/builds/slave/test', 11:26:46 INFO - 'SHELL': '/bin/bash', 11:26:46 INFO - 'SHLVL': '1', 11:26:46 INFO - 'TERM': 'linux', 11:26:46 INFO - 'TMOUT': '86400', 11:26:46 INFO - 'USER': 'cltbld', 11:26:46 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:46 INFO - '_': '/tools/buildbot/bin/python'} 11:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:46 INFO - Downloading/unpacking jsonschema==2.5.1 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:26:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:48 INFO - Downloading functools32-3.2.3-2.tar.gz 11:26:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:26:48 INFO - warning: no files found matching '*.txt' 11:26:48 INFO - no previously-included directories found matching 'build' 11:26:48 INFO - no previously-included directories found matching 'dist' 11:26:48 INFO - no previously-included directories found matching '.git*' 11:26:48 INFO - Installing collected packages: jsonschema, functools32 11:26:48 INFO - Running setup.py install for functools32 11:26:48 INFO - warning: no files found matching '*.txt' 11:26:48 INFO - no previously-included directories found matching 'build' 11:26:48 INFO - no previously-included directories found matching 'dist' 11:26:48 INFO - no previously-included directories found matching '.git*' 11:26:48 INFO - Successfully installed jsonschema functools32 11:26:48 INFO - Cleaning up... 11:26:48 INFO - Return code: 0 11:26:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:26:48 INFO - Using env: {'DISPLAY': ':0', 11:26:48 INFO - 'HOME': '/home/cltbld', 11:26:48 INFO - 'LANG': 'en_US.UTF-8', 11:26:48 INFO - 'LANGUAGE': 'en_US:en', 11:26:48 INFO - 'LOGNAME': 'cltbld', 11:26:48 INFO - 'MAIL': '/var/mail/cltbld', 11:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:48 INFO - 'MOZ_NO_REMOTE': '1', 11:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:48 INFO - 'NO_EM_RESTART': '1', 11:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:48 INFO - 'PWD': '/builds/slave/test', 11:26:48 INFO - 'SHELL': '/bin/bash', 11:26:48 INFO - 'SHLVL': '1', 11:26:48 INFO - 'TERM': 'linux', 11:26:48 INFO - 'TMOUT': '86400', 11:26:48 INFO - 'USER': 'cltbld', 11:26:48 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:48 INFO - '_': '/tools/buildbot/bin/python'} 11:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:26:48 INFO - Cleaning up... 11:26:48 INFO - Return code: 0 11:26:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:26:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:26:48 INFO - Using env: {'DISPLAY': ':0', 11:26:48 INFO - 'HOME': '/home/cltbld', 11:26:48 INFO - 'LANG': 'en_US.UTF-8', 11:26:48 INFO - 'LANGUAGE': 'en_US:en', 11:26:48 INFO - 'LOGNAME': 'cltbld', 11:26:48 INFO - 'MAIL': '/var/mail/cltbld', 11:26:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:48 INFO - 'MOZ_NO_REMOTE': '1', 11:26:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:48 INFO - 'NO_EM_RESTART': '1', 11:26:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:48 INFO - 'PWD': '/builds/slave/test', 11:26:48 INFO - 'SHELL': '/bin/bash', 11:26:48 INFO - 'SHLVL': '1', 11:26:48 INFO - 'TERM': 'linux', 11:26:48 INFO - 'TMOUT': '86400', 11:26:48 INFO - 'USER': 'cltbld', 11:26:48 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:48 INFO - '_': '/tools/buildbot/bin/python'} 11:26:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:48 INFO - Downloading/unpacking blobuploader==1.2.4 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:50 INFO - Downloading blobuploader-1.2.4.tar.gz 11:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:26:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:26:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:50 INFO - Downloading docopt-0.6.1.tar.gz 11:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:26:50 INFO - Installing collected packages: blobuploader, requests, docopt 11:26:50 INFO - Running setup.py install for blobuploader 11:26:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:26:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:26:50 INFO - Running setup.py install for requests 11:26:51 INFO - Running setup.py install for docopt 11:26:51 INFO - Successfully installed blobuploader requests docopt 11:26:51 INFO - Cleaning up... 11:26:51 INFO - Return code: 0 11:26:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:51 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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:51 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 11:26:51 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 11:26:51 INFO - Using env: {'DISPLAY': ':0', 11:26:51 INFO - 'HOME': '/home/cltbld', 11:26:51 INFO - 'LANG': 'en_US.UTF-8', 11:26:51 INFO - 'LANGUAGE': 'en_US:en', 11:26:51 INFO - 'LOGNAME': 'cltbld', 11:26:51 INFO - 'MAIL': '/var/mail/cltbld', 11:26:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:51 INFO - 'MOZ_NO_REMOTE': '1', 11:26:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:51 INFO - 'NO_EM_RESTART': '1', 11:26:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:51 INFO - 'PWD': '/builds/slave/test', 11:26:51 INFO - 'SHELL': '/bin/bash', 11:26:51 INFO - 'SHLVL': '1', 11:26:51 INFO - 'TERM': 'linux', 11:26:51 INFO - 'TMOUT': '86400', 11:26:51 INFO - 'USER': 'cltbld', 11:26:51 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:51 INFO - '_': '/tools/buildbot/bin/python'} 11:26:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:51 INFO - Running setup.py (path:/tmp/pip-aasIfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:51 INFO - Running setup.py (path:/tmp/pip-l3NHDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:51 INFO - Running setup.py (path:/tmp/pip-gZm8CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:51 INFO - Running setup.py (path:/tmp/pip-wpDaRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:51 INFO - Running setup.py (path:/tmp/pip-bxZVQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:51 INFO - Running setup.py (path:/tmp/pip-RkXIgO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:51 INFO - Running setup.py (path:/tmp/pip-7RVaHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:51 INFO - Running setup.py (path:/tmp/pip-FVjz8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:51 INFO - Running setup.py (path:/tmp/pip-et8CDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:52 INFO - Running setup.py (path:/tmp/pip-4lasUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:52 INFO - Running setup.py (path:/tmp/pip-9uu4SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:52 INFO - Running setup.py (path:/tmp/pip-Zh504P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:52 INFO - Running setup.py (path:/tmp/pip-ucaakD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:52 INFO - Running setup.py (path:/tmp/pip-nkvl3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:52 INFO - Running setup.py (path:/tmp/pip-GQ1Tt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:52 INFO - Running setup.py (path:/tmp/pip-sLazhD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:52 INFO - Running setup.py (path:/tmp/pip-Sep6BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:26:52 INFO - Running setup.py install for manifestparser 11:26:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:26:52 INFO - Running setup.py install for mozcrash 11:26:52 INFO - Running setup.py install for mozdebug 11:26:52 INFO - Running setup.py install for mozdevice 11:26:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozfile 11:26:53 INFO - Running setup.py install for mozhttpd 11:26:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozinfo 11:26:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozInstall 11:26:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozleak 11:26:53 INFO - Running setup.py install for mozlog 11:26:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for moznetwork 11:26:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozprocess 11:26:53 INFO - Running setup.py install for mozprofile 11:26:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:26:53 INFO - Running setup.py install for mozrunner 11:26:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:26:54 INFO - Running setup.py install for mozscreenshot 11:26:54 INFO - Running setup.py install for moztest 11:26:54 INFO - Running setup.py install for mozversion 11:26:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:26:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:26:54 INFO - Cleaning up... 11:26:54 INFO - Return code: 0 11:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26: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')]} 11:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26: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')]} 11:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:54 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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:54 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 11:26:54 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 11:26:54 INFO - Using env: {'DISPLAY': ':0', 11:26:54 INFO - 'HOME': '/home/cltbld', 11:26:54 INFO - 'LANG': 'en_US.UTF-8', 11:26:54 INFO - 'LANGUAGE': 'en_US:en', 11:26:54 INFO - 'LOGNAME': 'cltbld', 11:26:54 INFO - 'MAIL': '/var/mail/cltbld', 11:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:54 INFO - 'MOZ_NO_REMOTE': '1', 11:26:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:54 INFO - 'NO_EM_RESTART': '1', 11:26:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:54 INFO - 'PWD': '/builds/slave/test', 11:26:54 INFO - 'SHELL': '/bin/bash', 11:26:54 INFO - 'SHLVL': '1', 11:26:54 INFO - 'TERM': 'linux', 11:26:54 INFO - 'TMOUT': '86400', 11:26:54 INFO - 'USER': 'cltbld', 11:26:54 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:54 INFO - '_': '/tools/buildbot/bin/python'} 11:26:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:26:54 INFO - Running setup.py (path:/tmp/pip-3snqOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:26:54 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)) 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:26:54 INFO - Running setup.py (path:/tmp/pip-gZt37W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:26:54 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)) 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:26:54 INFO - Running setup.py (path:/tmp/pip-JkOkpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:26:54 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)) 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:26:54 INFO - Running setup.py (path:/tmp/pip-wzIcR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:26:54 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)) 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:26:54 INFO - Running setup.py (path:/tmp/pip-1N_kpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:26:54 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)) 11:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:26:54 INFO - Running setup.py (path:/tmp/pip-oHzHLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:26:55 INFO - Running setup.py (path:/tmp/pip-a5Bj1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:26:55 INFO - Running setup.py (path:/tmp/pip-HBTN34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:26:55 INFO - Running setup.py (path:/tmp/pip-sLHFWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:26:55 INFO - Running setup.py (path:/tmp/pip-dJX8U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:26:55 INFO - Running setup.py (path:/tmp/pip-XHSyd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:26:55 INFO - Running setup.py (path:/tmp/pip-nh9DGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:26:55 INFO - Running setup.py (path:/tmp/pip-AZXd8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:26:55 INFO - Running setup.py (path:/tmp/pip-B5Uj6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:55 INFO - Running setup.py (path:/tmp/pip-BAgLEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:26:55 INFO - Running setup.py (path:/tmp/pip-djL18o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:26:55 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)) 11:26:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:26:55 INFO - Running setup.py (path:/tmp/pip-4u4sk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:26:55 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)) 11:26:55 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)) 11:26:55 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)) 11:26:55 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)) 11:26:55 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)) 11:26:55 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)) 11:26:55 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)) 11:26:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:56 INFO - Downloading blessings-1.6.tar.gz 11:26:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:26:57 INFO - Installing collected packages: blessings 11:26:57 INFO - Running setup.py install for blessings 11:26:57 INFO - Successfully installed blessings 11:26:57 INFO - Cleaning up... 11:26:57 INFO - Return code: 0 11:26:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:26:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:26:57 INFO - Reading from file tmpfile_stdout 11:26:57 INFO - Current package versions: 11:26:57 INFO - argparse == 1.2.1 11:26:57 INFO - blessings == 1.6 11:26:57 INFO - blobuploader == 1.2.4 11:26:57 INFO - docopt == 0.6.1 11:26:57 INFO - functools32 == 3.2.3-2 11:26:57 INFO - jsonschema == 2.5.1 11:26:57 INFO - manifestparser == 1.1 11:26:57 INFO - mozInstall == 1.13 11:26:57 INFO - mozcrash == 1.0 11:26:57 INFO - mozdebug == 0.1 11:26:57 INFO - mozdevice == 0.51 11:26:57 INFO - mozfile == 1.2 11:26:57 INFO - mozhttpd == 0.7 11:26:57 INFO - mozinfo == 0.10 11:26:57 INFO - mozleak == 0.1 11:26:57 INFO - mozlog == 3.5 11:26:57 INFO - moznetwork == 0.27 11:26:57 INFO - mozprocess == 0.25 11:26:57 INFO - mozprofile == 0.28 11:26:57 INFO - mozrunner == 6.13 11:26:57 INFO - mozscreenshot == 0.1 11:26:57 INFO - mozsystemmonitor == 0.3 11:26:57 INFO - moztest == 0.8 11:26:57 INFO - mozversion == 1.4 11:26:57 INFO - psutil == 3.1.1 11:26:57 INFO - requests == 1.2.3 11:26:57 INFO - wsgiref == 0.1.2 11:26:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:57 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 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:57 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 11:26:57 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 11:26:57 INFO - Using env: {'DISPLAY': ':0', 11:26:57 INFO - 'HOME': '/home/cltbld', 11:26:57 INFO - 'LANG': 'en_US.UTF-8', 11:26:57 INFO - 'LANGUAGE': 'en_US:en', 11:26:57 INFO - 'LOGNAME': 'cltbld', 11:26:57 INFO - 'MAIL': '/var/mail/cltbld', 11:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:57 INFO - 'MOZ_NO_REMOTE': '1', 11:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:57 INFO - 'NO_EM_RESTART': '1', 11:26:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:57 INFO - 'PWD': '/builds/slave/test', 11:26:57 INFO - 'SHELL': '/bin/bash', 11:26:57 INFO - 'SHLVL': '1', 11:26:57 INFO - 'TERM': 'linux', 11:26:57 INFO - 'TMOUT': '86400', 11:26:57 INFO - 'USER': 'cltbld', 11:26:57 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:57 INFO - '_': '/tools/buildbot/bin/python'} 11:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 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)) 11:26:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:26:58 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)) 11:26:58 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)) 11:26:58 INFO - Installing collected packages: simplejson 11:26:58 INFO - Running setup.py install for simplejson 11:26:58 INFO - building 'simplejson._speedups' extension 11:26:58 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 11:26:59 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 11:26:59 INFO - Successfully installed simplejson 11:26:59 INFO - Cleaning up... 11:26:59 INFO - Return code: 0 11:26:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x150c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d4b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18799c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, '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': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', '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 11:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:26:59 INFO - Using env: {'DISPLAY': ':0', 11:26:59 INFO - 'HOME': '/home/cltbld', 11:26:59 INFO - 'LANG': 'en_US.UTF-8', 11:26:59 INFO - 'LANGUAGE': 'en_US:en', 11:26:59 INFO - 'LOGNAME': 'cltbld', 11:26:59 INFO - 'MAIL': '/var/mail/cltbld', 11:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:26:59 INFO - 'MOZ_NO_REMOTE': '1', 11:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:26:59 INFO - 'NO_EM_RESTART': '1', 11:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:26:59 INFO - 'PWD': '/builds/slave/test', 11:26:59 INFO - 'SHELL': '/bin/bash', 11:26:59 INFO - 'SHLVL': '1', 11:26:59 INFO - 'TERM': 'linux', 11:26:59 INFO - 'TMOUT': '86400', 11:26:59 INFO - 'USER': 'cltbld', 11:26:59 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:26:59 INFO - '_': '/tools/buildbot/bin/python'} 11:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:27:00 INFO - Cleaning up... 11:27:00 INFO - Return code: 0 11:27:00 INFO - Running post-action listener: _resource_record_post_action 11:27:00 INFO - Running post-action listener: _start_resource_monitoring 11:27:00 INFO - Starting resource monitoring. 11:27:00 INFO - [mozharness: 2017-09-23 18:27:00.141938Z] Finished create-virtualenv step (success) 11:27:00 INFO - [mozharness: 2017-09-23 18:27:00.143154Z] Running install step. 11:27:00 INFO - Running pre-action listener: _resource_record_pre_action 11:27:00 INFO - Running main action method: install 11:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:00 INFO - Reading from file tmpfile_stdout 11:27:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:00 INFO - Reading from file tmpfile_stdout 11:27:00 INFO - Output received: 11:27:00 INFO - Usage: mozinstall [options] installer 11:27:00 INFO - Options: 11:27:00 INFO - -h, --help show this help message and exit 11:27:00 INFO - -d DEST, --destination=DEST 11:27:00 INFO - Directory to install application into. [default: 11:27:00 INFO - "/builds/slave/test"] 11:27:00 INFO - --app=APP Application being installed. [default: firefox] 11:27:00 INFO - mkdir: /builds/slave/test/build/application 11:27:00 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'] 11:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:27:18 INFO - Reading from file tmpfile_stdout 11:27:18 INFO - Output received: 11:27:18 INFO - /builds/slave/test/build/application/firefox/firefox 11:27:18 INFO - Running post-action listener: _resource_record_post_action 11:27:18 INFO - [mozharness: 2017-09-23 18:27:18.261274Z] Finished install step (success) 11:27:18 INFO - [mozharness: 2017-09-23 18:27:18.261527Z] Running setup-mitmproxy step. 11:27:18 INFO - Running pre-action listener: _resource_record_pre_action 11:27:18 INFO - Running main action method: setup_mitmproxy 11:27:18 INFO - Skipping: mitmproxy is not required 11:27:18 INFO - Running post-action listener: _resource_record_post_action 11:27:18 INFO - [mozharness: 2017-09-23 18:27:18.262936Z] Finished setup-mitmproxy step (success) 11:27:18 INFO - [mozharness: 2017-09-23 18:27:18.263225Z] Running run-tests step. 11:27:18 INFO - Running pre-action listener: _resource_record_pre_action 11:27:18 INFO - Running pre-action listener: _set_gcov_prefix 11:27:18 INFO - Running main action method: run_tests 11:27:18 WARNING - Try message not found. 11:27:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:27:18 INFO - Python 2.7.3 11:27:18 INFO - Return code: 0 11:27:18 INFO - grabbing minidump binary from tooltool 11:27:18 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')]} 11:27:18 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 0x1876d60>, '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 0x1877a60>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1877ef0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:27:18 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 11:27:18 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 11:27:18 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 11:27:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:27:18 INFO - Return code: 0 11:27:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:27:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:27:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:27:18 INFO - ENV: RUST_BACKTRACE is now full 11:27:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:27:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:27:18 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/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 11:27:18 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/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-085 --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 11:27:18 INFO - Using env: {'DISPLAY': ':0', 11:27:18 INFO - 'HOME': '/home/cltbld', 11:27:18 INFO - 'LANG': 'en_US.UTF-8', 11:27:18 INFO - 'LANGUAGE': 'en_US:en', 11:27:18 INFO - 'LOGNAME': 'cltbld', 11:27:18 INFO - 'MAIL': '/var/mail/cltbld', 11:27:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:18 INFO - 'MOZ_NO_REMOTE': '1', 11:27:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:18 INFO - 'NO_EM_RESTART': '1', 11:27:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:18 INFO - 'PWD': '/builds/slave/test', 11:27:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:18 INFO - 'RUST_BACKTRACE': 'full', 11:27:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:18 INFO - 'SHELL': '/bin/bash', 11:27:18 INFO - 'SHLVL': '1', 11:27:18 INFO - 'TERM': 'linux', 11:27:18 INFO - 'TMOUT': '86400', 11:27:18 INFO - 'USER': 'cltbld', 11:27:18 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:27:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:18 INFO - '_': '/tools/buildbot/bin/python'} 11:27:18 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/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-085', '--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 11:27:19 INFO - mozversion application_buildid: 20170923173344 11:27:19 INFO - mozversion application_changeset: 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 11:27:19 INFO - mozversion application_display_name: Nightly 11:27:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:27:19 INFO - mozversion application_name: Firefox 11:27:19 INFO - mozversion application_remotingname: firefox 11:27:19 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:27:19 INFO - mozversion application_vendor: Mozilla 11:27:19 INFO - mozversion application_version: 58.0a1 11:27:19 INFO - mozversion platform_buildid: 20170923173344 11:27:19 INFO - mozversion platform_changeset: 2d9d0bebb5c66ba3dfdffd713a888a8c49730631 11:27:19 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:27:19 INFO - mozversion platform_version: 58.0a1 11:27:19 INFO - using testdate: 1506191239 11:27:19 INFO - actual date: 1506191239 11:27:19 INFO - starting webserver on 'localhost:60470' 11:27:19 INFO - SUITE-START | Running 2 tests 11:27:19 INFO - TEST-START | dromaeo_css 11:27:19 INFO - Initialising browser for dromaeo_css test... 11:27:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60470/getInfo.html -profile /tmp/tmpQpHfyh/profile 11:27:19 INFO - TEST-INFO | started process 3558 (/builds/slave/test/build/application/firefox/firefox http://localhost:60470/getInfo.html) 11:27:28 INFO - TEST-INFO | 3558: exit 0 11:27:29 INFO - Browser initialized. 11:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 11:27:29 INFO - Using env: {'DISPLAY': ':0', 11:27:29 INFO - 'HOME': '/home/cltbld', 11:27:29 INFO - 'JSGC_DISABLE_POISONING': '1', 11:27:29 INFO - 'LANG': 'en_US.UTF-8', 11:27:29 INFO - 'LANGUAGE': 'en_US:en', 11:27:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:27:29 INFO - 'LOGNAME': 'cltbld', 11:27:29 INFO - 'MAIL': '/var/mail/cltbld', 11:27:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:27:29 INFO - 'MOZ_CRASHREPORTER': '1', 11:27:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:27:29 INFO - 'MOZ_NO_REMOTE': '1', 11:27:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:27:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:27:29 INFO - 'NO_EM_RESTART': '1', 11:27:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:27:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:29 INFO - 'PWD': '/builds/slave/test', 11:27:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:27:29 INFO - 'RUST_BACKTRACE': 'full', 11:27:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:27:29 INFO - 'SHELL': '/bin/bash', 11:27:29 INFO - 'SHLVL': '1', 11:27:29 INFO - 'STYLO_FORCE_DISABLED': '1', 11:27:29 INFO - 'TERM': 'linux', 11:27:29 INFO - 'TMOUT': '86400', 11:27:29 INFO - 'USER': 'cltbld', 11:27:29 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:27:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:29 INFO - '_': '/tools/buildbot/bin/python'} 11:27:29 INFO - TEST-INFO | started process 3796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQpHfyh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:29 INFO - PID 3796 | 11:27:29 INFO - PID 3796 | (/builds/slave/test/build/application/firefox/firefox:3845): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:27:29 INFO - PID 3796 | 11:27:40 INFO - PID 3796 | RSS: Main: 147656704 11:27:40 INFO - PID 3796 | 11:30:37 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60470/tests/dromaeo/cssquery-ext.html) 11:30:39 INFO - PID 3796 | RSS: Main: 154230784 11:30:39 INFO - PID 3796 | 11:33:40 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-ext.html (next: http://localhost:60470/tests/dromaeo/cssquery-jquery.html) 11:33:41 INFO - PID 3796 | RSS: Main: 152842240 11:33:41 INFO - PID 3796 | 11:36:43 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60470/tests/dromaeo/cssquery-mootools.html) 11:36:43 INFO - PID 3796 | RSS: Main: 154472448 11:36:43 INFO - PID 3796 | 11:39:45 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60470/tests/dromaeo/cssquery-prototype.html) 11:39:46 INFO - PID 3796 | RSS: Main: 152653824 11:39:46 INFO - PID 3796 | 11:42:49 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60470/tests/dromaeo/cssquery-yui.html) 11:42:49 INFO - PID 3796 | RSS: Main: 154488832 11:42:49 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | Cycle 1(1): loaded http://localhost:60470/tests/dromaeo/cssquery-yui.html (next: http://localhost:60470/tests/dromaeo/cssquery-dojo.html) 11:45:51 INFO - PID 3796 | RSS: Main: 154890240 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | __start_tp_report 11:45:51 INFO - PID 3796 | _x_x_mozilla_page_load 11:45:51 INFO - PID 3796 | _x_x_mozilla_page_load_details 11:45:51 INFO - PID 3796 | |i|pagename|runs| 11:45:51 INFO - PID 3796 | |0;dojo.html;3108.953365699514;3126.062181345596;3141.56018157458;3154.5741324921128;3156.573862528558;6209.348018458065;6286.968565157168;6324.1462402575635;6339.239291285041;6362.777302794398;6164.691765411734;6189.504839612831;6204.96897515513;6247.906281405772;6337.873242535146;5822.941770582303;5904.852378690524;5932.466078052985;5932.6143800653035;5955.434233747787;5789.231657322865;5805.419458054182;5851.122331650266;5865.120231965197;5920.348761636238;5803.448672376117;5843.474087332139;5913.113033045035;5934.258217722785;5957.314908785502;5642.492175704207;5752.309722833287;5792.958696684233;5836.474717275466;5848.590598658096;5768.451997060272;5805.042168042268;5819.9418005819825;5827.3007239131575;5844.386339434341;6313.715882785285;6330.905036424458;6341.58779679324;6350.999999999954;6396.9360306397275;6760.526763126583;6815.556988795713;6848.452123830081;6906.689198986058;6910.654467276667;6890.517663763539;6908.620025898574;6937.9653101734675;6947.305269473063;6959.060526828864;6172.87654246917;6266.874662506724;6291.622502649856;6325.936740632626;6326.430621244064;6949.235584085746;7060.3292687194635;7112.35988761014;7115.466340024519;7147.857042859114;6677.265500794909;6713.966430167818;6755.22314933779;6794.796156115324;6828.897566536506;6560.311167327457;6736.494762892803;6753.527253092335;6826.419754320839;6929.029935808991;6745.426638735762;6764.526483146133;6840.931590684129;6843.178818541707;6861.073755043105;6741.325867413219;6747.460203183734;6756.087928129639;6837.760678376233;6852.794416167523;5225.294585231021;5307.522322990872;5361.222622719683;5418.864528386743;5428.4028756836715;4650.511696271843;4703.0593881223895;4735.313379560013;4739.312799644033;4788.138135135709;5829.183914252008;5885.764569417261;5903.822885313448;5908.675022873783;5910.734016969247;6772.510047789478;6789.219239787488;6818.18181818185;6892.896606550906;6909.170899492093;5704.914426283609;5758.683272420057;5838.795642152504;5843.152742852262;5929.258842644669;5919.644821310735;5936.7922122725495;5941.257342832146;5952.7321270542925;5958.523318134538;6570.934290657032;6647.4349680276755;6648.933510664928;6732.663366831639;6739.865202695919;6597.538172327891;6773.559718618274;6799.286074962058;6892.827679308058;6899.655017249017;6542.5420220586;6635.469162467088;6707.731690732511;6724.831879203059;6731.865362692816;6673;6757;6779.830504237433;6786.3892249697765;6791.490638202055;6617.139771829631;6785.08401365829;6803.591784492748;6836.28219036994;6964.895526567004;6642.90035649456;6700.66496675174;6719.160104986877;6725.630090345078;6731.427828634621;6598.241202261801;6608.537402381787;6616.305287944697;6695.832604184934;6702.798916032527;6554.377334153248;6610.2398224204835;6618.940969444866;6621.668916554249;6662.400383965466;6695.765648202289;6736.393724564813;6770.052192693125;6779.966100169468;6791.830204244933;6419.4864410846085;6428.774992875227;6443.710033048618;6482.124913136666;6510.7721229756735 11:45:51 INFO - PID 3796 | |1;ext.html;869.213361907474;872.7599910024743;886.0652012127205;887.183790912361;916.3539704508322;41296;41830.790846045806;42129;42170;42228;37631;38006.619933800655;38044.42933355995;38055;38126.80936595313;7277.3086556777025;7334.413246940232;7409.814754631124;7415.925840741605;7416.443766717518;7307.963460182692;7385.778426647183;7404.111506619213;7406.740764073258;7421.332080112788;7890.171531989145;8070.596470176468;8116.431849770518;8122.9187708123045;8125.796855078611;8015.959920200391;8070.919290807075;8090.555019473926;8105.837883242331;8108.270255676958;7919.802004949865;7975.72084977023;8015.438919275594;8156.67373305073;8168.7549373518295;37680.623193767984;38061;38121;38141.23717525634;38249;3488.127968007998;3529.0824385659657;3532.6467353264725;3533.3463309287863;3534.717222622184;31190.532142017888;31406.685933140605;31495.37009259802;31497.05508834716;31657.683423165705;5192.9740351298005;5229.581633469314;5240.371155461331;5258.658187217857;5291.470852914677;198525;199730;199841;199885;199904.00047999813;50921.490785092414;51342.99999999925;51403;51439.22841157386;51442.74278628583;53844.73077634587;53916.73041634845;53999.73000135053;54010.72994635002;54177.729111354194;16588.25352859124;16926.74609880853;16955.576110597332;16964.236609352607;16978.745318820227;13780.173189608655;13874.375653095432;13875.791863122062;13877.097988630707;13907.026508144536;14552.272386380639;14632.634184145481;14682.119072855663;14705.705885882222;14864.108153510824;5909.494055626968;5993.9810232260625;5996.310424301174;6103.816885493442;6110.877782444326;993.895640957689;1010.3887148275335;1016.8118898003893;1017.1100287248657;1018;22168.445788855406;22300.44248893758;22314.442138946655;22387.216447424264;22701.09195632156;1096.5832983466391;1107.186218129674;1116.6203490813164;1116.9776604467866;1120;11885.5840045598;11931.463084161234;12003.159778815574;12072.275663460221;12231.082668799698;199452;202486;214616;214684;214806;43978.780106099905;44992;51524.742376287875;51837.740811296455;52542.21186682203;1477.0915886729583;1498.8725958293667;1507.2765072765135;1514.7576387777904;1517.924103794806;26397.472050559267;26610.866945665148;26674.733252667225;26697;26821.731782681924;36825.81587092047;37098.62901370952;37138;37139.81430092832;37238.25523489569;189956;190561;191442;192077;192500;33601;34362.82818585891;34535;34586.654133458345;34686;41840.790796045825;42508.5749142517;42641.57358426376;42654.78672606617;42991.57008429876;31000.379992399576;31013.534796978514;31305.53041704331;31404.685953140175;31559.36881262316;30970;31200.37599247957;31401.214969625944;31646.208844779063;31671;34348.58459677395;35480;35650;35864.64135358613;35928.28143437169;30683.2329191772;30711;31007.379852403275;31062;31533.526997094603;22307.77692223122;22335.664965025862;22351.217707380165;22434.102635894382;22602.09591616317 11:45:51 INFO - PID 3796 | |2;jquery.html;588.9970550147249;598.4554055809209;605.1225722702083;606.1150719948874;611.6666416802842;21844.672329915065;22809.771902280972;22812.88593557032;22825.201117960874;22846.31461056167;23768.524629507443;24296.271111866627;25613.103541376055;25768.871155644196;25809.87095064522;6394.232692076946;6596.60420374779;6600.504962127836;6601.603903765789;6607.20713514379;6366.172397588331;6433.970564709647;6532.673366331688;6537.2482164550975;6540.542162048659;6590.406863382319;6592.077109204692;6619.172603424572;6622.238442579092;6625.403713665769;6606.108175396308;6614.801555953329;6626.237982632011;6628.966855165741;6633.2703402625675;5823.56323275756;6070.180525629072;6096.298925623566;6096.72564734588;6148.262208535004;29590.70409295901;29860.253493662614;29881.551776723365;29987.950421735353;30096.84951575228;2054.599353126141;2058.2487392101925;2062.7834077421803;2071.8342532597358;2076.1591555420077;19665.705014424653;20054.1978320867;20174.689499153486;20231.595368092556;20387.286444974354;2443.511297740441;2458.5697502936914;2474.0969546115716;2518.9496210075695;2525.7726804587674;123336;130432;135634;141869;143225;14780.992726400698;14967.579879091132;15108.848911510744;15260.160691162093;15530.534083977498;23378;23416;23479.295621131394;23481.647775283385;23550;10275;10292.014094826214;10337.37975721459;10369.274150809522;10487.685369438928;9301.209397201179;9374.437533747998;9413.435193888388;9470.573824177929;9595.520223988773;9063.864042039375;9183.173514383603;9232.8615070774;9302.674406395743;9447.574859131355;2725.7955653325685;2786.6238057862333;2790.2610501927516;2814.282357998697;2839.33275680215;950.4202436513721;974.858645496399;976.3360914578155;981.5288661442405;994.3785134291068;19385.903070484557;19483.61032779365;19825.20699172017;19909.402717918485;20047.198112075355;991.2466525440573;1023.923205759571;1038.5430410619454;1041.942693151884;1049.2445439283704;10753.139748820076;10804.891951080546;10864.891351086388;10910.836337454944;11151.330920144817;444053.5109031472;448264;477416;480176;506027;113062.43468782604;114232;116194.41902790601;116227.41886290515;117221.41389293;1014.457265363042;1139.9658010259704;1179.4810283475244;1180.392098069495;1186.3771519952095;20479.4880127998;20479.69280460824;20727;20736.377908662766;21175.57648847045;52839.471605283456;52924.47075529196;53043.46956530539;53327.73336133295;53770.731146345584;66304.6684766573;66446.00330995135;66508.33491665022;66606.66696666485;66932;14400.495982640976;14516.34676439584;14560.126392416489;14580;14750;22429.878506074958;22977.540449191256;23042.078316867137;23042.193523226608;23488;18244.635107298047;18407;18487.260509579468;18635;18703.34538291153;16284.837151628331;16521.83478165251;16741.49775506737;16778.66442671115;17131.486055418358;18126.365577204735;18528.44414667562;18908.905455472635;18924.337648182798;19211.32760353381;14305.642358940693;14394.280285985868;14410.42358305698;14480.34838432252;14487.85512144865;18174.273029079217;18343;18382.632347353247;18423.078846057375;18518.16668249905 11:45:51 INFO - PID 3796 | |3;mootools.html;1333.513267657305;1383.605672383371;1395.8325000999878;1397.748405287048;1403.7753959366503;12660.873391266085;13318.134321269123;13331.533396331119;13350.732985340288;15708.84291157088;15526.456574019912;15804.367825286974;15806.525804225863;15809.92095039526;15813.367465301402;2708.756211940925;2760.7377299156547;2761.4477104579064;2762.599423083652;2764.156932135698;2687.126683827754;2692.8653567321653;2768.958465623007;2773.5285001549787;2789.7628701560393;2758.668959724836;2765.308672831792;2792.7346902044274;2794.6227259320035;2803.4673412051748;2683.5840444731098;2691.4213444109414;2706.8105232633725;2711.3628297350106;2716.008656840259;2678.638383818179;2680.8659567021764;2704.878280477383;2706.472237913588;2707.7021527631946;15164.317605707769;15556.766648500281;15597.92201038999;15610;15616;8000.479968802009;8177.754667359989;8436.746897593082;8459.280961118313;8466.83066338676;5429.701366424845;5539.362973258087;5648.4633959773755;5693.174489699012;5797.420257974211;1987.224982256921;2013.1544751204528;2051;2062.75246970363;2079.2514694709894;26750.46499070008;26888.73111268882;26932.59601105985;26999.595006074924;27013.72986270132;7478.177400485943;7572.507786993828;7770.0287464067;7835.333996610238;7837.804054898673;17310.221040052977;17343;17386.130693465275;17498.387556435464;17505.7374139388;7875.842483150305;8043.11525732169;8064.435489515678;8107.270345668918;8108;7356.448266380043;7457.440691948125;7589.203133670995;7726.9613651932505;7745.186755390603;4857.854264372075;5253.106971814801;5427.0773968425465;5466.753996070186;5470.91793623096;1476.7415702252063;1558.5636021913883;1587.2777886061815;1610.3880525400273;1623.3993422433775;807.7334479621711;824.468217999387;827.1645637905758;834.6119054639622;834.6911642692121;8508.10664880191;8568.143185681507;8625;8641.265492433087;8650.221480066699;952.6094301336419;963.1716723617683;969.6848524229654;974.6198982396871;975.3857366059184;5370.301860758154;5407.513323800798;5517.806876759294;5604.075327570905;5611.831645050655;21081.578368432547;22142.446438839157;22185.223517176822;22529.88735056314;22631.434214144778;22306.21928232504;22407.775922240897;22410.775892241196;22427.21504747326;22519.437014074778;10927.016568508872;11839.408029598486;11920.88079119215;12079.577214797615;12113.394330283627;8379.371547133867;8633.266172375419;8675.869861952202;8688.174623410765;8740.737777866674;18611.81388186101;18984.335548255745;18989.33537326187;19094.61810763805;19344.806551934864;19725.70411443858;19729.408117755916;19740.703889441957;20329;20337;11225.550977961117;11250.774984500427;11270.492827822603;11449.255798373079;11454.541818327174;13891.930540347234;14017.369218384993;14086.366113524711;14153.08004979673;14172.078814877;10061;11636.476358564054;11791.587294444653;11901.10741694359;12083.637490875288;11517.712057198301;11563.479643416234;11682.24065435744;11695.649130526097;11937.820932685843;9827.213822894008;9853.753656158653;9906.900930990887;10043;10076.798464030824;6875.621840798804;6993.160820701549;7004.719811207495;7041.788746337618;7148.392386647193;7302.794675481103;7433;7453.813654658677;7498.962505187439;7516.24837516244 11:45:51 INFO - PID 3796 | |4;prototype.html;506.7339646685492;527.970961597112;536.1207619504013;542.3708498142156;548.703700001999;6269.811905642832;6301.936980630204;6348.238211414637;6351;6357.50598609327;6258.624482531051;6277.278113017004;6294.370562943704;6309.589876658026;6336.42972132508;5244.659097158673;5257.684538927677;5265.157574788034;5271.736413179345;5316.76074576645;4916.475892473327;5125.692458452486;5148.536631703165;5196.480351964792;5282.339707536558;5017.19724844025;5022.146235140035;5040.319556859832;5063.417706963691;5100.234964755279;5061.063703214881;5105.361829771278;5119.12974794284;5137.845864624067;5144.151215049513;4406.140802543506;4528.298113792367;4557.179707652621;4566.474855391606;4576.54234576543;6177.1969643945995;6186.56694031418;6212.4408803207925;6243.282022567418;6270.8118756436925;5722.256106706143;5726.713664316809;5776.797812076557;5804.651720896717;5820.476157145835;6565;6573.408393244583;6591.373819487141;6637.601743895381;6653.367930046637;4982.800687972477;4986.900261994776;4989.376327959005;5003.749812509396;5009.298698182258;6637.2367177774695;6729.93270067298;6826.829329266808;6861.55399899005;6880.415164711006;5043.394792624908;5073.3911930568565;5087.151195330553;5100.668456550312;5105.055564720538;5141.2545180948555;5148.716820574904;5153.252778347119;5170.482951704799;5201.557867581298;5794.62334948227;5808.448197421239;5821.476067153976;5832.154337621021;5838.4453476919625;6537.5096867734155;6539.411452969255;6673;6679.365460281266;6681.265060843303;1743.4396215387158;1772.8758986871053;1774.698301288784;1777.4447358561258;1782.393986044751;1174.929504229749;1223.1254652923203;1250.2061191143507;1263.210493441599;1264.3804535777404;5583.553315734732;5637.915431268534;5698.031334673033;5709.229254050733;5736.196932429463;6597.60414375139;6720.126383570105;6762.966185169043;6823.215330237086;6825.795226143224;5729.885402292014;5747.827565173052;5752.827415177551;5786.537077033827;5831.62094463867;3548.8580456781438;3577.713782897362;3589.3718599245026;3607.3687104756564;3624.9456258156147;6453.838654033687;6462.386073323027;6512.73949042033;6562.67186640666;6563.770268040691;6867.931320686829;6900.2409734929115;6904.792856214322;6914.585124892523;6958.756443524452;6487.6756162191705;6516.283208847118;6526.531530405716;6553.934460655332;6559.344065593403;6717.261101278953;6737.32626737342;6774.2418943899265;6778.220504641832;6809.829754256183;6614.70233839488;6672.132622759011;6723.7310507581105;6726;6734.326567343226;6387.393197646216;6424;6435.22777266731;6465.833945628267;6500.772472963424;5028.723420211923;5062.291279220985;5075.416327122428;5085.4406015337545;5106.110739026584;6404.199475065617;6735.562188457735;6761.290064543152;6761.661916904037;6853.691583878638;6334.144890439732;6428.774992875227;6497.155369801895;6568.901466477911;6660.733570657119;6355.745770169141;6396.680165991775;6415.550911436155;6435.680685459376;6472.799248255616;6185.195924529782;6352.523560733056;6384.9042264367;6389.648569328731;6428.582142160744;6484.157059582224;6525.836854078686;6595.967020164869;6610;6651.567648102858;6263.68681565929;6267.2479302484;6306.369363063841;6396.264429590657;6427.292997770148 11:45:51 INFO - PID 3796 | |5;yui.html;922.7462447826847;941.670415354626;942.9104235097672;946.3470205558165;948.1135138645365;19618.215271389145;19810.80189198111;20132.59734805305;20151.193952241894;20207.898960505194;19137.61724765504;19228.13473393697;19237.807621923777;19287.710684339712;19300.227990880383;973.7370909854335;989.0949780950458;992.8361820299642;993.2252842782641;993.46849435552;966.7148191283553;996.875390576178;1006.134724137245;1006.3760468509535;1007.0584003956325;1057.666834946993;1057.762003549203;1060.5545670818237;1060.734816295926;1060.8833028366873;984.7882705218412;1020.4336593190776;1030.1449796668746;1051.2483574244413;1057.4606950455245;750.8423231121471;753.8077790163528;757.1368639750689;758.2606958215696;760.1448370583093;19896.303629373047;19957.800421995886;20048.79951200484;20097.59804803896;20126.798732012787;21498.78501214999;21597.67603485949;22023.119075236973;22192.334229973127;22279.554408911732;16973.745393819103;17124.74312885308;17192.398266060627;17229.56926076858;17568.38510652121;3748.775073495599;3763.717721170896;3770.6794922431627;3773.8490460381554;3776.093737503007;136580.31709841389;138139.30930345383;139041;141654.29172854172;141855;16412.261448234858;16781.91609041947;16838;16851.494455166365;16855.578610534834;29271.7072829269;31646;31704.682953170635;31826;31832.204194895312;9232.815343693088;9234.353595248269;9291.814163716823;9321.533923303808;9342.06579342074;4093.283675356801;4097.078157414558;4210.115875666083;4214.325707886724;4214.641755450821;5019.573336266385;5095.949040509621;5108.106081435734;5144.948550514522;5156.20078887773;966.5167416291854;975.3952549419405;991.4051569058652;997.9051990060933;1005.3364779245809;668.9632070236183;683.0846665468297;695.3429009585993;698.4028655499576;703.7958991892397;9823.950880245553;10939.726506837393;10977.670669879917;10979.121670266359;11828.88171118295;640.5932233032058;650.5056157320375;665.118717699041;680.6052489556046;686.0463955102412;5266.92099618506;5313.654612450178;5351.331083614548;5351.946480535223;5375.704336261543;116197.4190129044;116282.41858790652;118200;120721.39639301923;121486;85281.57359213164;87712;105402;106182.46908765407;106959.46520267348;89702;93907;94122.52938735262;94647;97822.85503327477;11324.660260192208;11363.54545818158;12110.515579376726;12458.937705311415;12469.064820138707;39982.40026399664;42789.35815962701;42868.35697464603;43825;44595.55404445914;54916.72541637266;74210.25789742034;74334.62832685802;77195.61402192953;78442;17017.659646807242;17110.315587376863;17133.314667413164;17148.657026859644;17327.82672173262;18291.72562411538;19488.902555487133;19493.61012779708;19553.315633952745;19625.90187049113;14364.928175359057;14831.258437078319;15043.398264069314;15124.54626361211;15159;17127.828721713122;17209.655806884042;17238.396656116976;17239.138043097544;17739.911300443415;16729.33082676728;16817.915910420368;17232.827671723124;17387.652246955244;17494.650106998044;12924.418401171783;12954.676133096747;12998.80501792455;13084.411201496147;13214.801777973531;13150.21098734079;13289.734205316034;13353.53262635803;13447.731045379232;13549.864501355254 11:45:51 INFO - PID 3796 | __end_tp_report 11:45:51 INFO - PID 3796 | __start_cc_report 11:45:51 INFO - PID 3796 | _x_x_mozilla_cycle_collect,288 11:45:51 INFO - PID 3796 | __end_cc_report 11:45:51 INFO - PID 3796 | __startTimestamp1506192351789__endTimestamp 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | ------- Summary: start ------- 11:45:51 INFO - PID 3796 | Number of tests: 6 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#0] dojo.html Cycles:165 Average:6269.99 Median:6560.31 stddev:764.10 (11.6%) stddev-sans-first:725.09 11:45:51 INFO - PID 3796 | Values: 3109.0 3126.1 3141.6 3154.6 3156.6 6209.3 6287.0 6324.1 6339.2 6362.8 6164.7 6189.5 6205.0 6247.9 6337.9 5822.9 5904.9 5932.5 5932.6 5955.4 5789.2 5805.4 5851.1 5865.1 5920.3 5803.4 5843.5 5913.1 5934.3 5957.3 5642.5 5752.3 5793.0 5836.5 5848.6 5768.5 5805.0 5819.9 5827.3 5844.4 6313.7 6330.9 6341.6 6351.0 6396.9 6760.5 6815.6 6848.5 6906.7 6910.7 6890.5 6908.6 6938.0 6947.3 6959.1 6172.9 6266.9 6291.6 6325.9 6326.4 6949.2 7060.3 7112.4 7115.5 7147.9 6677.3 6714.0 6755.2 6794.8 6828.9 6560.3 6736.5 6753.5 6826.4 6929.0 6745.4 6764.5 6840.9 6843.2 6861.1 6741.3 6747.5 6756.1 6837.8 6852.8 5225.3 5307.5 5361.2 5418.9 5428.4 4650.5 4703.1 4735.3 4739.3 4788.1 5829.2 5885.8 5903.8 5908.7 5910.7 6772.5 6789.2 6818.2 6892.9 6909.2 5704.9 5758.7 5838.8 5843.2 5929.3 5919.6 5936.8 5941.3 5952.7 5958.5 6570.9 6647.4 6648.9 6732.7 6739.9 6597.5 6773.6 6799.3 6892.8 6899.7 6542.5 6635.5 6707.7 6724.8 6731.9 6673.0 6757.0 6779.8 6786.4 6791.5 6617.1 6785.1 6803.6 6836.3 6964.9 6642.9 6700.7 6719.2 6725.6 6731.4 6598.2 6608.5 6616.3 6695.8 6702.8 6554.4 6610.2 6618.9 6621.7 6662.4 6695.8 6736.4 6770.1 6780.0 6791.8 6419.5 6428.8 6443.7 6482.1 6510.8 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#1] ext.html Cycles:180 Average:37054.34 Median:3508.61 stddev:51755.09 (1475.1%) stddev-sans-first:51828.95 11:45:51 INFO - PID 3796 | Values: 869.2 872.8 886.1 887.2 916.4 41296.0 41830.8 42129.0 42170.0 42228.0 37631.0 38006.6 38044.4 38055.0 38126.8 7277.3 7334.4 7409.8 7415.9 7416.4 7308.0 7385.8 7404.1 7406.7 7421.3 7890.2 8070.6 8116.4 8122.9 8125.8 8016.0 8070.9 8090.6 8105.8 8108.3 7919.8 7975.7 8015.4 8156.7 8168.8 37680.6 38061.0 38121.0 38141.2 38249.0 3488.1 3529.1 3532.6 3533.3 3534.7 31190.5 31406.7 31495.4 31497.1 31657.7 5193.0 5229.6 5240.4 5258.7 5291.5 198525.0 199730.0 199841.0 199885.0 199904.0 50921.5 51343.0 51403.0 51439.2 51442.7 53844.7 53916.7 53999.7 54010.7 54177.7 16588.3 16926.7 16955.6 16964.2 16978.7 13780.2 13874.4 13875.8 13877.1 13907.0 14552.3 14632.6 14682.1 14705.7 14864.1 5909.5 5994.0 5996.3 6103.8 6110.9 993.9 1010.4 1016.8 1017.1 1018.0 22168.4 22300.4 22314.4 22387.2 22701.1 1096.6 1107.2 1116.6 1117.0 1120.0 11885.6 11931.5 12003.2 12072.3 12231.1 199452.0 202486.0 214616.0 214684.0 214806.0 43978.8 44992.0 51524.7 51837.7 52542.2 1477.1 1498.9 1507.3 1514.8 1517.9 26397.5 26610.9 26674.7 26697.0 26821.7 36825.8 37098.6 37138.0 37139.8 37238.3 189956.0 190561.0 191442.0 192077.0 192500.0 33601.0 34362.8 34535.0 34586.7 34686.0 41840.8 42508.6 42641.6 42654.8 42991.6 31000.4 31013.5 31305.5 31404.7 31559.4 30970.0 31200.4 31401.2 31646.2 31671.0 34348.6 35480.0 35650.0 35864.6 35928.3 30683.2 30711.0 31007.4 31062.0 31533.5 22307.8 22335.7 22351.2 22434.1 22602.1 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#2] jquery.html Cycles:180 Average:34042.30 Median:23009.81 stddev:79553.54 (345.7%) stddev-sans-first:79737.06 11:45:51 INFO - PID 3796 | Values: 589.0 598.5 605.1 606.1 611.7 21844.7 22809.8 22812.9 22825.2 22846.3 23768.5 24296.3 25613.1 25768.9 25809.9 6394.2 6596.6 6600.5 6601.6 6607.2 6366.2 6434.0 6532.7 6537.2 6540.5 6590.4 6592.1 6619.2 6622.2 6625.4 6606.1 6614.8 6626.2 6629.0 6633.3 5823.6 6070.2 6096.3 6096.7 6148.3 29590.7 29860.3 29881.6 29988.0 30096.8 2054.6 2058.2 2062.8 2071.8 2076.2 19665.7 20054.2 20174.7 20231.6 20387.3 2443.5 2458.6 2474.1 2518.9 2525.8 123336.0 130432.0 135634.0 141869.0 143225.0 14781.0 14967.6 15108.8 15260.2 15530.5 23378.0 23416.0 23479.3 23481.6 23550.0 10275.0 10292.0 10337.4 10369.3 10487.7 9301.2 9374.4 9413.4 9470.6 9595.5 9063.9 9183.2 9232.9 9302.7 9447.6 2725.8 2786.6 2790.3 2814.3 2839.3 950.4 974.9 976.3 981.5 994.4 19385.9 19483.6 19825.2 19909.4 20047.2 991.2 1023.9 1038.5 1041.9 1049.2 10753.1 10804.9 10864.9 10910.8 11151.3 444053.5 448264.0 477416.0 480176.0 506027.0 113062.4 114232.0 116194.4 116227.4 117221.4 1014.5 1140.0 1179.5 1180.4 1186.4 20479.5 20479.7 20727.0 20736.4 21175.6 52839.5 52924.5 53043.5 53327.7 53770.7 66304.7 66446.0 66508.3 66606.7 66932.0 14400.5 14516.3 14560.1 14580.0 14750.0 22429.9 22977.5 23042.1 23042.2 23488.0 18244.6 18407.0 18487.3 18635.0 18703.3 16284.8 16521.8 16741.5 16778.7 17131.5 18126.4 18528.4 18908.9 18924.3 19211.3 14305.6 14394.3 14410.4 14480.3 14487.9 18174.3 18343.0 18382.6 18423.1 18518.2 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#3] mootools.html Cycles:180 Average:9534.15 Median:26966.10 stddev:6804.94 (25.2%) stddev-sans-first:6796.13 11:45:51 INFO - PID 3796 | Values: 1333.5 1383.6 1395.8 1397.7 1403.8 12660.9 13318.1 13331.5 13350.7 15708.8 15526.5 15804.4 15806.5 15809.9 15813.4 2708.8 2760.7 2761.4 2762.6 2764.2 2687.1 2692.9 2769.0 2773.5 2789.8 2758.7 2765.3 2792.7 2794.6 2803.5 2683.6 2691.4 2706.8 2711.4 2716.0 2678.6 2680.9 2704.9 2706.5 2707.7 15164.3 15556.8 15597.9 15610.0 15616.0 8000.5 8177.8 8436.7 8459.3 8466.8 5429.7 5539.4 5648.5 5693.2 5797.4 1987.2 2013.2 2051.0 2062.8 2079.3 26750.5 26888.7 26932.6 26999.6 27013.7 7478.2 7572.5 7770.0 7835.3 7837.8 17310.2 17343.0 17386.1 17498.4 17505.7 7875.8 8043.1 8064.4 8107.3 8108.0 7356.4 7457.4 7589.2 7727.0 7745.2 4857.9 5253.1 5427.1 5466.8 5470.9 1476.7 1558.6 1587.3 1610.4 1623.4 807.7 824.5 827.2 834.6 834.7 8508.1 8568.1 8625.0 8641.3 8650.2 952.6 963.2 969.7 974.6 975.4 5370.3 5407.5 5517.8 5604.1 5611.8 21081.6 22142.4 22185.2 22529.9 22631.4 22306.2 22407.8 22410.8 22427.2 22519.4 10927.0 11839.4 11920.9 12079.6 12113.4 8379.4 8633.3 8675.9 8688.2 8740.7 18611.8 18984.3 18989.3 19094.6 19344.8 19725.7 19729.4 19740.7 20329.0 20337.0 11225.6 11250.8 11270.5 11449.3 11454.5 13891.9 14017.4 14086.4 14153.1 14172.1 10061.0 11636.5 11791.6 11901.1 12083.6 11517.7 11563.5 11682.2 11695.6 11937.8 9827.2 9853.8 9906.9 10043.0 10076.8 6875.6 6993.2 7004.7 7041.8 7148.4 7302.8 7433.0 7453.8 7499.0 7516.2 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#4] prototype.html Cycles:180 Average:5552.29 Median:6261.16 stddev:1534.32 (24.5%) stddev-sans-first:1491.15 11:45:51 INFO - PID 3796 | Values: 506.7 528.0 536.1 542.4 548.7 6269.8 6301.9 6348.2 6351.0 6357.5 6258.6 6277.3 6294.4 6309.6 6336.4 5244.7 5257.7 5265.2 5271.7 5316.8 4916.5 5125.7 5148.5 5196.5 5282.3 5017.2 5022.1 5040.3 5063.4 5100.2 5061.1 5105.4 5119.1 5137.8 5144.2 4406.1 4528.3 4557.2 4566.5 4576.5 6177.2 6186.6 6212.4 6243.3 6270.8 5722.3 5726.7 5776.8 5804.7 5820.5 6565.0 6573.4 6591.4 6637.6 6653.4 4982.8 4986.9 4989.4 5003.7 5009.3 6637.2 6729.9 6826.8 6861.6 6880.4 5043.4 5073.4 5087.2 5100.7 5105.1 5141.3 5148.7 5153.3 5170.5 5201.6 5794.6 5808.4 5821.5 5832.2 5838.4 6537.5 6539.4 6673.0 6679.4 6681.3 1743.4 1772.9 1774.7 1777.4 1782.4 1174.9 1223.1 1250.2 1263.2 1264.4 5583.6 5637.9 5698.0 5709.2 5736.2 6597.6 6720.1 6763.0 6823.2 6825.8 5729.9 5747.8 5752.8 5786.5 5831.6 3548.9 3577.7 3589.4 3607.4 3624.9 6453.8 6462.4 6512.7 6562.7 6563.8 6867.9 6900.2 6904.8 6914.6 6958.8 6487.7 6516.3 6526.5 6553.9 6559.3 6717.3 6737.3 6774.2 6778.2 6809.8 6614.7 6672.1 6723.7 6726.0 6734.3 6387.4 6424.0 6435.2 6465.8 6500.8 5028.7 5062.3 5075.4 5085.4 5106.1 6404.2 6735.6 6761.3 6761.7 6853.7 6334.1 6428.8 6497.2 6568.9 6660.7 6355.7 6396.7 6415.6 6435.7 6472.8 6185.2 6352.5 6384.9 6389.6 6428.6 6484.2 6525.8 6596.0 6610.0 6651.6 6263.7 6267.2 6306.4 6396.3 6427.3 11:45:51 INFO - PID 3796 | 11:45:51 INFO - PID 3796 | [#5] yui.html Cycles:180 Average:24505.55 Median:20112.20 stddev:34678.38 (172.4%) stddev-sans-first:34730.45 11:45:51 INFO - PID 3796 | Values: 922.7 941.7 942.9 946.3 948.1 19618.2 19810.8 20132.6 20151.2 20207.9 19137.6 19228.1 19237.8 19287.7 19300.2 973.7 989.1 992.8 993.2 993.5 966.7 996.9 1006.1 1006.4 1007.1 1057.7 1057.8 1060.6 1060.7 1060.9 984.8 1020.4 1030.1 1051.2 1057.5 750.8 753.8 757.1 758.3 760.1 19896.3 19957.8 20048.8 20097.6 20126.8 21498.8 21597.7 22023.1 22192.3 22279.6 16973.7 17124.7 17192.4 17229.6 17568.4 3748.8 3763.7 3770.7 3773.8 3776.1 136580.3 138139.3 139041.0 141654.3 141855.0 16412.3 16781.9 16838.0 16851.5 16855.6 29271.7 31646.0 31704.7 31826.0 31832.2 9232.8 9234.4 9291.8 9321.5 9342.1 4093.3 4097.1 4210.1 4214.3 4214.6 5019.6 5095.9 5108.1 5144.9 5156.2 966.5 975.4 991.4 997.9 1005.3 669.0 683.1 695.3 698.4 703.8 9824.0 10939.7 10977.7 10979.1 11828.9 640.6 650.5 665.1 680.6 686.0 5266.9 5313.7 5351.3 5351.9 5375.7 116197.4 116282.4 118200.0 120721.4 121486.0 85281.6 87712.0 105402.0 106182.5 106959.5 89702.0 93907.0 94122.5 94647.0 97822.9 11324.7 11363.5 12110.5 12458.9 12469.1 39982.4 42789.4 42868.4 43825.0 44595.6 54916.7 74210.3 74334.6 77195.6 78442.0 17017.7 17110.3 17133.3 17148.7 17327.8 18291.7 19488.9 19493.6 19553.3 19625.9 14364.9 14831.3 15043.4 15124.5 15159.0 17127.8 17209.7 17238.4 17239.1 17739.9 16729.3 16817.9 17232.8 17387.7 17494.7 12924.4 12954.7 12998.8 13084.4 13214.8 13150.2 13289.7 13353.5 13447.7 13549.9 11:45:51 INFO - PID 3796 | -------- Summary: end -------- 11:45:51 INFO - PID 3796 | 11:45:52 INFO - TEST-INFO | 3796: exit 0 11:45:52 INFO - TEST-OK | dromaeo_css | took 1113384ms 11:45:52 INFO - TEST-START | kraken 11:45:52 INFO - Initialising browser for kraken test... 11:45:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60470/getInfo.html -profile /tmp/tmp2L6ucx/profile 11:45:52 INFO - TEST-INFO | started process 4169 (/builds/slave/test/build/application/firefox/firefox http://localhost:60470/getInfo.html) 11:45:58 INFO - TEST-INFO | 4169: exit 0 11:45:58 INFO - Browser initialized. 11:45:58 INFO - Running cycle 1/1 for kraken test... 11:45:58 INFO - Using env: {'DISPLAY': ':0', 11:45:58 INFO - 'HOME': '/home/cltbld', 11:45:58 INFO - 'JSGC_DISABLE_POISONING': '1', 11:45:58 INFO - 'LANG': 'en_US.UTF-8', 11:45:58 INFO - 'LANGUAGE': 'en_US:en', 11:45:58 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:45:58 INFO - 'LOGNAME': 'cltbld', 11:45:58 INFO - 'MAIL': '/var/mail/cltbld', 11:45:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:45:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:45:58 INFO - 'MOZ_CRASHREPORTER': '1', 11:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:45:58 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:45:58 INFO - 'MOZ_NO_REMOTE': '1', 11:45:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:45:58 INFO - 'NO_EM_RESTART': '1', 11:45:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:45:58 INFO - 'PWD': '/builds/slave/test', 11:45:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:45:58 INFO - 'RUST_BACKTRACE': 'full', 11:45:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:45:58 INFO - 'SHELL': '/bin/bash', 11:45:58 INFO - 'SHLVL': '1', 11:45:58 INFO - 'STYLO_FORCE_DISABLED': '1', 11:45:58 INFO - 'TERM': 'linux', 11:45:58 INFO - 'TMOUT': '86400', 11:45:58 INFO - 'USER': 'cltbld', 11:45:58 INFO - 'XDG_SESSION_COOKIE': '5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717', 11:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:45:58 INFO - '_': '/tools/buildbot/bin/python'} 11:45:58 INFO - TEST-INFO | started process 4403 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2L6ucx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:45:59 INFO - PID 4403 | 11:45:59 INFO - PID 4403 | (/builds/slave/test/build/application/firefox/firefox:4452): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:45:59 INFO - PID 4403 | 11:46:10 INFO - PID 4403 | RSS: Main: 151248896 11:46:10 INFO - PID 4403 | 11:46:12 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60470/tests/kraken/driver.html?testName=audio-beat-detection) 11:46:13 INFO - PID 4403 | RSS: Main: 156692480 11:46:13 INFO - PID 4403 | 11:46:16 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60470/tests/kraken/driver.html?testName=audio-dft) 11:46:16 INFO - PID 4403 | RSS: Main: 157093888 11:46:16 INFO - PID 4403 | 11:46:19 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60470/tests/kraken/driver.html?testName=audio-fft) 11:46:20 INFO - PID 4403 | RSS: Main: 154705920 11:46:20 INFO - PID 4403 | 11:46:22 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60470/tests/kraken/driver.html?testName=audio-oscillator) 11:46:23 INFO - PID 4403 | RSS: Main: 154750976 11:46:23 INFO - PID 4403 | 11:46:25 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:46:25 INFO - PID 4403 | RSS: Main: 154611712 11:46:25 INFO - PID 4403 | 11:46:28 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60470/tests/kraken/driver.html?testName=imaging-darkroom) 11:46:29 INFO - PID 4403 | RSS: Main: 158392320 11:46:29 INFO - PID 4403 | 11:46:33 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60470/tests/kraken/driver.html?testName=imaging-desaturate) 11:46:33 INFO - PID 4403 | RSS: Main: 158019584 11:46:33 INFO - PID 4403 | 11:46:36 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60470/tests/kraken/driver.html?testName=json-parse-financial) 11:46:37 INFO - PID 4403 | RSS: Main: 157728768 11:46:37 INFO - PID 4403 | 11:46:39 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:46:39 INFO - PID 4403 | RSS: Main: 157691904 11:46:39 INFO - PID 4403 | 11:46:41 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:46:41 INFO - PID 4403 | RSS: Main: 157638656 11:46:41 INFO - PID 4403 | 11:46:44 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:46:45 INFO - PID 4403 | RSS: Main: 154259456 11:46:45 INFO - PID 4403 | 11:46:47 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:46:48 INFO - PID 4403 | RSS: Main: 155099136 11:46:48 INFO - PID 4403 | 11:46:51 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:46:52 INFO - PID 4403 | RSS: Main: 154976256 11:46:52 INFO - PID 4403 | 11:46:53 INFO - PID 4403 | Cycle 1(1): loaded http://localhost:60470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60470/tests/kraken/driver.html?testName=ai-astar) 11:46:54 INFO - PID 4403 | RSS: Main: 156356608 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | __start_tp_report 11:46:54 INFO - PID 4403 | _x_x_mozilla_page_load 11:46:54 INFO - PID 4403 | _x_x_mozilla_page_load_details 11:46:54 INFO - PID 4403 | |i|pagename|runs| 11:46:54 INFO - PID 4403 | |0;ai-astar;107;107;109;108;108;108;107;106;106;107 11:46:54 INFO - PID 4403 | |1;audio-beat-detection;116;116;121;117;142;118;118;119;152;116 11:46:54 INFO - PID 4403 | |2;audio-dft;164;162;164;162;161;163;167;166;171;165 11:46:54 INFO - PID 4403 | |3;audio-fft;75;74;75;74;74;73;74;74;74;73 11:46:54 INFO - PID 4403 | |4;audio-oscillator;80;79;80;78;78;78;79;79;78;79 11:46:54 INFO - PID 4403 | |5;imaging-gaussian-blur;113;113;121;113;115;113;114;114;110;114 11:46:54 INFO - PID 4403 | |6;imaging-darkroom;151;151;151;151;151;150;150;151;152;152 11:46:54 INFO - PID 4403 | |7;imaging-desaturate;93;95;94;94;95;94;95;95;95;94 11:46:54 INFO - PID 4403 | |8;json-parse-financial;55;55;53;54;55;65;55;55;61;54 11:46:54 INFO - PID 4403 | |9;json-stringify-tinderbox;38;38;37;38;37;38;38;39;38;38 11:46:54 INFO - PID 4403 | |10;stanford-crypto-aes;74;74;77;74;75;74;73;75;78;73 11:46:54 INFO - PID 4403 | |11;stanford-crypto-ccm;129;111;109;122;121;115;117;114;111;118 11:46:54 INFO - PID 4403 | |12;stanford-crypto-pbkdf2;170;174;169;167;169;173;169;171;172;168 11:46:54 INFO - PID 4403 | |13;stanford-crypto-sha256-iterative;66;68;68;66;68;65;65;64;66;66 11:46:54 INFO - PID 4403 | __end_tp_report 11:46:54 INFO - PID 4403 | __start_cc_report 11:46:54 INFO - PID 4403 | _x_x_mozilla_cycle_collect,720 11:46:54 INFO - PID 4403 | __end_cc_report 11:46:54 INFO - PID 4403 | __startTimestamp1506192414094__endTimestamp 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | ------- Summary: start ------- 11:46:54 INFO - PID 4403 | Number of tests: 14 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#0] ai-astar Cycles:10 Average:107.30 Median:107.50 stddev:0.95 (0.9%) stddev-sans-first:1.00 11:46:54 INFO - PID 4403 | Values: 107.0 107.0 109.0 108.0 108.0 108.0 107.0 106.0 106.0 107.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:118.50 stddev:12.70 (10.7%) stddev-sans-first:13.18 11:46:54 INFO - PID 4403 | Values: 116.0 116.0 121.0 117.0 142.0 118.0 118.0 119.0 152.0 116.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.95 (1.8%) stddev-sans-first:3.13 11:46:54 INFO - PID 4403 | Values: 164.0 162.0 164.0 162.0 161.0 163.0 167.0 166.0 171.0 165.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#3] audio-fft Cycles:10 Average:74.00 Median:74.00 stddev:0.67 (0.9%) stddev-sans-first:0.60 11:46:54 INFO - PID 4403 | Values: 75.0 74.0 75.0 74.0 74.0 73.0 74.0 74.0 74.0 73.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#4] audio-oscillator Cycles:10 Average:78.80 Median:79.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 11:46:54 INFO - PID 4403 | Values: 80.0 79.0 80.0 78.0 78.0 78.0 79.0 79.0 78.0 79.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:2.79 (2.4%) stddev-sans-first:2.93 11:46:54 INFO - PID 4403 | Values: 113.0 113.0 121.0 113.0 115.0 113.0 114.0 114.0 110.0 114.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 11:46:54 INFO - PID 4403 | Values: 151.0 151.0 151.0 151.0 151.0 150.0 150.0 151.0 152.0 152.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 11:46:54 INFO - PID 4403 | Values: 93.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 94.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:55.00 stddev:3.77 (6.8%) stddev-sans-first:3.97 11:46:54 INFO - PID 4403 | Values: 55.0 55.0 53.0 54.0 55.0 65.0 55.0 55.0 61.0 54.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#9] json-stringify-tinderbox Cycles:10 Average:37.90 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 11:46:54 INFO - PID 4403 | Values: 38.0 38.0 37.0 38.0 37.0 38.0 38.0 39.0 38.0 38.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.50 stddev:1.64 (2.2%) stddev-sans-first:1.72 11:46:54 INFO - PID 4403 | Values: 74.0 74.0 77.0 74.0 75.0 74.0 73.0 75.0 78.0 73.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:117.50 stddev:6.09 (5.2%) stddev-sans-first:4.56 11:46:54 INFO - PID 4403 | Values: 129.0 111.0 109.0 122.0 121.0 115.0 117.0 114.0 111.0 118.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:170.50 stddev:2.25 (1.3%) stddev-sans-first:2.39 11:46:54 INFO - PID 4403 | Values: 170.0 174.0 169.0 167.0 169.0 173.0 169.0 171.0 172.0 168.0 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 11:46:54 INFO - PID 4403 | Values: 66.0 68.0 68.0 66.0 68.0 65.0 65.0 64.0 66.0 66.0 11:46:54 INFO - PID 4403 | -------- Summary: end -------- 11:46:54 INFO - PID 4403 | 11:46:54 INFO - PID 4403 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:46:54 INFO - TEST-INFO | 4403: exit 0 11:46:54 INFO - TEST-OK | kraken | took 62357ms 11:46:54 INFO - SUITE-END | took 1175s 11:46:55 INFO - Completed test suite (00:19:36) 11:46:55 INFO - javascript benchmark 11:46:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8605.029347862872, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.953365699514, 3126.062181345596, 3141.56018157458, 3154.5741324921128, 3156.573862528558, 6209.348018458065, 6286.968565157168, 6324.1462402575635, 6339.239291285041, 6362.777302794398, 6164.691765411734, 6189.504839612831, 6204.96897515513, 6247.906281405772, 6337.873242535146, 5822.941770582303, 5904.852378690524, 5932.466078052985, 5932.6143800653035, 5955.434233747787, 5789.231657322865, 5805.419458054182, 5851.122331650266, 5865.120231965197, 5920.348761636238, 5803.448672376117, 5843.474087332139, 5913.113033045035, 5934.258217722785, 5957.314908785502, 5642.492175704207, 5752.309722833287, 5792.958696684233, 5836.474717275466, 5848.590598658096, 5768.451997060272, 5805.042168042268, 5819.9418005819825, 5827.3007239131575, 5844.386339434341, 6313.715882785285, 6330.905036424458, 6341.58779679324, 6350.999999999954, 6396.9360306397275, 6760.526763126583, 6815.556988795713, 6848.452123830081, 6906.689198986058, 6910.654467276667, 6890.517663763539, 6908.620025898574, 6937.9653101734675, 6947.305269473063, 6959.060526828864, 6172.87654246917, 6266.874662506724, 6291.622502649856, 6325.936740632626, 6326.430621244064, 6949.235584085746, 7060.3292687194635, 7112.35988761014, 7115.466340024519, 7147.857042859114, 6677.265500794909, 6713.966430167818, 6755.22314933779, 6794.796156115324, 6828.897566536506, 6560.311167327457, 6736.494762892803, 6753.527253092335, 6826.419754320839, 6929.029935808991, 6745.426638735762, 6764.526483146133, 6840.931590684129, 6843.178818541707, 6861.073755043105, 6741.325867413219, 6747.460203183734, 6756.087928129639, 6837.760678376233, 6852.794416167523, 5225.294585231021, 5307.522322990872, 5361.222622719683, 5418.864528386743, 5428.4028756836715, 4650.511696271843, 4703.0593881223895, 4735.313379560013, 4739.312799644033, 4788.138135135709, 5829.183914252008, 5885.764569417261, 5903.822885313448, 5908.675022873783, 5910.734016969247, 6772.510047789478, 6789.219239787488, 6818.18181818185, 6892.896606550906, 6909.170899492093, 5704.914426283609, 5758.683272420057, 5838.795642152504, 5843.152742852262, 5929.258842644669, 5919.644821310735, 5936.7922122725495, 5941.257342832146, 5952.7321270542925, 5958.523318134538, 6570.934290657032, 6647.4349680276755, 6648.933510664928, 6732.663366831639, 6739.865202695919, 6597.538172327891, 6773.559718618274, 6799.286074962058, 6892.827679308058, 6899.655017249017, 6542.5420220586, 6635.469162467088, 6707.731690732511, 6724.831879203059, 6731.865362692816, 6673.0, 6757.0, 6779.830504237433, 6786.3892249697765, 6791.490638202055, 6617.139771829631, 6785.08401365829, 6803.591784492748, 6836.28219036994, 6964.895526567004, 6642.90035649456, 6700.66496675174, 6719.160104986877, 6725.630090345078, 6731.427828634621, 6598.241202261801, 6608.537402381787, 6616.305287944697, 6695.832604184934, 6702.798916032527, 6554.377334153248, 6610.2398224204835, 6618.940969444866, 6621.668916554249, 6662.400383965466, 6695.765648202289, 6736.393724564813, 6770.052192693125, 6779.966100169468, 6791.830204244933, 6419.4864410846085, 6428.774992875227, 6443.710033048618, 6482.124913136666, 6510.7721229756735], "value": 6210.440014465223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.213361907474, 872.7599910024743, 886.0652012127205, 887.183790912361, 916.3539704508322, 41296.0, 41830.790846045806, 42129.0, 42170.0, 42228.0, 37631.0, 38006.619933800655, 38044.42933355995, 38055.0, 38126.80936595313, 7277.3086556777025, 7334.413246940232, 7409.814754631124, 7415.925840741605, 7416.443766717518, 7307.963460182692, 7385.778426647183, 7404.111506619213, 7406.740764073258, 7421.332080112788, 7890.171531989145, 8070.596470176468, 8116.431849770518, 8122.9187708123045, 8125.796855078611, 8015.959920200391, 8070.919290807075, 8090.555019473926, 8105.837883242331, 8108.270255676958, 7919.802004949865, 7975.72084977023, 8015.438919275594, 8156.67373305073, 8168.7549373518295, 37680.623193767984, 38061.0, 38121.0, 38141.23717525634, 38249.0, 3488.127968007998, 3529.0824385659657, 3532.6467353264725, 3533.3463309287863, 3534.717222622184, 31190.532142017888, 31406.685933140605, 31495.37009259802, 31497.05508834716, 31657.683423165705, 5192.9740351298005, 5229.581633469314, 5240.371155461331, 5258.658187217857, 5291.470852914677, 198525.0, 199730.0, 199841.0, 199885.0, 199904.00047999813, 50921.490785092414, 51342.99999999925, 51403.0, 51439.22841157386, 51442.74278628583, 53844.73077634587, 53916.73041634845, 53999.73000135053, 54010.72994635002, 54177.729111354194, 16588.25352859124, 16926.74609880853, 16955.576110597332, 16964.236609352607, 16978.745318820227, 13780.173189608655, 13874.375653095432, 13875.791863122062, 13877.097988630707, 13907.026508144536, 14552.272386380639, 14632.634184145481, 14682.119072855663, 14705.705885882222, 14864.108153510824, 5909.494055626968, 5993.9810232260625, 5996.310424301174, 6103.816885493442, 6110.877782444326, 993.895640957689, 1010.3887148275335, 1016.8118898003893, 1017.1100287248657, 1018.0, 22168.445788855406, 22300.44248893758, 22314.442138946655, 22387.216447424264, 22701.09195632156, 1096.5832983466391, 1107.186218129674, 1116.6203490813164, 1116.9776604467866, 1120.0, 11885.5840045598, 11931.463084161234, 12003.159778815574, 12072.275663460221, 12231.082668799698, 199452.0, 202486.0, 214616.0, 214684.0, 214806.0, 43978.780106099905, 44992.0, 51524.742376287875, 51837.740811296455, 52542.21186682203, 1477.0915886729583, 1498.8725958293667, 1507.2765072765135, 1514.7576387777904, 1517.924103794806, 26397.472050559267, 26610.866945665148, 26674.733252667225, 26697.0, 26821.731782681924, 36825.81587092047, 37098.62901370952, 37138.0, 37139.81430092832, 37238.25523489569, 189956.0, 190561.0, 191442.0, 192077.0, 192500.0, 33601.0, 34362.82818585891, 34535.0, 34586.654133458345, 34686.0, 41840.790796045825, 42508.5749142517, 42641.57358426376, 42654.78672606617, 42991.57008429876, 31000.379992399576, 31013.534796978514, 31305.53041704331, 31404.685953140175, 31559.36881262316, 30970.0, 31200.37599247957, 31401.214969625944, 31646.208844779063, 31671.0, 34348.58459677395, 35480.0, 35650.0, 35864.64135358613, 35928.28143437169, 30683.2329191772, 30711.0, 31007.379852403275, 31062.0, 31533.526997094603, 22307.77692223122, 22335.664965025862, 22351.217707380165, 22434.102635894382, 22602.09591616317], "value": 17225.38290025806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.9970550147249, 598.4554055809209, 605.1225722702083, 606.1150719948874, 611.6666416802842, 21844.672329915065, 22809.771902280972, 22812.88593557032, 22825.201117960874, 22846.31461056167, 23768.524629507443, 24296.271111866627, 25613.103541376055, 25768.871155644196, 25809.87095064522, 6394.232692076946, 6596.60420374779, 6600.504962127836, 6601.603903765789, 6607.20713514379, 6366.172397588331, 6433.970564709647, 6532.673366331688, 6537.2482164550975, 6540.542162048659, 6590.406863382319, 6592.077109204692, 6619.172603424572, 6622.238442579092, 6625.403713665769, 6606.108175396308, 6614.801555953329, 6626.237982632011, 6628.966855165741, 6633.2703402625675, 5823.56323275756, 6070.180525629072, 6096.298925623566, 6096.72564734588, 6148.262208535004, 29590.70409295901, 29860.253493662614, 29881.551776723365, 29987.950421735353, 30096.84951575228, 2054.599353126141, 2058.2487392101925, 2062.7834077421803, 2071.8342532597358, 2076.1591555420077, 19665.705014424653, 20054.1978320867, 20174.689499153486, 20231.595368092556, 20387.286444974354, 2443.511297740441, 2458.5697502936914, 2474.0969546115716, 2518.9496210075695, 2525.7726804587674, 123336.0, 130432.0, 135634.0, 141869.0, 143225.0, 14780.992726400698, 14967.579879091132, 15108.848911510744, 15260.160691162093, 15530.534083977498, 23378.0, 23416.0, 23479.295621131394, 23481.647775283385, 23550.0, 10275.0, 10292.014094826214, 10337.37975721459, 10369.274150809522, 10487.685369438928, 9301.209397201179, 9374.437533747998, 9413.435193888388, 9470.573824177929, 9595.520223988773, 9063.864042039375, 9183.173514383603, 9232.8615070774, 9302.674406395743, 9447.574859131355, 2725.7955653325685, 2786.6238057862333, 2790.2610501927516, 2814.282357998697, 2839.33275680215, 950.4202436513721, 974.858645496399, 976.3360914578155, 981.5288661442405, 994.3785134291068, 19385.903070484557, 19483.61032779365, 19825.20699172017, 19909.402717918485, 20047.198112075355, 991.2466525440573, 1023.923205759571, 1038.5430410619454, 1041.942693151884, 1049.2445439283704, 10753.139748820076, 10804.891951080546, 10864.891351086388, 10910.836337454944, 11151.330920144817, 444053.5109031472, 448264.0, 477416.0, 480176.0, 506027.0, 113062.43468782604, 114232.0, 116194.41902790601, 116227.41886290515, 117221.41389293, 1014.457265363042, 1139.9658010259704, 1179.4810283475244, 1180.392098069495, 1186.3771519952095, 20479.4880127998, 20479.69280460824, 20727.0, 20736.377908662766, 21175.57648847045, 52839.471605283456, 52924.47075529196, 53043.46956530539, 53327.73336133295, 53770.731146345584, 66304.6684766573, 66446.00330995135, 66508.33491665022, 66606.66696666485, 66932.0, 14400.495982640976, 14516.34676439584, 14560.126392416489, 14580.0, 14750.0, 22429.878506074958, 22977.540449191256, 23042.078316867137, 23042.193523226608, 23488.0, 18244.635107298047, 18407.0, 18487.260509579468, 18635.0, 18703.34538291153, 16284.837151628331, 16521.83478165251, 16741.49775506737, 16778.66442671115, 17131.486055418358, 18126.365577204735, 18528.44414667562, 18908.905455472635, 18924.337648182798, 19211.32760353381, 14305.642358940693, 14394.280285985868, 14410.42358305698, 14480.34838432252, 14487.85512144865, 18174.273029079217, 18343.0, 18382.632347353247, 18423.078846057375, 18518.16668249905], "value": 12006.218412851193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.513267657305, 1383.605672383371, 1395.8325000999878, 1397.748405287048, 1403.7753959366503, 12660.873391266085, 13318.134321269123, 13331.533396331119, 13350.732985340288, 15708.84291157088, 15526.456574019912, 15804.367825286974, 15806.525804225863, 15809.92095039526, 15813.367465301402, 2708.756211940925, 2760.7377299156547, 2761.4477104579064, 2762.599423083652, 2764.156932135698, 2687.126683827754, 2692.8653567321653, 2768.958465623007, 2773.5285001549787, 2789.7628701560393, 2758.668959724836, 2765.308672831792, 2792.7346902044274, 2794.6227259320035, 2803.4673412051748, 2683.5840444731098, 2691.4213444109414, 2706.8105232633725, 2711.3628297350106, 2716.008656840259, 2678.638383818179, 2680.8659567021764, 2704.878280477383, 2706.472237913588, 2707.7021527631946, 15164.317605707769, 15556.766648500281, 15597.92201038999, 15610.0, 15616.0, 8000.479968802009, 8177.754667359989, 8436.746897593082, 8459.280961118313, 8466.83066338676, 5429.701366424845, 5539.362973258087, 5648.4633959773755, 5693.174489699012, 5797.420257974211, 1987.224982256921, 2013.1544751204528, 2051.0, 2062.75246970363, 2079.2514694709894, 26750.46499070008, 26888.73111268882, 26932.59601105985, 26999.595006074924, 27013.72986270132, 7478.177400485943, 7572.507786993828, 7770.0287464067, 7835.333996610238, 7837.804054898673, 17310.221040052977, 17343.0, 17386.130693465275, 17498.387556435464, 17505.7374139388, 7875.842483150305, 8043.11525732169, 8064.435489515678, 8107.270345668918, 8108.0, 7356.448266380043, 7457.440691948125, 7589.203133670995, 7726.9613651932505, 7745.186755390603, 4857.854264372075, 5253.106971814801, 5427.0773968425465, 5466.753996070186, 5470.91793623096, 1476.7415702252063, 1558.5636021913883, 1587.2777886061815, 1610.3880525400273, 1623.3993422433775, 807.7334479621711, 824.468217999387, 827.1645637905758, 834.6119054639622, 834.6911642692121, 8508.10664880191, 8568.143185681507, 8625.0, 8641.265492433087, 8650.221480066699, 952.6094301336419, 963.1716723617683, 969.6848524229654, 974.6198982396871, 975.3857366059184, 5370.301860758154, 5407.513323800798, 5517.806876759294, 5604.075327570905, 5611.831645050655, 21081.578368432547, 22142.446438839157, 22185.223517176822, 22529.88735056314, 22631.434214144778, 22306.21928232504, 22407.775922240897, 22410.775892241196, 22427.21504747326, 22519.437014074778, 10927.016568508872, 11839.408029598486, 11920.88079119215, 12079.577214797615, 12113.394330283627, 8379.371547133867, 8633.266172375419, 8675.869861952202, 8688.174623410765, 8740.737777866674, 18611.81388186101, 18984.335548255745, 18989.33537326187, 19094.61810763805, 19344.806551934864, 19725.70411443858, 19729.408117755916, 19740.703889441957, 20329.0, 20337.0, 11225.550977961117, 11250.774984500427, 11270.492827822603, 11449.255798373079, 11454.541818327174, 13891.930540347234, 14017.369218384993, 14086.366113524711, 14153.08004979673, 14172.078814877, 10061.0, 11636.476358564054, 11791.587294444653, 11901.10741694359, 12083.637490875288, 11517.712057198301, 11563.479643416234, 11682.24065435744, 11695.649130526097, 11937.820932685843, 9827.213822894008, 9853.753656158653, 9906.900930990887, 10043.0, 10076.798464030824, 6875.621840798804, 6993.160820701549, 7004.719811207495, 7041.788746337618, 7148.392386647193, 7302.794675481103, 7433.0, 7453.813654658677, 7498.962505187439, 7516.24837516244], "value": 6810.7140368831615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.7339646685492, 527.970961597112, 536.1207619504013, 542.3708498142156, 548.703700001999, 6269.811905642832, 6301.936980630204, 6348.238211414637, 6351.0, 6357.50598609327, 6258.624482531051, 6277.278113017004, 6294.370562943704, 6309.589876658026, 6336.42972132508, 5244.659097158673, 5257.684538927677, 5265.157574788034, 5271.736413179345, 5316.76074576645, 4916.475892473327, 5125.692458452486, 5148.536631703165, 5196.480351964792, 5282.339707536558, 5017.19724844025, 5022.146235140035, 5040.319556859832, 5063.417706963691, 5100.234964755279, 5061.063703214881, 5105.361829771278, 5119.12974794284, 5137.845864624067, 5144.151215049513, 4406.140802543506, 4528.298113792367, 4557.179707652621, 4566.474855391606, 4576.54234576543, 6177.1969643945995, 6186.56694031418, 6212.4408803207925, 6243.282022567418, 6270.8118756436925, 5722.256106706143, 5726.713664316809, 5776.797812076557, 5804.651720896717, 5820.476157145835, 6565.0, 6573.408393244583, 6591.373819487141, 6637.601743895381, 6653.367930046637, 4982.800687972477, 4986.900261994776, 4989.376327959005, 5003.749812509396, 5009.298698182258, 6637.2367177774695, 6729.93270067298, 6826.829329266808, 6861.55399899005, 6880.415164711006, 5043.394792624908, 5073.3911930568565, 5087.151195330553, 5100.668456550312, 5105.055564720538, 5141.2545180948555, 5148.716820574904, 5153.252778347119, 5170.482951704799, 5201.557867581298, 5794.62334948227, 5808.448197421239, 5821.476067153976, 5832.154337621021, 5838.4453476919625, 6537.5096867734155, 6539.411452969255, 6673.0, 6679.365460281266, 6681.265060843303, 1743.4396215387158, 1772.8758986871053, 1774.698301288784, 1777.4447358561258, 1782.393986044751, 1174.929504229749, 1223.1254652923203, 1250.2061191143507, 1263.210493441599, 1264.3804535777404, 5583.553315734732, 5637.915431268534, 5698.031334673033, 5709.229254050733, 5736.196932429463, 6597.60414375139, 6720.126383570105, 6762.966185169043, 6823.215330237086, 6825.795226143224, 5729.885402292014, 5747.827565173052, 5752.827415177551, 5786.537077033827, 5831.62094463867, 3548.8580456781438, 3577.713782897362, 3589.3718599245026, 3607.3687104756564, 3624.9456258156147, 6453.838654033687, 6462.386073323027, 6512.73949042033, 6562.67186640666, 6563.770268040691, 6867.931320686829, 6900.2409734929115, 6904.792856214322, 6914.585124892523, 6958.756443524452, 6487.6756162191705, 6516.283208847118, 6526.531530405716, 6553.934460655332, 6559.344065593403, 6717.261101278953, 6737.32626737342, 6774.2418943899265, 6778.220504641832, 6809.829754256183, 6614.70233839488, 6672.132622759011, 6723.7310507581105, 6726.0, 6734.326567343226, 6387.393197646216, 6424.0, 6435.22777266731, 6465.833945628267, 6500.772472963424, 5028.723420211923, 5062.291279220985, 5075.416327122428, 5085.4406015337545, 5106.110739026584, 6404.199475065617, 6735.562188457735, 6761.290064543152, 6761.661916904037, 6853.691583878638, 6334.144890439732, 6428.774992875227, 6497.155369801895, 6568.901466477911, 6660.733570657119, 6355.745770169141, 6396.680165991775, 6415.550911436155, 6435.680685459376, 6472.799248255616, 6185.195924529782, 6352.523560733056, 6384.9042264367, 6389.648569328731, 6428.582142160744, 6484.157059582224, 6525.836854078686, 6595.967020164869, 6610.0, 6651.567648102858, 6263.68681565929, 6267.2479302484, 6306.369363063841, 6396.264429590657, 6427.292997770148], "value": 5103.057278456164, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [922.7462447826847, 941.670415354626, 942.9104235097672, 946.3470205558165, 948.1135138645365, 19618.215271389145, 19810.80189198111, 20132.59734805305, 20151.193952241894, 20207.898960505194, 19137.61724765504, 19228.13473393697, 19237.807621923777, 19287.710684339712, 19300.227990880383, 973.7370909854335, 989.0949780950458, 992.8361820299642, 993.2252842782641, 993.46849435552, 966.7148191283553, 996.875390576178, 1006.134724137245, 1006.3760468509535, 1007.0584003956325, 1057.666834946993, 1057.762003549203, 1060.5545670818237, 1060.734816295926, 1060.8833028366873, 984.7882705218412, 1020.4336593190776, 1030.1449796668746, 1051.2483574244413, 1057.4606950455245, 750.8423231121471, 753.8077790163528, 757.1368639750689, 758.2606958215696, 760.1448370583093, 19896.303629373047, 19957.800421995886, 20048.79951200484, 20097.59804803896, 20126.798732012787, 21498.78501214999, 21597.67603485949, 22023.119075236973, 22192.334229973127, 22279.554408911732, 16973.745393819103, 17124.74312885308, 17192.398266060627, 17229.56926076858, 17568.38510652121, 3748.775073495599, 3763.717721170896, 3770.6794922431627, 3773.8490460381554, 3776.093737503007, 136580.31709841389, 138139.30930345383, 139041.0, 141654.29172854172, 141855.0, 16412.261448234858, 16781.91609041947, 16838.0, 16851.494455166365, 16855.578610534834, 29271.7072829269, 31646.0, 31704.682953170635, 31826.0, 31832.204194895312, 9232.815343693088, 9234.353595248269, 9291.814163716823, 9321.533923303808, 9342.06579342074, 4093.283675356801, 4097.078157414558, 4210.115875666083, 4214.325707886724, 4214.641755450821, 5019.573336266385, 5095.949040509621, 5108.106081435734, 5144.948550514522, 5156.20078887773, 966.5167416291854, 975.3952549419405, 991.4051569058652, 997.9051990060933, 1005.3364779245809, 668.9632070236183, 683.0846665468297, 695.3429009585993, 698.4028655499576, 703.7958991892397, 9823.950880245553, 10939.726506837393, 10977.670669879917, 10979.121670266359, 11828.88171118295, 640.5932233032058, 650.5056157320375, 665.118717699041, 680.6052489556046, 686.0463955102412, 5266.92099618506, 5313.654612450178, 5351.331083614548, 5351.946480535223, 5375.704336261543, 116197.4190129044, 116282.41858790652, 118200.0, 120721.39639301923, 121486.0, 85281.57359213164, 87712.0, 105402.0, 106182.46908765407, 106959.46520267348, 89702.0, 93907.0, 94122.52938735262, 94647.0, 97822.85503327477, 11324.660260192208, 11363.54545818158, 12110.515579376726, 12458.937705311415, 12469.064820138707, 39982.40026399664, 42789.35815962701, 42868.35697464603, 43825.0, 44595.55404445914, 54916.72541637266, 74210.25789742034, 74334.62832685802, 77195.61402192953, 78442.0, 17017.659646807242, 17110.315587376863, 17133.314667413164, 17148.657026859644, 17327.82672173262, 18291.72562411538, 19488.902555487133, 19493.61012779708, 19553.315633952745, 19625.90187049113, 14364.928175359057, 14831.258437078319, 15043.398264069314, 15124.54626361211, 15159.0, 17127.828721713122, 17209.655806884042, 17238.396656116976, 17239.138043097544, 17739.911300443415, 16729.33082676728, 16817.915910420368, 17232.827671723124, 17387.652246955244, 17494.650106998044, 12924.418401171783, 12954.676133096747, 12998.80501792455, 13084.411201496147, 13214.801777973531, 13150.21098734079, 13289.734205316034, 13353.53262635803, 13447.731045379232, 13549.864501355254], "value": 9094.282382910951, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1429.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 107.0, 109.0, 108.0, 108.0, 108.0, 107.0, 106.0, 106.0, 107.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 121.0, 117.0, 142.0, 118.0, 118.0, 119.0, 152.0, 116.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 162.0, 161.0, 163.0, 167.0, 166.0, 171.0, 165.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 74.0, 74.0, 73.0, 74.0, 74.0, 74.0, 73.0], "value": 74.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 78.0, 78.0, 78.0, 79.0, 79.0, 78.0, 79.0], "value": 78.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 121.0, 113.0, 115.0, 113.0, 114.0, 114.0, 110.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 151.0, 150.0, 150.0, 151.0, 152.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 54.0, 55.0, 65.0, 55.0, 55.0, 61.0, 54.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 38.0, 37.0, 38.0, 38.0, 39.0, 38.0, 38.0], "value": 37.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 77.0, 74.0, 75.0, 74.0, 73.0, 75.0, 78.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 111.0, 109.0, 122.0, 121.0, 115.0, 117.0, 114.0, 111.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 169.0, 167.0, 169.0, 173.0, 169.0, 171.0, 172.0, 168.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 66.0, 68.0, 65.0, 65.0, 64.0, 66.0, 66.0], "value": 66.2, "unit": "score"}]}]} 11:46:55 INFO - Return code: 0 11:46:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:46:55 INFO - # TBPL SUCCESS # 11:46:55 INFO - Running post-action listener: _package_coverage_data 11:46:55 INFO - Running post-action listener: _resource_record_post_action 11:46:55 INFO - [mozharness: 2017-09-23 18:46:55.390094Z] Finished run-tests step (success) 11:46:55 INFO - Running post-run listener: _resource_record_post_run 11:46:55 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 9539584; Write bytes: 463536128; Read time: 3908; Write time: 651280 11:46:55 INFO - TinderboxPrint: CPU usage
13.2% 11:46:55 INFO - TinderboxPrint: I/O read bytes / time
9,539,584 / 3,908 11:46:55 INFO - TinderboxPrint: I/O write bytes / time
463,536,128 / 651,280 11:46:55 INFO - TinderboxPrint: CPU idle
8,271.7 (86.8%) 11:46:55 INFO - TinderboxPrint: CPU user
1,194.2 (12.5%) 11:46:55 INFO - TinderboxPrint: Swap in / out
0 / 0 11:46:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 12804096; Read time: 0; Write time: 3160 11:46:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:46:55 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 7389184; Write bytes: 406528000; Read time: 3356; Write time: 617044 11:46:56 INFO - Running post-run listener: _upload_blobber_files 11:46:56 INFO - Blob upload gear active. 11:46:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:46:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:46:56 INFO - (blobuploader) - INFO - Open directory for files ... 11:46:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:46:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:46:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:57 INFO - (blobuploader) - INFO - Done attempting. 11:46:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 11:46:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:46:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 11:46:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:46:58 INFO - (blobuploader) - INFO - Done attempting. 11:46:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:46:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:46:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:47:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:05 INFO - (blobuploader) - INFO - Done attempting. 11:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 11:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 11:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:06 INFO - (blobuploader) - INFO - Done attempting. 11:47:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:06 INFO - Return code: 0 11:47:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a632f4ff7264b5a1f469bac97a580179fc3e06b655c1ae2aa4f5ac0e0a0a7dd09e3fd974354b3f678877a762381e49d750e63483302b6481fcacc235e19daf4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52a07a70f2cff981205d37e1d187f07717c719cd97388238e8b6af1491c5bcdb33b8999284e305d5f3019af73b25a27651fefa2b0289ad8503c7a7cd3b36a6bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8616fc76bc3c435302c07fc78761c682a70a51e03bf1329d2155e214009443ba5cb4974c7a9324153946abf1207fb1af05c2256bac438b34e34366588db17b3e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a9fa8c92257b1bc04bb1a185081ee879e90c2624492463117c39c9633f091d5dd2a82226311a2d5656852e71959e89e24d55a82687176ea91db748ba8b47d67"} 11:47:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:06 INFO - Contents: 11:47:06 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a632f4ff7264b5a1f469bac97a580179fc3e06b655c1ae2aa4f5ac0e0a0a7dd09e3fd974354b3f678877a762381e49d750e63483302b6481fcacc235e19daf4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52a07a70f2cff981205d37e1d187f07717c719cd97388238e8b6af1491c5bcdb33b8999284e305d5f3019af73b25a27651fefa2b0289ad8503c7a7cd3b36a6bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8616fc76bc3c435302c07fc78761c682a70a51e03bf1329d2155e214009443ba5cb4974c7a9324153946abf1207fb1af05c2256bac438b34e34366588db17b3e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a9fa8c92257b1bc04bb1a185081ee879e90c2624492463117c39c9633f091d5dd2a82226311a2d5656852e71959e89e24d55a82687176ea91db748ba8b47d67"} 11:47:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:06 INFO - Copying logs to upload dir... 11:47:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.234203 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-09-23 11:47:06.061178) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 11:47:06.064316) ========= 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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 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/7a632f4ff7264b5a1f469bac97a580179fc3e06b655c1ae2aa4f5ac0e0a0a7dd09e3fd974354b3f678877a762381e49d750e63483302b6481fcacc235e19daf4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52a07a70f2cff981205d37e1d187f07717c719cd97388238e8b6af1491c5bcdb33b8999284e305d5f3019af73b25a27651fefa2b0289ad8503c7a7cd3b36a6bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8616fc76bc3c435302c07fc78761c682a70a51e03bf1329d2155e214009443ba5cb4974c7a9324153946abf1207fb1af05c2256bac438b34e34366588db17b3e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a9fa8c92257b1bc04bb1a185081ee879e90c2624492463117c39c9633f091d5dd2a82226311a2d5656852e71959e89e24d55a82687176ea91db748ba8b47d67"} build_url:https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/DNUXLEF0TY6Rkrc0rZZnLg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a632f4ff7264b5a1f469bac97a580179fc3e06b655c1ae2aa4f5ac0e0a0a7dd09e3fd974354b3f678877a762381e49d750e63483302b6481fcacc235e19daf4", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/52a07a70f2cff981205d37e1d187f07717c719cd97388238e8b6af1491c5bcdb33b8999284e305d5f3019af73b25a27651fefa2b0289ad8503c7a7cd3b36a6bd", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8616fc76bc3c435302c07fc78761c682a70a51e03bf1329d2155e214009443ba5cb4974c7a9324153946abf1207fb1af05c2256bac438b34e34366588db17b3e", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a9fa8c92257b1bc04bb1a185081ee879e90c2624492463117c39c9633f091d5dd2a82226311a2d5656852e71959e89e24d55a82687176ea91db748ba8b47d67"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-23 11:47:06.094753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:47:06.095124) ========= 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=5c37b704b588aaa989324530000001d0-1506182371.455637-1740220717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-23 11:47:06.146922) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 11:47:06.147244) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-23 11:47:06.147569) ========= ========= Total master_lag: 0.13 =========