builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1508857088.29 results: success (0) revision: f2d5cf8571925b8cea9bf10f427915ec25e19bc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.292603) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.293318) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.293582) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.328485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.328805) ========= 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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-24 07:58:08-- 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% 105M=0s 2017-10-24 07:58:08 (105 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118213 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.559165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.559554) ========= 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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023632 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:08.609561) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-24 07:58:08.609871) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f2d5cf8571925b8cea9bf10f427915ec25e19bc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev f2d5cf8571925b8cea9bf10f427915ec25e19bc5 --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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-24 07:58:08,652 truncating revision to first 12 chars 2017-10-24 07:58:08,652 Setting DEBUG logging. 2017-10-24 07:58:08,652 attempt 1/10 2017-10-24 07:58:08,652 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/f2d5cf857192?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-24 07:58:09,509 unpacking tar archive at: mozilla-beta-f2d5cf857192/testing/mozharness/ program finished with exit code 0 elapsedTime=1.145229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-24 07:58:09.775232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:09.775547) ========= script_repo_revision: f2d5cf8571925b8cea9bf10f427915ec25e19bc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:09.775918) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:09.776190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-24 07:58:09.791195) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-24 07:58:09.791623) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:58:09 INFO - MultiFileLogger online at 20171024 07:58:09 in /builds/slave/test 07:58:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 07:58:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:09 INFO - {'append_to_log': False, 07:58:09 INFO - 'base_work_dir': '/builds/slave/test', 07:58:09 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:58:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:09 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:58:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:09 INFO - 'code_coverage': False, 07:58:09 INFO - 'config_files': ('talos/linux_config.py',), 07:58:09 INFO - 'default_actions': ('clobber', 07:58:09 INFO - 'read-buildbot-config', 07:58:09 INFO - 'download-and-extract', 07:58:09 INFO - 'populate-webroot', 07:58:09 INFO - 'create-virtualenv', 07:58:09 INFO - 'install', 07:58:09 INFO - 'setup-mitmproxy', 07:58:09 INFO - 'run-tests'), 07:58:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:09 INFO - 'disable_ccov_upload': False, 07:58:09 INFO - 'disable_stylo': False, 07:58:09 INFO - 'download_minidump_stackwalk': True, 07:58:09 INFO - 'download_symbols': 'ondemand', 07:58:09 INFO - 'enable_stylo': False, 07:58:09 INFO - 'enable_webrender': False, 07:58:09 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:58:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:09 INFO - 'gecko_profile': False, 07:58:09 INFO - 'gecko_profile_interval': 0, 07:58:09 INFO - 'installer_path': 'installer.exe', 07:58:09 INFO - 'log_level': 'info', 07:58:09 INFO - 'log_name': 'talos', 07:58:09 INFO - 'log_to_console': True, 07:58:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:58:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:58:09 INFO - 'opt_config_files': (), 07:58:09 INFO - 'pip_index': False, 07:58:09 INFO - 'suite': 'dromaeojs-e10s', 07:58:09 INFO - 'system_bits': '32', 07:58:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:09 INFO - 'title': 'talos-linux64-ix-035', 07:58:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:09 INFO - 'use_talos_json': True, 07:58:09 INFO - 'verify': 'False', 07:58:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:09 INFO - 'work_dir': 'build'} 07:58:09 INFO - [mozharness: 2017-10-24 14:58:09.976165Z] Running clobber step. 07:58:09 INFO - Running pre-action listener: _resource_record_pre_action 07:58:09 INFO - Running main action method: clobber 07:58:09 INFO - rmtree: /builds/slave/test/build 07:58:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:11 INFO - Running post-action listener: _resource_record_post_action 07:58:11 INFO - [mozharness: 2017-10-24 14:58:11.072436Z] Finished clobber step (success) 07:58:11 INFO - [mozharness: 2017-10-24 14:58:11.072533Z] Running read-buildbot-config step. 07:58:11 INFO - Running pre-action listener: _resource_record_pre_action 07:58:11 INFO - Running main action method: read_buildbot_config 07:58:11 INFO - Using buildbot properties: 07:58:11 INFO - { 07:58:11 INFO - "project": "", 07:58:11 INFO - "product": "firefox", 07:58:11 INFO - "who": "ryanvm@gmail.com", 07:58:11 INFO - "installer_path": "public/build/target.tar.bz2", 07:58:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:58:11 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:58:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:58:11 INFO - "stage_platform": "linux64", 07:58:11 INFO - "basedir": "/builds/slave/test", 07:58:11 INFO - "buildnumber": 148, 07:58:11 INFO - "platform": "ubuntu64_hw", 07:58:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:58:11 INFO - "slavebuilddir": "test", 07:58:11 INFO - "taskId": "R7ZKTq16TpqwSZ07QGGbNA", 07:58:11 INFO - "branch": "mozilla-beta", 07:58:11 INFO - "script_repo_revision": "production", 07:58:11 INFO - "revision": "f2d5cf8571925b8cea9bf10f427915ec25e19bc5", 07:58:11 INFO - "slavename": "talos-linux64-ix-035", 07:58:11 INFO - "repo_path": "releases/mozilla-beta" 07:58:11 INFO - } 07:58:11 INFO - Finding installer, test and symbols from parent task. 07:58:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7ZKTq16TpqwSZ07QGGbNA'}, attempt #1 07:58:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R7ZKTq16TpqwSZ07QGGbNA'}, attempt #1 07:58:11 INFO - Task dependencies: V6YglzPlQzGg6x2Q8QynfQ 07:58:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ'}, attempt #1 07:58:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 07:58:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.test_packages.json 07:58:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.crashreporter-symbols.zip 07:58:12 INFO - Running post-action listener: _resource_record_post_action 07:58:12 INFO - [mozharness: 2017-10-24 14:58:12.429658Z] Finished read-buildbot-config step (success) 07:58:12 INFO - [mozharness: 2017-10-24 14:58:12.429873Z] Running download-and-extract step. 07:58:12 INFO - Running pre-action listener: _resource_record_pre_action 07:58:12 INFO - Running main action method: download_and_extract 07:58:12 INFO - mkdir: /builds/slave/test/build/tests 07:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:12 INFO - trying https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.test_packages.json 07:58:12 INFO - Downloading https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:58:12 INFO - Downloaded 989 bytes. 07:58:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:58:12 INFO - Using the following test package requirements: 07:58:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:58:12 INFO - u'common': [u'target.common.tests.zip'], 07:58:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:58:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:58:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:58:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:58:12 INFO - u'mozbase': [u'target.common.tests.zip'], 07:58:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:58:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:58:12 INFO - u'web-platform': [u'target.common.tests.zip', 07:58:12 INFO - u'target.web-platform.tests.tar.gz'], 07:58:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:58:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.common.tests.zip 07:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.common.tests.zip into memory 07:58:14 INFO - Content-Length response header: 55173706 07:58:14 INFO - Bytes received: 55173706 07:58:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.talos.tests.zip 07:58:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:58:25 INFO - Fetch https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.talos.tests.zip into memory 07:58:27 INFO - Content-Length response header: 14509096 07:58:27 INFO - Bytes received: 14509096 07:58:27 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')]} 07:58:27 INFO - trying https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 07:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:58:29 INFO - Downloaded 53685113 bytes. 07:58:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 07:58:29 INFO - mkdir: /builds/slave/test/properties 07:58:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:29 INFO - Contents: 07:58:29 INFO - build_url:https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 07:58:29 INFO - Running post-action listener: _resource_record_post_action 07:58:29 INFO - Running post-action listener: find_tests_for_verification 07:58:29 INFO - Running post-action listener: set_extra_try_arguments 07:58:29 INFO - [mozharness: 2017-10-24 14:58:29.638133Z] Finished download-and-extract step (success) 07:58:29 INFO - [mozharness: 2017-10-24 14:58:29.638229Z] Running populate-webroot step. 07:58:29 INFO - Running pre-action listener: _resource_record_pre_action 07:58:29 INFO - Running main action method: populate_webroot 07:58:29 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:29 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['tresize', 07:58:29 INFO - 'tcanvasmark']}, 07:58:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:29 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['dromaeo_css', 07:58:29 INFO - 'kraken']}, 07:58:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:29 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'tests': ['damp', 'tps']}, 07:58:29 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['damp', 'tps']}, 07:58:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:29 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['dromaeo_dom']}, 07:58:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:58:29 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['basic_compositor_video', 07:58:29 INFO - 'glvideo']}, 07:58:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:58:29 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['ts_paint_webext', 07:58:29 INFO - 'tp5o_webext']}, 07:58:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:29 INFO - 'ts_paint', 07:58:29 INFO - 'tpaint', 07:58:29 INFO - 'sessionrestore', 07:58:29 INFO - 'sessionrestore_many_windows', 07:58:29 INFO - 'sessionrestore_no_auto_restore', 07:58:29 INFO - 'tabpaint']}, 07:58:29 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['a11yr', 07:58:29 INFO - 'ts_paint', 07:58:29 INFO - 'tpaint', 07:58:29 INFO - 'sessionrestore', 07:58:29 INFO - 'sessionrestore_many_windows', 07:58:29 INFO - 'sessionrestore_no_auto_restore', 07:58:29 INFO - 'tabpaint']}, 07:58:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:58:29 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:58:29 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['perf_reftest_singletons']}, 07:58:29 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['bloom_basic']}, 07:58:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:29 INFO - 'tsvgr_opacity', 07:58:29 INFO - 'tart', 07:58:29 INFO - 'tscrollx', 07:58:29 INFO - 'tsvg_static']}, 07:58:29 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['tsvgx', 07:58:29 INFO - 'tsvgr_opacity', 07:58:29 INFO - 'tart', 07:58:29 INFO - 'tscrollx', 07:58:29 INFO - 'tsvg_static']}, 07:58:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:58:29 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo'], 07:58:29 INFO - 'tests': ['tp5o']}, 07:58:29 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:29 INFO - 'talos_options': ['--mitmproxy', 07:58:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:29 INFO - '--firstNonBlankPaint'], 07:58:29 INFO - 'tests': ['tp6_google', 07:58:29 INFO - 'tp6_youtube', 07:58:29 INFO - 'tp6_amazon', 07:58:29 INFO - 'tp6_facebook']}, 07:58:29 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo', 07:58:29 INFO - '--mitmproxy', 07:58:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:29 INFO - '--firstNonBlankPaint'], 07:58:29 INFO - 'tests': ['tp6_google', 07:58:29 INFO - 'tp6_youtube', 07:58:29 INFO - 'tp6_amazon', 07:58:29 INFO - 'tp6_facebook']}, 07:58:29 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:58:29 INFO - 'talos_options': ['--stylo-threads=1', 07:58:29 INFO - '--mitmproxy', 07:58:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:58:29 INFO - '--firstNonBlankPaint'], 07:58:29 INFO - 'tests': ['tp6_google', 07:58:29 INFO - 'tp6_youtube', 07:58:29 INFO - 'tp6_amazon', 07:58:29 INFO - 'tp6_facebook']}, 07:58:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--xperf_path', 07:58:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:29 INFO - 'tests': ['tp5n']}, 07:58:29 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:58:29 INFO - 'talos_options': ['--disable-stylo', 07:58:29 INFO - '--xperf_path', 07:58:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:29 INFO - 'tests': ['tp5n']}}} 07:58:29 INFO - Running post-action listener: _resource_record_post_action 07:58:29 INFO - [mozharness: 2017-10-24 14:58:29.653218Z] Finished populate-webroot step (success) 07:58:29 INFO - [mozharness: 2017-10-24 14:58:29.653307Z] Running create-virtualenv step. 07:58:29 INFO - Running pre-action listener: _resource_record_pre_action 07:58:29 INFO - Running main action method: create_virtualenv 07:58:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:29 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:58:29 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:58:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:58:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:30 INFO - Installing pip...............done. 07:58:30 INFO - Return code: 0 07:58:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:58:30 INFO - Reading from file tmpfile_stdout 07:58:30 INFO - Output received: 07:58:30 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:58:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:30 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:30 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 07:58:30 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 07:58:30 INFO - Using env: {'DISPLAY': ':0', 07:58:30 INFO - 'HOME': '/home/cltbld', 07:58:30 INFO - 'LANG': 'en_US.UTF-8', 07:58:30 INFO - 'LANGUAGE': 'en_US:en', 07:58:30 INFO - 'LOGNAME': 'cltbld', 07:58:30 INFO - 'MAIL': '/var/mail/cltbld', 07:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:30 INFO - 'MOZ_NO_REMOTE': '1', 07:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:30 INFO - 'NO_EM_RESTART': '1', 07:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:30 INFO - 'PWD': '/builds/slave/test', 07:58:30 INFO - 'SHELL': '/bin/bash', 07:58:30 INFO - 'SHLVL': '1', 07:58:30 INFO - 'TERM': 'linux', 07:58:30 INFO - 'TMOUT': '86400', 07:58:30 INFO - 'USER': 'cltbld', 07:58:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:30 INFO - '_': '/tools/buildbot/bin/python'} 07:58:31 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:58:31 INFO - Downloading/unpacking pip>=1.5 07:58:31 INFO - Running setup.py egg_info for package pip 07:58:31 INFO - warning: no files found matching 'pip/cacert.pem' 07:58:31 INFO - warning: no files found matching '*.html' under directory 'docs' 07:58:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:58:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:58:31 INFO - Installing collected packages: pip 07:58:31 INFO - Found existing installation: pip 1.1 07:58:31 INFO - Uninstalling pip: 07:58:31 INFO - Successfully uninstalled pip 07:58:31 INFO - Running setup.py install for pip 07:58:31 INFO - warning: no files found matching 'pip/cacert.pem' 07:58:31 INFO - warning: no files found matching '*.html' under directory 'docs' 07:58:31 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:58:31 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:58:31 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Successfully installed pip 07:58:31 INFO - Cleaning up... 07:58:31 INFO - Return code: 0 07:58:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:31 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')]} 07:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:31 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')]} 07:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:31 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:31 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 07:58:31 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 07:58:31 INFO - Using env: {'DISPLAY': ':0', 07:58:31 INFO - 'HOME': '/home/cltbld', 07:58:31 INFO - 'LANG': 'en_US.UTF-8', 07:58:31 INFO - 'LANGUAGE': 'en_US:en', 07:58:31 INFO - 'LOGNAME': 'cltbld', 07:58:31 INFO - 'MAIL': '/var/mail/cltbld', 07:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:31 INFO - 'MOZ_NO_REMOTE': '1', 07:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:31 INFO - 'NO_EM_RESTART': '1', 07:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:31 INFO - 'PWD': '/builds/slave/test', 07:58:31 INFO - 'SHELL': '/bin/bash', 07:58:31 INFO - 'SHLVL': '1', 07:58:31 INFO - 'TERM': 'linux', 07:58:31 INFO - 'TMOUT': '86400', 07:58:31 INFO - 'USER': 'cltbld', 07:58:31 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:31 INFO - '_': '/tools/buildbot/bin/python'} 07:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:32 INFO - Downloading/unpacking psutil>=3.1.1 07:58:32 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 07:58:32 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 07:58:32 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 07:58:32 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 07:58:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:33 INFO - Installing collected packages: psutil 07:58:33 INFO - Running setup.py install for psutil 07:58:33 INFO - building 'psutil._psutil_linux' extension 07:58:33 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 07:58:34 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 07:58:34 INFO - building 'psutil._psutil_posix' extension 07:58:34 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 07:58:34 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 07:58:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:34 INFO - Successfully installed psutil 07:58:34 INFO - Cleaning up... 07:58:34 INFO - Return code: 0 07:58:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:58:34 INFO - Using env: {'DISPLAY': ':0', 07:58:34 INFO - 'HOME': '/home/cltbld', 07:58:34 INFO - 'LANG': 'en_US.UTF-8', 07:58:34 INFO - 'LANGUAGE': 'en_US:en', 07:58:34 INFO - 'LOGNAME': 'cltbld', 07:58:34 INFO - 'MAIL': '/var/mail/cltbld', 07:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:34 INFO - 'MOZ_NO_REMOTE': '1', 07:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:34 INFO - 'NO_EM_RESTART': '1', 07:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:34 INFO - 'PWD': '/builds/slave/test', 07:58:34 INFO - 'SHELL': '/bin/bash', 07:58:34 INFO - 'SHLVL': '1', 07:58:34 INFO - 'TERM': 'linux', 07:58:34 INFO - 'TMOUT': '86400', 07:58:34 INFO - 'USER': 'cltbld', 07:58:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:34 INFO - '_': '/tools/buildbot/bin/python'} 07:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58:35 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 07:58:35 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 07:58:35 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 07:58:35 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 07:58:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:36 INFO - Installing collected packages: mozsystemmonitor 07:58:36 INFO - Running setup.py install for mozsystemmonitor 07:58:36 INFO - Successfully installed mozsystemmonitor 07:58:36 INFO - Cleaning up... 07:58:36 INFO - Return code: 0 07:58:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:37 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:37 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 07:58:37 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 07:58:37 INFO - Using env: {'DISPLAY': ':0', 07:58:37 INFO - 'HOME': '/home/cltbld', 07:58:37 INFO - 'LANG': 'en_US.UTF-8', 07:58:37 INFO - 'LANGUAGE': 'en_US:en', 07:58:37 INFO - 'LOGNAME': 'cltbld', 07:58:37 INFO - 'MAIL': '/var/mail/cltbld', 07:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:37 INFO - 'MOZ_NO_REMOTE': '1', 07:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:37 INFO - 'NO_EM_RESTART': '1', 07:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:37 INFO - 'PWD': '/builds/slave/test', 07:58:37 INFO - 'SHELL': '/bin/bash', 07:58:37 INFO - 'SHLVL': '1', 07:58:37 INFO - 'TERM': 'linux', 07:58:37 INFO - 'TMOUT': '86400', 07:58:37 INFO - 'USER': 'cltbld', 07:58:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:37 INFO - '_': '/tools/buildbot/bin/python'} 07:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:58:37 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 07:58:37 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 07:58:37 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 07:58:37 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 07:58:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:38 INFO - warning: no files found matching '*.txt' 07:58:38 INFO - no previously-included directories found matching 'build' 07:58:38 INFO - no previously-included directories found matching 'dist' 07:58:38 INFO - no previously-included directories found matching '.git*' 07:58:38 INFO - Installing collected packages: jsonschema, functools32 07:58:38 INFO - Running setup.py install for functools32 07:58:38 INFO - warning: no files found matching '*.txt' 07:58:38 INFO - no previously-included directories found matching 'build' 07:58:38 INFO - no previously-included directories found matching 'dist' 07:58:38 INFO - no previously-included directories found matching '.git*' 07:58:38 INFO - Successfully installed jsonschema functools32 07:58:38 INFO - Cleaning up... 07:58:38 INFO - Return code: 0 07:58:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:58:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:58:38 INFO - Using env: {'DISPLAY': ':0', 07:58:38 INFO - 'HOME': '/home/cltbld', 07:58:38 INFO - 'LANG': 'en_US.UTF-8', 07:58:38 INFO - 'LANGUAGE': 'en_US:en', 07:58:38 INFO - 'LOGNAME': 'cltbld', 07:58:38 INFO - 'MAIL': '/var/mail/cltbld', 07:58:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:38 INFO - 'MOZ_NO_REMOTE': '1', 07:58:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:38 INFO - 'NO_EM_RESTART': '1', 07:58:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:38 INFO - 'PWD': '/builds/slave/test', 07:58:38 INFO - 'SHELL': '/bin/bash', 07:58:38 INFO - 'SHLVL': '1', 07:58:38 INFO - 'TERM': 'linux', 07:58:38 INFO - 'TMOUT': '86400', 07:58:38 INFO - 'USER': 'cltbld', 07:58:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:38 INFO - '_': '/tools/buildbot/bin/python'} 07:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:58:39 INFO - Cleaning up... 07:58:39 INFO - Return code: 0 07:58:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:39 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:39 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 07:58:39 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 07:58:39 INFO - Using env: {'DISPLAY': ':0', 07:58:39 INFO - 'HOME': '/home/cltbld', 07:58:39 INFO - 'LANG': 'en_US.UTF-8', 07:58:39 INFO - 'LANGUAGE': 'en_US:en', 07:58:39 INFO - 'LOGNAME': 'cltbld', 07:58:39 INFO - 'MAIL': '/var/mail/cltbld', 07:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:39 INFO - 'MOZ_NO_REMOTE': '1', 07:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:39 INFO - 'NO_EM_RESTART': '1', 07:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:39 INFO - 'PWD': '/builds/slave/test', 07:58:39 INFO - 'SHELL': '/bin/bash', 07:58:39 INFO - 'SHLVL': '1', 07:58:39 INFO - 'TERM': 'linux', 07:58:39 INFO - 'TMOUT': '86400', 07:58:39 INFO - 'USER': 'cltbld', 07:58:39 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:39 INFO - '_': '/tools/buildbot/bin/python'} 07:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:58:39 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 07:58:39 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 07:58:39 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 07:58:39 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 07:58:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:40 INFO - Downloading docopt-0.6.1.tar.gz 07:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:40 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:40 INFO - Running setup.py install for blobuploader 07:58:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:41 INFO - Running setup.py install for requests 07:58:41 INFO - Running setup.py install for docopt 07:58:41 INFO - Successfully installed blobuploader requests docopt 07:58:41 INFO - Cleaning up... 07:58:41 INFO - Return code: 0 07:58:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:41 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')]} 07:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:41 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')]} 07:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:41 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:41 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 07:58:41 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 07:58:41 INFO - Using env: {'DISPLAY': ':0', 07:58:41 INFO - 'HOME': '/home/cltbld', 07:58:41 INFO - 'LANG': 'en_US.UTF-8', 07:58:41 INFO - 'LANGUAGE': 'en_US:en', 07:58:41 INFO - 'LOGNAME': 'cltbld', 07:58:41 INFO - 'MAIL': '/var/mail/cltbld', 07:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:41 INFO - 'MOZ_NO_REMOTE': '1', 07:58:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:41 INFO - 'NO_EM_RESTART': '1', 07:58:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:41 INFO - 'PWD': '/builds/slave/test', 07:58:41 INFO - 'SHELL': '/bin/bash', 07:58:41 INFO - 'SHLVL': '1', 07:58:41 INFO - 'TERM': 'linux', 07:58:41 INFO - 'TMOUT': '86400', 07:58:41 INFO - 'USER': 'cltbld', 07:58:41 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:41 INFO - '_': '/tools/buildbot/bin/python'} 07:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:41 INFO - Running setup.py (path:/tmp/pip-K8afAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:41 INFO - Running setup.py (path:/tmp/pip-Yw2pIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:41 INFO - Running setup.py (path:/tmp/pip-QHdlSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:41 INFO - Running setup.py (path:/tmp/pip-ALjn39-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:42 INFO - Running setup.py (path:/tmp/pip-ZJEeL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:42 INFO - Running setup.py (path:/tmp/pip-9mMYoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:42 INFO - Running setup.py (path:/tmp/pip-RzTC7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:42 INFO - Running setup.py (path:/tmp/pip-MRKz9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:42 INFO - Running setup.py (path:/tmp/pip-J6hn6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:42 INFO - Running setup.py (path:/tmp/pip-fxaZRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:42 INFO - Running setup.py (path:/tmp/pip-YBvw6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:42 INFO - Running setup.py (path:/tmp/pip-xPsO0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:42 INFO - Running setup.py (path:/tmp/pip-MXw1w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:42 INFO - Running setup.py (path:/tmp/pip-sNXrnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:42 INFO - Running setup.py (path:/tmp/pip-61xEqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:42 INFO - Running setup.py (path:/tmp/pip-707_F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:42 INFO - Running setup.py (path:/tmp/pip-4Z6ei6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:58:42 INFO - Running setup.py install for manifestparser 07:58:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for mozcrash 07:58:43 INFO - Running setup.py install for mozdebug 07:58:43 INFO - Running setup.py install for mozdevice 07:58:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for mozfile 07:58:43 INFO - Running setup.py install for mozhttpd 07:58:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for mozinfo 07:58:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for mozInstall 07:58:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for mozleak 07:58:43 INFO - Running setup.py install for mozlog 07:58:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:58:43 INFO - Running setup.py install for moznetwork 07:58:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Running setup.py install for mozprocess 07:58:44 INFO - Running setup.py install for mozprofile 07:58:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Running setup.py install for mozrunner 07:58:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Running setup.py install for mozscreenshot 07:58:44 INFO - Running setup.py install for moztest 07:58:44 INFO - Running setup.py install for mozversion 07:58:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:58:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:58:44 INFO - Cleaning up... 07:58:44 INFO - Return code: 0 07:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:44 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:44 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 07:58:44 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 07:58:44 INFO - Using env: {'DISPLAY': ':0', 07:58:44 INFO - 'HOME': '/home/cltbld', 07:58:44 INFO - 'LANG': 'en_US.UTF-8', 07:58:44 INFO - 'LANGUAGE': 'en_US:en', 07:58:44 INFO - 'LOGNAME': 'cltbld', 07:58:44 INFO - 'MAIL': '/var/mail/cltbld', 07:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:44 INFO - 'MOZ_NO_REMOTE': '1', 07:58:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:44 INFO - 'NO_EM_RESTART': '1', 07:58:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:44 INFO - 'PWD': '/builds/slave/test', 07:58:44 INFO - 'SHELL': '/bin/bash', 07:58:44 INFO - 'SHLVL': '1', 07:58:44 INFO - 'TERM': 'linux', 07:58:44 INFO - 'TMOUT': '86400', 07:58:44 INFO - 'USER': 'cltbld', 07:58:44 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:44 INFO - '_': '/tools/buildbot/bin/python'} 07:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:44 INFO - Running setup.py (path:/tmp/pip-wdsQh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:45 INFO - Running setup.py (path:/tmp/pip-3vyNf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:45 INFO - Running setup.py (path:/tmp/pip-oJqJv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:45 INFO - Running setup.py (path:/tmp/pip-YEPdvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:45 INFO - Running setup.py (path:/tmp/pip-wizKSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:45 INFO - Running setup.py (path:/tmp/pip-ThbClR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:45 INFO - Running setup.py (path:/tmp/pip-FuviLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:45 INFO - Running setup.py (path:/tmp/pip-Erbs43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:45 INFO - Running setup.py (path:/tmp/pip-05mRij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:45 INFO - Running setup.py (path:/tmp/pip-LfxtHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:45 INFO - Running setup.py (path:/tmp/pip-jMWhIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:45 INFO - Running setup.py (path:/tmp/pip-pT1KWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:45 INFO - Running setup.py (path:/tmp/pip-41GQDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:45 INFO - Running setup.py (path:/tmp/pip-e2IX9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:45 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)) 07:58:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:45 INFO - Running setup.py (path:/tmp/pip-I9lpHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:46 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)) 07:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:46 INFO - Running setup.py (path:/tmp/pip-7wlUXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:46 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)) 07:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:46 INFO - Running setup.py (path:/tmp/pip-w_m8Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:46 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)) 07:58:46 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)) 07:58:46 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)) 07:58:46 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)) 07:58:46 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)) 07:58:46 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)) 07:58:46 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)) 07:58:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58: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 07:58: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 07:58: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 07:58: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 07:58:47 INFO - Downloading blessings-1.6.tar.gz 07:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:58:47 INFO - Installing collected packages: blessings 07:58:47 INFO - Running setup.py install for blessings 07:58:47 INFO - Successfully installed blessings 07:58:47 INFO - Cleaning up... 07:58:47 INFO - Return code: 0 07:58:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:58:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:47 INFO - Reading from file tmpfile_stdout 07:58:47 INFO - Current package versions: 07:58:47 INFO - argparse == 1.2.1 07:58:47 INFO - blessings == 1.6 07:58:47 INFO - blobuploader == 1.2.4 07:58:47 INFO - docopt == 0.6.1 07:58:47 INFO - functools32 == 3.2.3-2 07:58:47 INFO - jsonschema == 2.5.1 07:58:47 INFO - manifestparser == 1.1 07:58:47 INFO - mozInstall == 1.13 07:58:47 INFO - mozcrash == 1.0 07:58:47 INFO - mozdebug == 0.1 07:58:47 INFO - mozdevice == 0.51 07:58:47 INFO - mozfile == 1.2 07:58:47 INFO - mozhttpd == 0.7 07:58:47 INFO - mozinfo == 0.10 07:58:47 INFO - mozleak == 0.1 07:58:47 INFO - mozlog == 3.5 07:58:47 INFO - moznetwork == 0.27 07:58:47 INFO - mozprocess == 0.25 07:58:47 INFO - mozprofile == 0.28 07:58:47 INFO - mozrunner == 6.13 07:58:47 INFO - mozscreenshot == 0.1 07:58:47 INFO - mozsystemmonitor == 0.3 07:58:47 INFO - moztest == 0.8 07:58:47 INFO - mozversion == 1.4 07:58:47 INFO - psutil == 3.1.1 07:58:47 INFO - requests == 1.2.3 07:58:47 INFO - wsgiref == 0.1.2 07:58:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:47 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')]} 07:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:47 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')]} 07:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:47 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 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:47 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 07:58:47 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 07:58:47 INFO - Using env: {'DISPLAY': ':0', 07:58:47 INFO - 'HOME': '/home/cltbld', 07:58:47 INFO - 'LANG': 'en_US.UTF-8', 07:58:47 INFO - 'LANGUAGE': 'en_US:en', 07:58:47 INFO - 'LOGNAME': 'cltbld', 07:58:47 INFO - 'MAIL': '/var/mail/cltbld', 07:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:47 INFO - 'MOZ_NO_REMOTE': '1', 07:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:47 INFO - 'NO_EM_RESTART': '1', 07:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:47 INFO - 'PWD': '/builds/slave/test', 07:58:47 INFO - 'SHELL': '/bin/bash', 07:58:47 INFO - 'SHLVL': '1', 07:58:47 INFO - 'TERM': 'linux', 07:58:47 INFO - 'TMOUT': '86400', 07:58:47 INFO - 'USER': 'cltbld', 07:58:47 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:47 INFO - '_': '/tools/buildbot/bin/python'} 07:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 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)) 07:58:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:58:47 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 07:58:47 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 07:58:47 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 07:58:47 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 07:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:58:49 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)) 07:58:49 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)) 07:58:49 INFO - Installing collected packages: simplejson 07:58:49 INFO - Running setup.py install for simplejson 07:58:49 INFO - building 'simplejson._speedups' extension 07:58:49 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 07:58:50 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 07:58:50 INFO - Successfully installed simplejson 07:58:50 INFO - Cleaning up... 07:58:50 INFO - Return code: 0 07:58:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9ea60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, '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': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', '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 07:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:58:50 INFO - Using env: {'DISPLAY': ':0', 07:58:50 INFO - 'HOME': '/home/cltbld', 07:58:50 INFO - 'LANG': 'en_US.UTF-8', 07:58:50 INFO - 'LANGUAGE': 'en_US:en', 07:58:50 INFO - 'LOGNAME': 'cltbld', 07:58:50 INFO - 'MAIL': '/var/mail/cltbld', 07:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:50 INFO - 'MOZ_NO_REMOTE': '1', 07:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:50 INFO - 'NO_EM_RESTART': '1', 07:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:50 INFO - 'PWD': '/builds/slave/test', 07:58:50 INFO - 'SHELL': '/bin/bash', 07:58:50 INFO - 'SHLVL': '1', 07:58:50 INFO - 'TERM': 'linux', 07:58:50 INFO - 'TMOUT': '86400', 07:58:50 INFO - 'USER': 'cltbld', 07:58:50 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:50 INFO - '_': '/tools/buildbot/bin/python'} 07:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:58:50 INFO - Cleaning up... 07:58:50 INFO - Return code: 0 07:58:50 INFO - Running post-action listener: _resource_record_post_action 07:58:50 INFO - Running post-action listener: _start_resource_monitoring 07:58:50 INFO - Starting resource monitoring. 07:58:50 INFO - [mozharness: 2017-10-24 14:58:50.479920Z] Finished create-virtualenv step (success) 07:58:50 INFO - [mozharness: 2017-10-24 14:58:50.480446Z] Running install step. 07:58:50 INFO - Running pre-action listener: _resource_record_pre_action 07:58:50 INFO - Running main action method: install 07:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:50 INFO - Reading from file tmpfile_stdout 07:58:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:58:50 INFO - Reading from file tmpfile_stdout 07:58:50 INFO - Output received: 07:58:50 INFO - Usage: mozinstall [options] installer 07:58:50 INFO - Options: 07:58:50 INFO - -h, --help show this help message and exit 07:58:50 INFO - -d DEST, --destination=DEST 07:58:50 INFO - Directory to install application into. [default: 07:58:50 INFO - "/builds/slave/test"] 07:58:50 INFO - --app=APP Application being installed. [default: firefox] 07:58:50 INFO - mkdir: /builds/slave/test/build/application 07:58:50 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'] 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:59:05 INFO - Reading from file tmpfile_stdout 07:59:05 INFO - Output received: 07:59:05 INFO - /builds/slave/test/build/application/firefox/firefox 07:59:05 INFO - Running post-action listener: _resource_record_post_action 07:59:05 INFO - [mozharness: 2017-10-24 14:59:05.539626Z] Finished install step (success) 07:59:05 INFO - [mozharness: 2017-10-24 14:59:05.539959Z] Running setup-mitmproxy step. 07:59:05 INFO - Running pre-action listener: _resource_record_pre_action 07:59:05 INFO - Running main action method: setup_mitmproxy 07:59:05 INFO - Skipping: mitmproxy is not required 07:59:05 INFO - Running post-action listener: _resource_record_post_action 07:59:05 INFO - [mozharness: 2017-10-24 14:59:05.541078Z] Finished setup-mitmproxy step (success) 07:59:05 INFO - [mozharness: 2017-10-24 14:59:05.541297Z] Running run-tests step. 07:59:05 INFO - Running pre-action listener: _resource_record_pre_action 07:59:05 INFO - Running pre-action listener: _set_gcov_prefix 07:59:05 INFO - Running main action method: run_tests 07:59:05 WARNING - Try message not found. 07:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:05 INFO - Python 2.7.3 07:59:05 INFO - Return code: 0 07:59:05 INFO - grabbing minidump binary from tooltool 07:59:05 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')]} 07:59:05 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 0xfa2090>, '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 0xfa2d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9cf90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:05 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 07:59:05 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 07:59:05 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 07:59:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:05 INFO - Return code: 0 07:59:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:59:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:05 INFO - ENV: RUST_BACKTRACE is now full 07:59:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:59:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:59:05 INFO - Using env: {'DISPLAY': ':0', 07:59:05 INFO - 'HOME': '/home/cltbld', 07:59:05 INFO - 'LANG': 'en_US.UTF-8', 07:59:05 INFO - 'LANGUAGE': 'en_US:en', 07:59:05 INFO - 'LOGNAME': 'cltbld', 07:59:05 INFO - 'MAIL': '/var/mail/cltbld', 07:59:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:05 INFO - 'MOZ_NO_REMOTE': '1', 07:59:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:05 INFO - 'NO_EM_RESTART': '1', 07:59:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:05 INFO - 'PWD': '/builds/slave/test', 07:59:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:05 INFO - 'RUST_BACKTRACE': 'full', 07:59:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:59:05 INFO - 'SHELL': '/bin/bash', 07:59:05 INFO - 'SHLVL': '1', 07:59:05 INFO - 'TERM': 'linux', 07:59:05 INFO - 'TMOUT': '86400', 07:59:05 INFO - 'USER': 'cltbld', 07:59:05 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:05 INFO - '_': '/tools/buildbot/bin/python'} 07:59:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:59:05 INFO - mozversion application_buildid: 20171024133944 07:59:05 INFO - mozversion application_changeset: f2d5cf8571925b8cea9bf10f427915ec25e19bc5 07:59:05 INFO - mozversion application_display_name: Firefox 07:59:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:05 INFO - mozversion application_name: Firefox 07:59:05 INFO - mozversion application_remotingname: firefox 07:59:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:59:05 INFO - mozversion application_vendor: Mozilla 07:59:05 INFO - mozversion application_version: 57.0 07:59:05 INFO - mozversion platform_buildid: 20171024133944 07:59:05 INFO - mozversion platform_changeset: f2d5cf8571925b8cea9bf10f427915ec25e19bc5 07:59:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:59:05 INFO - mozversion platform_version: 57.0 07:59:05 INFO - using testdate: 1508857145 07:59:05 INFO - actual date: 1508857145 07:59:05 INFO - starting webserver on 'localhost:42208' 07:59:05 INFO - SUITE-START | Running 2 tests 07:59:05 INFO - TEST-START | dromaeo_css 07:59:05 INFO - Initialising browser for dromaeo_css test... 07:59:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42208/getInfo.html -profile /tmp/tmp2yHvux/profile 07:59:05 INFO - TEST-INFO | started process 25874 (/builds/slave/test/build/application/firefox/firefox http://localhost:42208/getInfo.html) 07:59:10 INFO - TEST-INFO | 25874: exit 0 07:59:10 INFO - Browser initialized. 07:59:10 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:10 INFO - Using env: {'DISPLAY': ':0', 07:59:10 INFO - 'HOME': '/home/cltbld', 07:59:10 INFO - 'JSGC_DISABLE_POISONING': '1', 07:59:10 INFO - 'LANG': 'en_US.UTF-8', 07:59:10 INFO - 'LANGUAGE': 'en_US:en', 07:59:10 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:59:10 INFO - 'LOGNAME': 'cltbld', 07:59:10 INFO - 'MAIL': '/var/mail/cltbld', 07:59:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:10 INFO - 'MOZ_CRASHREPORTER': '1', 07:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:10 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:59:10 INFO - 'MOZ_NO_REMOTE': '1', 07:59:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:10 INFO - 'NO_EM_RESTART': '1', 07:59:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:10 INFO - 'PWD': '/builds/slave/test', 07:59:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:10 INFO - 'RUST_BACKTRACE': 'full', 07:59:10 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:59:10 INFO - 'SHELL': '/bin/bash', 07:59:10 INFO - 'SHLVL': '1', 07:59:10 INFO - 'TERM': 'linux', 07:59:10 INFO - 'TMOUT': '86400', 07:59:10 INFO - 'USER': 'cltbld', 07:59:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 07:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:10 INFO - '_': '/tools/buildbot/bin/python'} 07:59:10 INFO - TEST-INFO | started process 26102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2yHvux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:11 INFO - PID 26102 | 07:59:11 INFO - PID 26102 | (/builds/slave/test/build/application/firefox/firefox:26151): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:59:11 INFO - PID 26102 | 07:59:21 INFO - PID 26102 | RSS: Main: 143921152 07:59:21 INFO - PID 26102 | 08:02:19 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42208/tests/dromaeo/cssquery-ext.html) 08:02:20 INFO - PID 26102 | RSS: Main: 146657280 08:02:20 INFO - PID 26102 | 08:05:21 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-ext.html (next: http://localhost:42208/tests/dromaeo/cssquery-jquery.html) 08:05:22 INFO - PID 26102 | RSS: Main: 145264640 08:05:22 INFO - PID 26102 | 08:08:24 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42208/tests/dromaeo/cssquery-mootools.html) 08:08:24 INFO - PID 26102 | RSS: Main: 146784256 08:08:24 INFO - PID 26102 | 08:11:26 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42208/tests/dromaeo/cssquery-prototype.html) 08:11:26 INFO - PID 26102 | RSS: Main: 146481152 08:11:26 INFO - PID 26102 | 08:14:29 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42208/tests/dromaeo/cssquery-yui.html) 08:14:30 INFO - PID 26102 | RSS: Main: 147607552 08:14:30 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | Cycle 1(1): loaded http://localhost:42208/tests/dromaeo/cssquery-yui.html (next: http://localhost:42208/tests/dromaeo/cssquery-dojo.html) 08:17:31 INFO - PID 26102 | RSS: Main: 150003712 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | __start_tp_report 08:17:31 INFO - PID 26102 | _x_x_mozilla_page_load 08:17:31 INFO - PID 26102 | _x_x_mozilla_page_load_details 08:17:31 INFO - PID 26102 | |i|pagename|runs| 08:17:31 INFO - PID 26102 | |0;dojo.html;4015.3173960426725;4032.65722413595;4041.151358214775;4058.2086493133843;4060.5736397678243;6558.606483610986;6575.220582783418;6698.8660226795555;6720.529562930591;6734.79795606132;6650.201975762903;6658.30087840777;6664.666766661671;6680.532362734611;6747.797566073025;5966.9403305967035;6026.969865150668;6038.305594856603;6053.243344581916;6064.605800622968;5896.086106653475;5995.250593675791;6029.246344206974;6124.356942521038;6133.846653833668;5900.498457631085;5953;6053.243344581927;6152.138700581922;6171.537134714892;6083.11794789753;6094.268687757498;6112.205413296288;6138.232720909887;6164.321924588292;5814.098814683689;5945.197398351211;6023.608465449775;6056.757729690807;6154.661493617849;6505.869882602321;6531.902021469682;6585.539012269143;6618.56979296349;6675.46596272297;7233.204347521769;7249.202587715347;7319.121705395387;7328.487005909588;7333.963330183315;7063.964680176618;7295.0516432863915;7296.6716497757725;7346.96326518364;7385.150707668633;6573.30980247072;6666.899996500057;6673.432758215557;6730.427913627347;6814.795556133324;7402.185759566443;7448.702051917862;7495.700171993169;7502.962485187539;7509.812254693567;7117.89323160153;7140.500164988401;7142.4286057115305;7224.20533741288;7252.3835473984245;7051.823704407431;7069.222385537587;7202.459815513857;7210.67551960163;7308.744193953186;7083.787486375417;7114.679839407239;7125.96437017822;7180.425565954815;7201.639918004079;7124.7150113995895;7126.251743566851;7135.536190147727;7214.422846172293;7219.494635375579;5225.712585807817;5318.308619879391;5389.595780316414;5390.51485366311;5393;4840.951590484121;4916.0905232532095;4938.851834444972;5007.624428167902;5035.320231768665;6749.831254218684;6767.052612634235;6820.249772525019;6843.8973415398805;6853.246142924274;7099.787006389816;7185.425165986709;7246.166690830517;7282.089738782653;7299.5620262784405;6537.771178008747;6621.768238111643;6679.165104361955;6715.966420167965;6751.527393082535;6184.721687524072;6216.720247588869;6246.3753624637175;6249.9062514062325;6255.43701066897;7258.129024516986;7483.4013278937555;7484.101907771103;7575.734849280248;7602.277783610548;7098.3256590623805;7124.287571243041;7144.3570078693165;7145.321194486515;7211.6033618151505;7491.213422590549;7512.173660897406;7572.204918483701;7578.545287282781;7600.049993750781;7138.607376594337;7152.213256541881;7160.176579693402;7228.385587225145;7248.383887369632;6999.965000174967;7230.927690723025;7235.131784185932;7297.306755858185;7322.1579518356075;6841.657917104224;6898.620575868375;6970.128733908262;6979.546329488567;6982.231954485104;6934.098567186234;6979.825504362431;7019.4735394844565;7026.227115017242;7031.015657808013;6859.622720750406;6877.1747390313485;6879.346462086094;6967.79096627102;6973.686184121828;6818.454523638196;6917.619530925646;7032.050673159058;7060.435165186876;7110.1112360954885;6829.180498340231;6847.794566163023;6858.177018757581;6898.310168983262;6914.688839002157 08:17:31 INFO - PID 26102 | |1;ext.html;986.4081551069357;1011.888692243853;1016.547636301845;1017.7201269650845;1022.3456987527983;45663;46719.29921051187;46721;46751.5324846751;46780;42874.785626071825;43317.35023974643;43486.565134348646;43500.56499435005;43526.56473435264;8032.759017229478;8086.272235498804;8093.797655058612;8143.552104634243;8152.918470815305;7987.400944929153;8061.4760040597175;8127.390445716565;8134.877976830352;8144.470609410369;8060.637271322776;8626.396152269344;8796.208341249287;8846.292296616288;8920.776980575472;8785.604647790864;8850.645974161025;8854.158854908774;8855.645774169057;8873.822523549557;8650.956745216297;8688.913110868874;8699.217070463688;8720.084391138902;8758.73723788281;40600.39099413511;40751;40848.59151408507;40866;42080.36879446811;3809.657130858236;3848.499695039655;3850.4994350734505;3860.9420858686863;3871.3031654302213;33776.324473510394;34276.82861585701;35474.82262588696;35538.46692299617;35627.82186089079;5564.443555644403;5623.493885550321;5707.4577915098;5725.08398656213;5742.799002034909;239117.99999999825;249534;249555;250230;250708;47926.760366197945;53528.46471535235;54865.451345486836;55458.72270638621;55565.72217138889;57185.42814571801;57271;57720.71139644359;57732;57770;17101.315947362215;17230.310787568607;17231;17254.137293135293;17295.135243237786;14349.78475322871;14363.138211707332;14364.640883977776;14368.784468232985;14378.065425747292;15209.163496007826;15236.695266094615;15289.235538223267;15342.079475231521;15470.226488675522;5659.886802264014;5786.88426231473;5865.501432378211;5921.644701317849;6020;1117.7261570915016;1128.5542210826677;1137.5222406589253;1137.8008848451489;1138.1975707126455;26320.473590528083;26431.735682643313;26533.469330613665;26633;26673.33316667099;1236.6784635994707;1248.082659245472;1248.7440074784647;1257.220523275575;1271.5295340723992;13895.861041389659;13975.79036314456;13993.440262389595;14084.859151408355;14165.433382664578;284848;285603;286720;286859;286902;59900.40099598948;60165;60331.69834150801;60422;60460.395396046355;1572.300326354784;1572.5675439254296;1577.1168145838367;1595.3060418717894;1616.3696158498194;25834.87082564575;25853.870730646227;26091;26193.607095893196;26296.73703262943;43942.34086488641;44008;44163.67508974736;44170.55829441793;44182.77908610436;245038;245757;246239;246390;246969;36254.093647657966;39293;39476.40785388279;39812;39904.60095399009;51954.480455194964;53217.73391133019;53434.73282633562;53519;53841.730791347356;38674;38685.61314386933;38700.6129938697;38816.22367552577;38956.80521597374;38651.420228697156;38736.80631596824;38760;38783.612163878;38810.223795523365;44786.55213447824;44832.775836120614;45023.774881126694;45085;45338.319925200485;34687;35264.647353527165;35284.64715352814;35319.82340088283;35534.46698299476;27888;28052.158435246976;28190.71809281881;28401.857990709916;28710.856445717636 08:17:31 INFO - PID 26102 | |2;jquery.html;653.59477124183;653.8325451129502;654.6091247338786;656.4333456186313;657.6583769111014;23936.76063239367;24451.144209952632;24573.26280211592;24679.876600617015;24693.50612987739;27171.86414067927;27603;27618.447631047366;27629;27647.86176069122;6420.711068001928;6437.101055188718;6466.127072845176;6468.547201695883;6484.221893372778;6433.324500927405;6503.317151699074;6517.283098859121;6526.836829079263;6556.508261880354;6478.902816457733;6482;6505.251896031969;6647.833804154887;6890.138732658418;6895.689693963758;6948.687309071079;6949.374556289933;6950.826229344257;6953;6462.450691691212;6532.052852336385;6537.803865884031;6540.4767618590395;6540.574862633914;30576.54135187974;30702.692973070207;31176;31205.68794312073;31227.219319516968;2321.1179751694417;2378.1200955646523;2380.071772008918;2381.499885024147;2405.4707964247837;18749.531261718566;19086.80913190864;19114.13986370617;19119.80880191208;19127.043647817554;2569.087973769322;2621.279148234232;2670.679518457778;2677.089789471589;2685.140754958414;138807;145429;165214;173362.1331893345;173367.13316433463;16261.756073658904;16281.348746050026;17146.142692865305;17227.82772172287;17338.739918901225;26952.191434257005;26955;27004.32489187786;27017.459650806875;27162;11271.154663400277;11453.255538389978;11487.597934072268;11574.88425115755;11805.645830625095;10440.582376704846;10463.68608941733;10677.305975111592;10701.678949631523;10781.784364312827;9874.259430542737;9962.950185249172;10078.74803129913;10148.898511014942;10285;2909.3956718249456;2920.6710946519283;2946.808457450259;3078.445879741668;3161.873525059018;1046.4767616191905;1067.5516283161091;1072.5280876414508;1074.2050882347007;1080.56777289085;21248.36254912355;21545.138194472358;21604.56790864174;21746;22028.229011984502;1124.145649306533;1129.548180727699;1131.4399372310759;1145.2269717940358;1147.7417581044365;11852.70368240801;12071.939640301742;12103.455344509519;12162.391880405945;12414.689632759253;644546;653436;654568;666627;685350;128202.35898820446;131724;132619;134557;134572;1151.067635215478;1192.7554851255472;1243.620695687806;1261.2936755416995;1296.397175313465;22097.668534971668;22491.100355985578;22518.549629007655;22536.5492690142;22613.208537701103;61127.69436152791;61219;62010;62160.68919655553;63466;74355.62822185854;75960.62019689866;76300;77143.61428192822;77235;15814.051156930622;16242.918785405996;16266.674666506367;16274.67450651004;16351.918240408722;24856;24858.50282994366;24927.750722492543;24941.875290624157;24942.37644058913;19225.903870480557;19719.40841774749;20161;20181.899090504452;20316.390508284774;17577.912110439367;17627.82372176262;18076.186571604572;18203.089845507406;18208.544786380447;20008.89995550013;20751.688724669442;20863.165473380894;21110.894445527672;21130.260440884496;15785.447509337118;16006.119663418624;16117.516474505783;16193.838061619233;16241.51275461738;20040.098195581526;20072.197112115937;20196.29312974039;20206;20250.08874600617 08:17:31 INFO - PID 26102 | |3;mootools.html;1434.1323499282933;1540.0528674864954;1553.277725857476;1567.733485307497;1570.9371625134995;18457.169427375768;18860.151293191804;19010.809891901077;19039;19042.238310467583;18451.815481845177;18519.537011574685;18539.44381668549;18649.440516784518;18673.813261867377;2800.2159395369276;2906.229849089993;2906.3170155013554;2907.622009138809;2909.3308539036034;2784.763295119907;2887.119428574284;2890.523063694488;2898.043645596948;2899.3911278631513;2791.3719413131985;2881.9279518012113;2889.2343528964734;2891.4939885520057;2892.117904039267;2848.686644469107;2860.67102283238;2878.6113874626867;2879.4672985497646;2885.8701358438816;2738.5070687276284;2767.3081729567607;2768.1695491352716;2783.1233161554246;2788.3726161613677;17252.56868578283;17292.56768580783;17293.567660808454;17361.565960850952;17392.826071739248;8783.868241976375;9178.219851312646;9198.218151457135;9199.218066464358;9219.078092190794;6202.658853763041;6212.099245609361;6340.429361357454;6388.201474815648;6392.2968473468345;2065.297798748433;2141.154244073598;2145.10977944153;2183.639699449589;2192.210804110519;32492.999999999764;32548.186295342806;32779.836100819346;32780.344393112246;32902.6709732902;7602.201768814195;7607.847843043219;7653.57905315213;7667.808304792425;7773.533587984739;20755.68866467004;20761.792382075986;20768.79231207699;20778.48053798637;20779.8961005194;8830.911690883137;9001.684941027033;9021.413608115452;9023.323250756219;9025.097490250922;7998.64006119726;8150.144234855374;8154.836903261901;8244.54654993981;8264.586770661563;5782.942170578324;5965.105234214816;5981.641101533922;6039.094135879654;6049.576529642971;1570.1207323898652;1650.2326418215587;1714.3314107498086;1723.1212081838353;1766.1875537253009;1011.4032720694826;1041.7864337810731;1052.2634156090767;1055.9208059395576;1065.5524679634573;10332.276740628084;10403.687889363331;10529.57881684724;10689.198310126772;10692.572297108185;824.7731873734651;836.782436566497;839.6179738219096;843.9957800210959;909.9226565741853;6105.419985101408;6383.648899310582;6392.808215753442;6609.074729537869;6673.766418175438;25893.352666183495;27004.05485807987;27321.590176147372;27329.453410932067;27605.723942760716;26781.73218267831;26802.865985670338;27025.729742702715;27269.590956135675;27395;12809.871901281054;13090.803637945439;13279.20324780497;13290.20258784476;13401.329933503286;9991.450470224207;10190.08289253941;10307.020833020852;10331.32846364984;10383.117435018108;22104.447388814766;22309.888450557642;22525.436864077874;22697.546049079258;22999.770002299763;23257.88371058134;23926.760732392453;24044.15845445401;24114.87942560346;24493.75506244915;12872.292023938773;13133.277669727875;13136.40886160106;13144;13145.474181032652;16147.838521615104;16188.109653969144;16331.265093071079;16431.589210269838;16486.34054637801;13194.868051319363;13218.933905330412;13318.733625327633;13407.865921341052;13801.861981380058;12085.220399308384;12306.138570299992;12476.563320283747;12557.87442125567;12643.620691379274;11681.707957301136;11735.295882247092;11796.823047654121;11799.882001179878;11809.468573914022;7956.5226086435;8057.435979481615;8063.153368896416;8086.959565202136;8125.309348705427;8753.387262891536;8797.38418310712;8807.471551706918;8818.250448711675;8850.070742571937 08:17:31 INFO - PID 26102 | |4;prototype.html;555.7249161664973;587.8647910980471;588.6232811000958;591.5415552946466;594.4768603628803;6507.089007538936;6575.487637843293;6585.440237579805;6640.833979150518;6659.866802663956;6398.552101352895;6424.486041116711;6436.324185960465;6504.252011018734;6608.636524991123;5329.294625719762;5398.757055932492;5418.783248670048;5424.945750542483;5435.130379139338;5109.923351149736;5346.4118946915805;5348.224507446418;5418.810341638044;5420.24116623673;5093.414257360396;5146.897062058757;5165.527824569998;5166.844994650148;5190.4031036430915;5142.125838607446;5212.53087222148;5212.791488340462;5223.817166399177;5231.607629427808;4706.482286948433;4712.2224832902875;4718.363020992157;4719.480857105716;4756.191447453941;6356.968215158895;6372.330905254974;6428.292887782341;6429.935700642981;6459.61242325462;6120;6145.4161854623735;6151.200343955302;6202.534809889276;6212.949726590215;6863.691133898987;6897.068895699117;6905.413039891615;6918.1698196216275;6957.65211739411;5284.969430960964;5292.444293349181;5312.203169524563;5319.6808191508635;5321.1752178412025;6961.338672826073;7050.285640028575;7211.134663840373;7235.746748863817;7261.673224704901;5381.9461805382225;5418.431064738224;5421.566274698014;5434.10337294342;5442.2108794225405;5452.672839629635;5467.988422141916;5481.369642491085;5523.972380138154;5561.443855614487;6062.727177277033;6111.786087487006;6112.969435152885;6113.969430152821;6122.234720659918;6968.163820341591;6986.4061554767395;7001.894971575431;7016.614351120644;7032.085828842218;1898.3450709505198;1898.6107847891149;1912.4453908366418;1914.5787926656114;1915.4445210888964;1273.9235046873537;1303.2766814417898;1330.82699249097;1342.64392963106;1355.9322033898266;6445.645489498029;6495.902561461582;6526;6528.51036172289;6549.312322206099;6907.481938854606;6966.860662786818;7062.223155452896;7074;7085.716571337089;6540.117084193573;6586.473082153416;6592.736290548324;6616.239132499824;6619.106420633249;3709.091272638167;3740.251949610089;3760.8972597607085;3799.3351163546267;3800.7149463790324;7204.4956853019785;7270.9636451817405;7290.526115802562;7302.233265507151;7361.190269070398;7131.536450130725;7202.315780000891;7286.344229019413;7304.306090921354;7367.373773229228;7291.833306670907;7340.853182936311;7452.813679657944;7466.328030477174;7467.087835743955;6996.6151861648095;7010.334018268256;7091.432685385053;7105.360517553445;7148.749793757193;6933.237343892067;6957.75647852343;6961.89557156633;6964.756233531802;6965.268646792217;7119.82200444993;7209.963950180216;7255.274472552703;7296.160941491584;7347.55914645123;5417.485338892799;5448.509634132947;5464.153056276284;5490.945090549043;5518.172274158908;6872;7041.471889608198;7086.362227399559;7130.180029296697;7189.640517974185;6664.467832049022;6772.814757417334;6774;6787.083743694538;6885.036094946811;6690.264070952094;6695.397414232742;6834.658267086526;6841.17905851301;6872.144520979207;6625.734970601122;6633.436157926437;6633.568818026813;6657.167854018247;6711.328867113445;6824.93175068243;6922.988500002515;6957.9215221640725;6983.2318444972025;7003.96498017527;6618.801435956929;6693.866122677617;6802.489813263926;6809.718744220543;6853.965730171317 08:17:31 INFO - PID 26102 | |5;yui.html;1004.8392257238843;1011.9291649584527;1020.3724709303776;1043.577351172775;1050.758325585115;20006.399808005746;20074.598508029867;20177.09203085861;21802.563948721017;22390.776092239073;20041.398758037245;20231.291904783335;20304;20315.796842031574;20327.186912523517;1087.374759513279;1087.4943151434582;1092.6667366453228;1099.4612639806496;1100.02098132662;1103.7351035751442;1104.0119093411392;1104.9558017679283;1105.5909313553957;1107.3134656512932;1100.114407901639;1137.9886201137965;1143.2054721968236;1145.7250259937596;1146.776378606172;1139.8746137924904;1139.9943000284986;1141.3209140561435;1144.5536240866027;1151.067635215478;834.9582520873932;835.0563862834957;838.2916435611959;839.2572573272637;840.2143995364293;21708.348749537538;21743;22402.88798556013;22708.545829083327;22709.77290227093;23398.298051058326;23717.169899053624;23768.524629507487;24325.635115473284;24344.756552434425;19645.607087858163;19646.312379066807;19804.80195198044;19806.70289945652;19934.900325498278;3798.905027374338;3839.2321535692695;3846.442265871461;3872.1481274119647;3879.592642772525;128862;148912;162808;162856;166814.1659291708;19350.8064919349;19389.8061019388;19513.609727805648;19870.503237418892;19883.701744473845;35590.46614300788;35623.28753424917;35782;35924.820375898475;36086.278274434364;10662.680119596425;10687.25189236746;10691.518881650189;10705.197110216764;10709.839352409721;5037.722925239147;5072.923906141411;5074.188129899198;5148.021875843652;5154.329937108152;5963.224780778471;6010.308814486302;6074.787382441594;6075.2405949256345;6082.452579267887;1242.782513060229;1298.4157129291857;1302.446460254407;1307.4966138036925;1312.3962977030674;753.4537460341319;770.0874463760462;774.5275382016965;779.4426984705849;789.06889869954;12775.936120319338;12949.352532373343;14235.85764142366;15647.452339168301;15758.369665213264;723.2984005514747;751.537804250393;751.7342946540537;759.1535437986605;760.2093822424616;6686.699098540577;6687.264400915896;6712.328767123347;6764.3573860483175;6770.289119642465;146853.26573367277;148671;148877;150491;153946;103847.4807625957;106305;131467;139608;144025;103925.48037259765;105110;106740.46629766801;109032.45483772531;109292.4535377334;14198.361073751912;14708.191049492381;14816.185109818633;15022.549323520312;15269.236538173269;56595.434045659014;57650.711746441;57913.71043144757;58072.709636451546;58166.12750808826;98509;103867;104304;104750;104757;21054.368368948955;21588.46028849291;21634.567308653423;21804.563908722055;21904.45238869041;24744.752552474245;24754.628680569447;24860.627090593294;24954.251372458857;25202.36994075163;22074.006669699582;22602.886985565623;22659.320220393416;22951.081956721544;22978.540429191657;21165.894170529664;21318.360449186548;21397.358079257647;21399.144034238456;21537.676934846302;22230.999605018136;22609.208677696202;22625.321240362817;22650.207242746426;22743.88628056849;16199.838001620305;16287.348506059625;16537.421190258283;16670.24983875753;16749.74875376846;16092.195390230676;16185.433509827571;16222.675546488768;16294.511164665078;16502.587435314214 08:17:31 INFO - PID 26102 | __end_tp_report 08:17:31 INFO - PID 26102 | __start_cc_report 08:17:31 INFO - PID 26102 | _x_x_mozilla_cycle_collect,233 08:17:31 INFO - PID 26102 | __end_cc_report 08:17:31 INFO - PID 26102 | __startTimestamp1508858251899__endTimestamp 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | ------- Summary: start ------- 08:17:31 INFO - PID 26102 | Number of tests: 6 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#0] dojo.html Cycles:165 Average:6668.74 Median:6879.35 stddev:765.96 (11.1%) stddev-sans-first:739.49 08:17:31 INFO - PID 26102 | Values: 4015.3 4032.7 4041.2 4058.2 4060.6 6558.6 6575.2 6698.9 6720.5 6734.8 6650.2 6658.3 6664.7 6680.5 6747.8 5966.9 6027.0 6038.3 6053.2 6064.6 5896.1 5995.3 6029.2 6124.4 6133.8 5900.5 5953.0 6053.2 6152.1 6171.5 6083.1 6094.3 6112.2 6138.2 6164.3 5814.1 5945.2 6023.6 6056.8 6154.7 6505.9 6531.9 6585.5 6618.6 6675.5 7233.2 7249.2 7319.1 7328.5 7334.0 7064.0 7295.1 7296.7 7347.0 7385.2 6573.3 6666.9 6673.4 6730.4 6814.8 7402.2 7448.7 7495.7 7503.0 7509.8 7117.9 7140.5 7142.4 7224.2 7252.4 7051.8 7069.2 7202.5 7210.7 7308.7 7083.8 7114.7 7126.0 7180.4 7201.6 7124.7 7126.3 7135.5 7214.4 7219.5 5225.7 5318.3 5389.6 5390.5 5393.0 4841.0 4916.1 4938.9 5007.6 5035.3 6749.8 6767.1 6820.2 6843.9 6853.2 7099.8 7185.4 7246.2 7282.1 7299.6 6537.8 6621.8 6679.2 6716.0 6751.5 6184.7 6216.7 6246.4 6249.9 6255.4 7258.1 7483.4 7484.1 7575.7 7602.3 7098.3 7124.3 7144.4 7145.3 7211.6 7491.2 7512.2 7572.2 7578.5 7600.0 7138.6 7152.2 7160.2 7228.4 7248.4 7000.0 7230.9 7235.1 7297.3 7322.2 6841.7 6898.6 6970.1 6979.5 6982.2 6934.1 6979.8 7019.5 7026.2 7031.0 6859.6 6877.2 6879.3 6967.8 6973.7 6818.5 6917.6 7032.1 7060.4 7110.1 6829.2 6847.8 6858.2 6898.3 6914.7 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#1] ext.html Cycles:180 Average:44879.38 Median:38771.81 stddev:67738.76 (174.7%) stddev-sans-first:67848.61 08:17:31 INFO - PID 26102 | Values: 986.4 1011.9 1016.5 1017.7 1022.3 45663.0 46719.3 46721.0 46751.5 46780.0 42874.8 43317.4 43486.6 43500.6 43526.6 8032.8 8086.3 8093.8 8143.6 8152.9 7987.4 8061.5 8127.4 8134.9 8144.5 8060.6 8626.4 8796.2 8846.3 8920.8 8785.6 8850.6 8854.2 8855.6 8873.8 8651.0 8688.9 8699.2 8720.1 8758.7 40600.4 40751.0 40848.6 40866.0 42080.4 3809.7 3848.5 3850.5 3860.9 3871.3 33776.3 34276.8 35474.8 35538.5 35627.8 5564.4 5623.5 5707.5 5725.1 5742.8 239118.0 249534.0 249555.0 250230.0 250708.0 47926.8 53528.5 54865.5 55458.7 55565.7 57185.4 57271.0 57720.7 57732.0 57770.0 17101.3 17230.3 17231.0 17254.1 17295.1 14349.8 14363.1 14364.6 14368.8 14378.1 15209.2 15236.7 15289.2 15342.1 15470.2 5659.9 5786.9 5865.5 5921.6 6020.0 1117.7 1128.6 1137.5 1137.8 1138.2 26320.5 26431.7 26533.5 26633.0 26673.3 1236.7 1248.1 1248.7 1257.2 1271.5 13895.9 13975.8 13993.4 14084.9 14165.4 284848.0 285603.0 286720.0 286859.0 286902.0 59900.4 60165.0 60331.7 60422.0 60460.4 1572.3 1572.6 1577.1 1595.3 1616.4 25834.9 25853.9 26091.0 26193.6 26296.7 43942.3 44008.0 44163.7 44170.6 44182.8 245038.0 245757.0 246239.0 246390.0 246969.0 36254.1 39293.0 39476.4 39812.0 39904.6 51954.5 53217.7 53434.7 53519.0 53841.7 38674.0 38685.6 38700.6 38816.2 38956.8 38651.4 38736.8 38760.0 38783.6 38810.2 44786.6 44832.8 45023.8 45085.0 45338.3 34687.0 35264.6 35284.6 35319.8 35534.5 27888.0 28052.2 28190.7 28401.9 28710.9 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#2] jquery.html Cycles:180 Average:41834.80 Median:22527.55 stddev:110208.61 (489.2%) stddev-sans-first:110474.40 08:17:31 INFO - PID 26102 | Values: 653.6 653.8 654.6 656.4 657.7 23936.8 24451.1 24573.3 24679.9 24693.5 27171.9 27603.0 27618.4 27629.0 27647.9 6420.7 6437.1 6466.1 6468.5 6484.2 6433.3 6503.3 6517.3 6526.8 6556.5 6478.9 6482.0 6505.3 6647.8 6890.1 6895.7 6948.7 6949.4 6950.8 6953.0 6462.5 6532.1 6537.8 6540.5 6540.6 30576.5 30702.7 31176.0 31205.7 31227.2 2321.1 2378.1 2380.1 2381.5 2405.5 18749.5 19086.8 19114.1 19119.8 19127.0 2569.1 2621.3 2670.7 2677.1 2685.1 138807.0 145429.0 165214.0 173362.1 173367.1 16261.8 16281.3 17146.1 17227.8 17338.7 26952.2 26955.0 27004.3 27017.5 27162.0 11271.2 11453.3 11487.6 11574.9 11805.6 10440.6 10463.7 10677.3 10701.7 10781.8 9874.3 9963.0 10078.7 10148.9 10285.0 2909.4 2920.7 2946.8 3078.4 3161.9 1046.5 1067.6 1072.5 1074.2 1080.6 21248.4 21545.1 21604.6 21746.0 22028.2 1124.1 1129.5 1131.4 1145.2 1147.7 11852.7 12071.9 12103.5 12162.4 12414.7 644546.0 653436.0 654568.0 666627.0 685350.0 128202.4 131724.0 132619.0 134557.0 134572.0 1151.1 1192.8 1243.6 1261.3 1296.4 22097.7 22491.1 22518.5 22536.5 22613.2 61127.7 61219.0 62010.0 62160.7 63466.0 74355.6 75960.6 76300.0 77143.6 77235.0 15814.1 16242.9 16266.7 16274.7 16351.9 24856.0 24858.5 24927.8 24941.9 24942.4 19225.9 19719.4 20161.0 20181.9 20316.4 17577.9 17627.8 18076.2 18203.1 18208.5 20008.9 20751.7 20863.2 21110.9 21130.3 15785.4 16006.1 16117.5 16193.8 16241.5 20040.1 20072.2 20196.3 20206.0 20250.1 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#3] mootools.html Cycles:180 Average:11131.83 Median:26792.30 stddev:8332.53 (31.1%) stddev-sans-first:8324.05 08:17:31 INFO - PID 26102 | Values: 1434.1 1540.1 1553.3 1567.7 1570.9 18457.2 18860.2 19010.8 19039.0 19042.2 18451.8 18519.5 18539.4 18649.4 18673.8 2800.2 2906.2 2906.3 2907.6 2909.3 2784.8 2887.1 2890.5 2898.0 2899.4 2791.4 2881.9 2889.2 2891.5 2892.1 2848.7 2860.7 2878.6 2879.5 2885.9 2738.5 2767.3 2768.2 2783.1 2788.4 17252.6 17292.6 17293.6 17361.6 17392.8 8783.9 9178.2 9198.2 9199.2 9219.1 6202.7 6212.1 6340.4 6388.2 6392.3 2065.3 2141.2 2145.1 2183.6 2192.2 32493.0 32548.2 32779.8 32780.3 32902.7 7602.2 7607.8 7653.6 7667.8 7773.5 20755.7 20761.8 20768.8 20778.5 20779.9 8830.9 9001.7 9021.4 9023.3 9025.1 7998.6 8150.1 8154.8 8244.5 8264.6 5782.9 5965.1 5981.6 6039.1 6049.6 1570.1 1650.2 1714.3 1723.1 1766.2 1011.4 1041.8 1052.3 1055.9 1065.6 10332.3 10403.7 10529.6 10689.2 10692.6 824.8 836.8 839.6 844.0 909.9 6105.4 6383.6 6392.8 6609.1 6673.8 25893.4 27004.1 27321.6 27329.5 27605.7 26781.7 26802.9 27025.7 27269.6 27395.0 12809.9 13090.8 13279.2 13290.2 13401.3 9991.5 10190.1 10307.0 10331.3 10383.1 22104.4 22309.9 22525.4 22697.5 22999.8 23257.9 23926.8 24044.2 24114.9 24493.8 12872.3 13133.3 13136.4 13144.0 13145.5 16147.8 16188.1 16331.3 16431.6 16486.3 13194.9 13218.9 13318.7 13407.9 13801.9 12085.2 12306.1 12476.6 12557.9 12643.6 11681.7 11735.3 11796.8 11799.9 11809.5 7956.5 8057.4 8063.2 8087.0 8125.3 8753.4 8797.4 8807.5 8818.3 8850.1 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#4] prototype.html Cycles:180 Average:5894.23 Median:6562.40 stddev:1641.46 (25.0%) stddev-sans-first:1596.41 08:17:31 INFO - PID 26102 | Values: 555.7 587.9 588.6 591.5 594.5 6507.1 6575.5 6585.4 6640.8 6659.9 6398.6 6424.5 6436.3 6504.3 6608.6 5329.3 5398.8 5418.8 5424.9 5435.1 5109.9 5346.4 5348.2 5418.8 5420.2 5093.4 5146.9 5165.5 5166.8 5190.4 5142.1 5212.5 5212.8 5223.8 5231.6 4706.5 4712.2 4718.4 4719.5 4756.2 6357.0 6372.3 6428.3 6429.9 6459.6 6120.0 6145.4 6151.2 6202.5 6212.9 6863.7 6897.1 6905.4 6918.2 6957.7 5285.0 5292.4 5312.2 5319.7 5321.2 6961.3 7050.3 7211.1 7235.7 7261.7 5381.9 5418.4 5421.6 5434.1 5442.2 5452.7 5468.0 5481.4 5524.0 5561.4 6062.7 6111.8 6113.0 6114.0 6122.2 6968.2 6986.4 7001.9 7016.6 7032.1 1898.3 1898.6 1912.4 1914.6 1915.4 1273.9 1303.3 1330.8 1342.6 1355.9 6445.6 6495.9 6526.0 6528.5 6549.3 6907.5 6966.9 7062.2 7074.0 7085.7 6540.1 6586.5 6592.7 6616.2 6619.1 3709.1 3740.3 3760.9 3799.3 3800.7 7204.5 7271.0 7290.5 7302.2 7361.2 7131.5 7202.3 7286.3 7304.3 7367.4 7291.8 7340.9 7452.8 7466.3 7467.1 6996.6 7010.3 7091.4 7105.4 7148.7 6933.2 6957.8 6961.9 6964.8 6965.3 7119.8 7210.0 7255.3 7296.2 7347.6 5417.5 5448.5 5464.2 5490.9 5518.2 6872.0 7041.5 7086.4 7130.2 7189.6 6664.5 6772.8 6774.0 6787.1 6885.0 6690.3 6695.4 6834.7 6841.2 6872.1 6625.7 6633.4 6633.6 6657.2 6711.3 6824.9 6923.0 6957.9 6983.2 7004.0 6618.8 6693.9 6802.5 6809.7 6854.0 08:17:31 INFO - PID 26102 | 08:17:31 INFO - PID 26102 | [#5] yui.html Cycles:180 Average:29876.32 Median:20058.00 stddev:42049.73 (209.6%) stddev-sans-first:42111.81 08:17:31 INFO - PID 26102 | Values: 1004.8 1011.9 1020.4 1043.6 1050.8 20006.4 20074.6 20177.1 21802.6 22390.8 20041.4 20231.3 20304.0 20315.8 20327.2 1087.4 1087.5 1092.7 1099.5 1100.0 1103.7 1104.0 1105.0 1105.6 1107.3 1100.1 1138.0 1143.2 1145.7 1146.8 1139.9 1140.0 1141.3 1144.6 1151.1 835.0 835.1 838.3 839.3 840.2 21708.3 21743.0 22402.9 22708.5 22709.8 23398.3 23717.2 23768.5 24325.6 24344.8 19645.6 19646.3 19804.8 19806.7 19934.9 3798.9 3839.2 3846.4 3872.1 3879.6 128862.0 148912.0 162808.0 162856.0 166814.2 19350.8 19389.8 19513.6 19870.5 19883.7 35590.5 35623.3 35782.0 35924.8 36086.3 10662.7 10687.3 10691.5 10705.2 10709.8 5037.7 5072.9 5074.2 5148.0 5154.3 5963.2 6010.3 6074.8 6075.2 6082.5 1242.8 1298.4 1302.4 1307.5 1312.4 753.5 770.1 774.5 779.4 789.1 12775.9 12949.4 14235.9 15647.5 15758.4 723.3 751.5 751.7 759.2 760.2 6686.7 6687.3 6712.3 6764.4 6770.3 146853.3 148671.0 148877.0 150491.0 153946.0 103847.5 106305.0 131467.0 139608.0 144025.0 103925.5 105110.0 106740.5 109032.5 109292.5 14198.4 14708.2 14816.2 15022.5 15269.2 56595.4 57650.7 57913.7 58072.7 58166.1 98509.0 103867.0 104304.0 104750.0 104757.0 21054.4 21588.5 21634.6 21804.6 21904.5 24744.8 24754.6 24860.6 24954.3 25202.4 22074.0 22602.9 22659.3 22951.1 22978.5 21165.9 21318.4 21397.4 21399.1 21537.7 22231.0 22609.2 22625.3 22650.2 22743.9 16199.8 16287.3 16537.4 16670.2 16749.7 16092.2 16185.4 16222.7 16294.5 16502.6 08:17:31 INFO - PID 26102 | -------- Summary: end -------- 08:17:31 INFO - PID 26102 | 08:17:32 INFO - TEST-INFO | 26102: exit 0 08:17:32 INFO - TEST-OK | dromaeo_css | took 1106606ms 08:17:32 INFO - TEST-START | kraken 08:17:32 INFO - Initialising browser for kraken test... 08:17:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42208/getInfo.html -profile /tmp/tmp_EhARq/profile 08:17:32 INFO - TEST-INFO | started process 26471 (/builds/slave/test/build/application/firefox/firefox http://localhost:42208/getInfo.html) 08:17:36 INFO - TEST-INFO | 26471: exit 0 08:17:36 INFO - Browser initialized. 08:17:36 INFO - Running cycle 1/1 for kraken test... 08:17:36 INFO - Using env: {'DISPLAY': ':0', 08:17:36 INFO - 'HOME': '/home/cltbld', 08:17:36 INFO - 'JSGC_DISABLE_POISONING': '1', 08:17:36 INFO - 'LANG': 'en_US.UTF-8', 08:17:36 INFO - 'LANGUAGE': 'en_US:en', 08:17:36 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:17:36 INFO - 'LOGNAME': 'cltbld', 08:17:36 INFO - 'MAIL': '/var/mail/cltbld', 08:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:36 INFO - 'MOZ_CRASHREPORTER': '1', 08:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:36 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:17:36 INFO - 'MOZ_NO_REMOTE': '1', 08:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:36 INFO - 'NO_EM_RESTART': '1', 08:17:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:36 INFO - 'PWD': '/builds/slave/test', 08:17:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:36 INFO - 'RUST_BACKTRACE': 'full', 08:17:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:17:36 INFO - 'SHELL': '/bin/bash', 08:17:36 INFO - 'SHLVL': '1', 08:17:36 INFO - 'TERM': 'linux', 08:17:36 INFO - 'TMOUT': '86400', 08:17:36 INFO - 'USER': 'cltbld', 08:17:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618', 08:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:36 INFO - '_': '/tools/buildbot/bin/python'} 08:17:36 INFO - TEST-INFO | started process 26702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_EhARq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:37 INFO - PID 26702 | 08:17:37 INFO - PID 26702 | (/builds/slave/test/build/application/firefox/firefox:26752): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:17:37 INFO - PID 26702 | 08:17:48 INFO - PID 26702 | RSS: Main: 143523840 08:17:48 INFO - PID 26702 | 08:17:50 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42208/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:51 INFO - PID 26702 | RSS: Main: 150503424 08:17:51 INFO - PID 26702 | 08:17:53 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42208/tests/kraken/driver.html?testName=audio-dft) 08:17:54 INFO - PID 26702 | RSS: Main: 151175168 08:17:54 INFO - PID 26702 | 08:17:57 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42208/tests/kraken/driver.html?testName=audio-fft) 08:17:58 INFO - PID 26702 | RSS: Main: 152539136 08:17:58 INFO - PID 26702 | 08:18:00 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42208/tests/kraken/driver.html?testName=audio-oscillator) 08:18:00 INFO - PID 26702 | RSS: Main: 152309760 08:18:00 INFO - PID 26702 | 08:18:02 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42208/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:03 INFO - PID 26702 | RSS: Main: 152190976 08:18:03 INFO - PID 26702 | 08:18:06 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42208/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:06 INFO - PID 26702 | RSS: Main: 152731648 08:18:06 INFO - PID 26702 | 08:18:10 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42208/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:11 INFO - PID 26702 | RSS: Main: 153636864 08:18:11 INFO - PID 26702 | 08:18:13 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42208/tests/kraken/driver.html?testName=json-parse-financial) 08:18:14 INFO - PID 26702 | RSS: Main: 154726400 08:18:14 INFO - PID 26702 | 08:18:16 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42208/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:16 INFO - PID 26702 | RSS: Main: 154509312 08:18:16 INFO - PID 26702 | 08:18:18 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:18 INFO - PID 26702 | RSS: Main: 154697728 08:18:18 INFO - PID 26702 | 08:18:20 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:21 INFO - PID 26702 | RSS: Main: 151711744 08:18:21 INFO - PID 26702 | 08:18:23 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:24 INFO - PID 26702 | RSS: Main: 151691264 08:18:24 INFO - PID 26702 | 08:18:27 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:18:27 INFO - PID 26702 | RSS: Main: 151891968 08:18:27 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | Cycle 1(1): loaded http://localhost:42208/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42208/tests/kraken/driver.html?testName=ai-astar) 08:18:29 INFO - PID 26702 | RSS: Main: 153436160 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | __start_tp_report 08:18:29 INFO - PID 26702 | _x_x_mozilla_page_load 08:18:29 INFO - PID 26702 | _x_x_mozilla_page_load_details 08:18:29 INFO - PID 26702 | |i|pagename|runs| 08:18:29 INFO - PID 26702 | |0;ai-astar;104;105;104;105;104;107;105;104;105;104 08:18:29 INFO - PID 26702 | |1;audio-beat-detection;110;113;120;110;113;139;109;114;115;115 08:18:29 INFO - PID 26702 | |2;audio-dft;161;161;162;161;161;160;161;161;161;162 08:18:29 INFO - PID 26702 | |3;audio-fft;75;75;72;72;77;76;75;74;72;74 08:18:29 INFO - PID 26702 | |4;audio-oscillator;78;84;81;83;85;77;78;76;75;77 08:18:29 INFO - PID 26702 | |5;imaging-gaussian-blur;110;113;114;109;113;113;113;113;114;113 08:18:29 INFO - PID 26702 | |6;imaging-darkroom;149;148;148;148;162;149;148;149;149;148 08:18:29 INFO - PID 26702 | |7;imaging-desaturate;95;96;95;93;94;93;94;94;96;94 08:18:29 INFO - PID 26702 | |8;json-parse-financial;46;45;50;42;44;42;44;42;42;43 08:18:29 INFO - PID 26702 | |9;json-stringify-tinderbox;38;38;37;37;38;37;38;43;38;38 08:18:29 INFO - PID 26702 | |10;stanford-crypto-aes;68;77;69;68;74;69;69;74;69;66 08:18:29 INFO - PID 26702 | |11;stanford-crypto-ccm;105;105;98;101;104;109;103;114;98;120 08:18:29 INFO - PID 26702 | |12;stanford-crypto-pbkdf2;147;152;148;151;156;160;149;156;151;153 08:18:29 INFO - PID 26702 | |13;stanford-crypto-sha256-iterative;58;58;56;58;60;55;57;58;63;59 08:18:29 INFO - PID 26702 | __end_tp_report 08:18:29 INFO - PID 26702 | __start_cc_report 08:18:29 INFO - PID 26702 | _x_x_mozilla_cycle_collect,708 08:18:29 INFO - PID 26702 | __end_cc_report 08:18:29 INFO - PID 26702 | __startTimestamp1508858309638__endTimestamp 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | ------- Summary: start ------- 08:18:29 INFO - PID 26702 | Number of tests: 14 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#0] ai-astar Cycles:10 Average:104.70 Median:105.00 stddev:0.95 (0.9%) stddev-sans-first:0.97 08:18:29 INFO - PID 26702 | Values: 104.0 105.0 104.0 105.0 104.0 107.0 105.0 104.0 105.0 104.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:114.50 stddev:8.75 (7.6%) stddev-sans-first:9.03 08:18:29 INFO - PID 26702 | Values: 110.0 113.0 120.0 110.0 113.0 139.0 109.0 114.0 115.0 115.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:18:29 INFO - PID 26702 | Values: 161.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 161.0 162.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#3] audio-fft Cycles:10 Average:74.20 Median:75.00 stddev:1.75 (2.3%) stddev-sans-first:1.83 08:18:29 INFO - PID 26702 | Values: 75.0 75.0 72.0 72.0 77.0 76.0 75.0 74.0 72.0 74.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:79.50 stddev:3.57 (4.5%) stddev-sans-first:3.75 08:18:29 INFO - PID 26702 | Values: 78.0 84.0 81.0 83.0 85.0 77.0 78.0 76.0 75.0 77.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#5] imaging-gaussian-blur Cycles:10 Average:112.50 Median:113.00 stddev:1.65 (1.5%) stddev-sans-first:1.48 08:18:29 INFO - PID 26702 | Values: 110.0 113.0 114.0 109.0 113.0 113.0 113.0 113.0 114.0 113.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.00 stddev:4.32 (2.9%) stddev-sans-first:4.57 08:18:29 INFO - PID 26702 | Values: 149.0 148.0 148.0 148.0 162.0 149.0 148.0 149.0 149.0 148.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:1.07 (1.1%) stddev-sans-first:1.12 08:18:29 INFO - PID 26702 | Values: 95.0 96.0 95.0 93.0 94.0 93.0 94.0 94.0 96.0 94.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#8] json-parse-financial Cycles:10 Average:44.00 Median:44.00 stddev:2.54 (5.8%) stddev-sans-first:2.59 08:18:29 INFO - PID 26702 | Values: 46.0 45.0 50.0 42.0 44.0 42.0 44.0 42.0 42.0 43.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:1.75 (4.6%) stddev-sans-first:1.86 08:18:29 INFO - PID 26702 | Values: 38.0 38.0 37.0 37.0 38.0 37.0 38.0 43.0 38.0 38.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#10] stanford-crypto-aes Cycles:10 Average:70.30 Median:69.00 stddev:3.47 (5.0%) stddev-sans-first:3.57 08:18:29 INFO - PID 26702 | Values: 68.0 77.0 69.0 68.0 74.0 69.0 69.0 74.0 69.0 66.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#11] stanford-crypto-ccm Cycles:10 Average:105.70 Median:111.50 stddev:6.96 (6.2%) stddev-sans-first:7.38 08:18:29 INFO - PID 26702 | Values: 105.0 105.0 98.0 101.0 104.0 109.0 103.0 114.0 98.0 120.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.30 Median:152.50 stddev:4.06 (2.7%) stddev-sans-first:3.82 08:18:29 INFO - PID 26702 | Values: 147.0 152.0 148.0 151.0 156.0 160.0 149.0 156.0 151.0 153.0 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.20 Median:58.00 stddev:2.20 (3.8%) stddev-sans-first:2.33 08:18:29 INFO - PID 26702 | Values: 58.0 58.0 56.0 58.0 60.0 55.0 57.0 58.0 63.0 59.0 08:18:29 INFO - PID 26702 | -------- Summary: end -------- 08:18:29 INFO - PID 26702 | 08:18:29 INFO - PID 26702 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:18:30 INFO - TEST-INFO | 26702: exit 0 08:18:30 INFO - TEST-OK | kraken | took 57727ms 08:18:30 INFO - SUITE-END | took 1164s 08:18:30 INFO - Completed test suite (00:19:24) 08:18:30 INFO - javascript benchmark 08:18:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9562.55227252929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4015.3173960426725, 4032.65722413595, 4041.151358214775, 4058.2086493133843, 4060.5736397678243, 6558.606483610986, 6575.220582783418, 6698.8660226795555, 6720.529562930591, 6734.79795606132, 6650.201975762903, 6658.30087840777, 6664.666766661671, 6680.532362734611, 6747.797566073025, 5966.9403305967035, 6026.969865150668, 6038.305594856603, 6053.243344581916, 6064.605800622968, 5896.086106653475, 5995.250593675791, 6029.246344206974, 6124.356942521038, 6133.846653833668, 5900.498457631085, 5953.0, 6053.243344581927, 6152.138700581922, 6171.537134714892, 6083.11794789753, 6094.268687757498, 6112.205413296288, 6138.232720909887, 6164.321924588292, 5814.098814683689, 5945.197398351211, 6023.608465449775, 6056.757729690807, 6154.661493617849, 6505.869882602321, 6531.902021469682, 6585.539012269143, 6618.56979296349, 6675.46596272297, 7233.204347521769, 7249.202587715347, 7319.121705395387, 7328.487005909588, 7333.963330183315, 7063.964680176618, 7295.0516432863915, 7296.6716497757725, 7346.96326518364, 7385.150707668633, 6573.30980247072, 6666.899996500057, 6673.432758215557, 6730.427913627347, 6814.795556133324, 7402.185759566443, 7448.702051917862, 7495.700171993169, 7502.962485187539, 7509.812254693567, 7117.89323160153, 7140.500164988401, 7142.4286057115305, 7224.20533741288, 7252.3835473984245, 7051.823704407431, 7069.222385537587, 7202.459815513857, 7210.67551960163, 7308.744193953186, 7083.787486375417, 7114.679839407239, 7125.96437017822, 7180.425565954815, 7201.639918004079, 7124.7150113995895, 7126.251743566851, 7135.536190147727, 7214.422846172293, 7219.494635375579, 5225.712585807817, 5318.308619879391, 5389.595780316414, 5390.51485366311, 5393.0, 4840.951590484121, 4916.0905232532095, 4938.851834444972, 5007.624428167902, 5035.320231768665, 6749.831254218684, 6767.052612634235, 6820.249772525019, 6843.8973415398805, 6853.246142924274, 7099.787006389816, 7185.425165986709, 7246.166690830517, 7282.089738782653, 7299.5620262784405, 6537.771178008747, 6621.768238111643, 6679.165104361955, 6715.966420167965, 6751.527393082535, 6184.721687524072, 6216.720247588869, 6246.3753624637175, 6249.9062514062325, 6255.43701066897, 7258.129024516986, 7483.4013278937555, 7484.101907771103, 7575.734849280248, 7602.277783610548, 7098.3256590623805, 7124.287571243041, 7144.3570078693165, 7145.321194486515, 7211.6033618151505, 7491.213422590549, 7512.173660897406, 7572.204918483701, 7578.545287282781, 7600.049993750781, 7138.607376594337, 7152.213256541881, 7160.176579693402, 7228.385587225145, 7248.383887369632, 6999.965000174967, 7230.927690723025, 7235.131784185932, 7297.306755858185, 7322.1579518356075, 6841.657917104224, 6898.620575868375, 6970.128733908262, 6979.546329488567, 6982.231954485104, 6934.098567186234, 6979.825504362431, 7019.4735394844565, 7026.227115017242, 7031.015657808013, 6859.622720750406, 6877.1747390313485, 6879.346462086094, 6967.79096627102, 6973.686184121828, 6818.454523638196, 6917.619530925646, 7032.050673159058, 7060.435165186876, 7110.1112360954885, 6829.180498340231, 6847.794566163023, 6858.177018757581, 6898.310168983262, 6914.688839002157], "value": 6618.003237937839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [986.4081551069357, 1011.888692243853, 1016.547636301845, 1017.7201269650845, 1022.3456987527983, 45663.0, 46719.29921051187, 46721.0, 46751.5324846751, 46780.0, 42874.785626071825, 43317.35023974643, 43486.565134348646, 43500.56499435005, 43526.56473435264, 8032.759017229478, 8086.272235498804, 8093.797655058612, 8143.552104634243, 8152.918470815305, 7987.400944929153, 8061.4760040597175, 8127.390445716565, 8134.877976830352, 8144.470609410369, 8060.637271322776, 8626.396152269344, 8796.208341249287, 8846.292296616288, 8920.776980575472, 8785.604647790864, 8850.645974161025, 8854.158854908774, 8855.645774169057, 8873.822523549557, 8650.956745216297, 8688.913110868874, 8699.217070463688, 8720.084391138902, 8758.73723788281, 40600.39099413511, 40751.0, 40848.59151408507, 40866.0, 42080.36879446811, 3809.657130858236, 3848.499695039655, 3850.4994350734505, 3860.9420858686863, 3871.3031654302213, 33776.324473510394, 34276.82861585701, 35474.82262588696, 35538.46692299617, 35627.82186089079, 5564.443555644403, 5623.493885550321, 5707.4577915098, 5725.08398656213, 5742.799002034909, 239117.99999999825, 249534.0, 249555.0, 250230.0, 250708.0, 47926.760366197945, 53528.46471535235, 54865.451345486836, 55458.72270638621, 55565.72217138889, 57185.42814571801, 57271.0, 57720.71139644359, 57732.0, 57770.0, 17101.315947362215, 17230.310787568607, 17231.0, 17254.137293135293, 17295.135243237786, 14349.78475322871, 14363.138211707332, 14364.640883977776, 14368.784468232985, 14378.065425747292, 15209.163496007826, 15236.695266094615, 15289.235538223267, 15342.079475231521, 15470.226488675522, 5659.886802264014, 5786.88426231473, 5865.501432378211, 5921.644701317849, 6020.0, 1117.7261570915016, 1128.5542210826677, 1137.5222406589253, 1137.8008848451489, 1138.1975707126455, 26320.473590528083, 26431.735682643313, 26533.469330613665, 26633.0, 26673.33316667099, 1236.6784635994707, 1248.082659245472, 1248.7440074784647, 1257.220523275575, 1271.5295340723992, 13895.861041389659, 13975.79036314456, 13993.440262389595, 14084.859151408355, 14165.433382664578, 284848.0, 285603.0, 286720.0, 286859.0, 286902.0, 59900.40099598948, 60165.0, 60331.69834150801, 60422.0, 60460.395396046355, 1572.300326354784, 1572.5675439254296, 1577.1168145838367, 1595.3060418717894, 1616.3696158498194, 25834.87082564575, 25853.870730646227, 26091.0, 26193.607095893196, 26296.73703262943, 43942.34086488641, 44008.0, 44163.67508974736, 44170.55829441793, 44182.77908610436, 245038.0, 245757.0, 246239.0, 246390.0, 246969.0, 36254.093647657966, 39293.0, 39476.40785388279, 39812.0, 39904.60095399009, 51954.480455194964, 53217.73391133019, 53434.73282633562, 53519.0, 53841.730791347356, 38674.0, 38685.61314386933, 38700.6129938697, 38816.22367552577, 38956.80521597374, 38651.420228697156, 38736.80631596824, 38760.0, 38783.612163878, 38810.223795523365, 44786.55213447824, 44832.775836120614, 45023.774881126694, 45085.0, 45338.319925200485, 34687.0, 35264.647353527165, 35284.64715352814, 35319.82340088283, 35534.46698299476, 27888.0, 28052.158435246976, 28190.71809281881, 28401.857990709916, 28710.856445717636], "value": 19484.222954618872, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.59477124183, 653.8325451129502, 654.6091247338786, 656.4333456186313, 657.6583769111014, 23936.76063239367, 24451.144209952632, 24573.26280211592, 24679.876600617015, 24693.50612987739, 27171.86414067927, 27603.0, 27618.447631047366, 27629.0, 27647.86176069122, 6420.711068001928, 6437.101055188718, 6466.127072845176, 6468.547201695883, 6484.221893372778, 6433.324500927405, 6503.317151699074, 6517.283098859121, 6526.836829079263, 6556.508261880354, 6478.902816457733, 6482.0, 6505.251896031969, 6647.833804154887, 6890.138732658418, 6895.689693963758, 6948.687309071079, 6949.374556289933, 6950.826229344257, 6953.0, 6462.450691691212, 6532.052852336385, 6537.803865884031, 6540.4767618590395, 6540.574862633914, 30576.54135187974, 30702.692973070207, 31176.0, 31205.68794312073, 31227.219319516968, 2321.1179751694417, 2378.1200955646523, 2380.071772008918, 2381.499885024147, 2405.4707964247837, 18749.531261718566, 19086.80913190864, 19114.13986370617, 19119.80880191208, 19127.043647817554, 2569.087973769322, 2621.279148234232, 2670.679518457778, 2677.089789471589, 2685.140754958414, 138807.0, 145429.0, 165214.0, 173362.1331893345, 173367.13316433463, 16261.756073658904, 16281.348746050026, 17146.142692865305, 17227.82772172287, 17338.739918901225, 26952.191434257005, 26955.0, 27004.32489187786, 27017.459650806875, 27162.0, 11271.154663400277, 11453.255538389978, 11487.597934072268, 11574.88425115755, 11805.645830625095, 10440.582376704846, 10463.68608941733, 10677.305975111592, 10701.678949631523, 10781.784364312827, 9874.259430542737, 9962.950185249172, 10078.74803129913, 10148.898511014942, 10285.0, 2909.3956718249456, 2920.6710946519283, 2946.808457450259, 3078.445879741668, 3161.873525059018, 1046.4767616191905, 1067.5516283161091, 1072.5280876414508, 1074.2050882347007, 1080.56777289085, 21248.36254912355, 21545.138194472358, 21604.56790864174, 21746.0, 22028.229011984502, 1124.145649306533, 1129.548180727699, 1131.4399372310759, 1145.2269717940358, 1147.7417581044365, 11852.70368240801, 12071.939640301742, 12103.455344509519, 12162.391880405945, 12414.689632759253, 644546.0, 653436.0, 654568.0, 666627.0, 685350.0, 128202.35898820446, 131724.0, 132619.0, 134557.0, 134572.0, 1151.067635215478, 1192.7554851255472, 1243.620695687806, 1261.2936755416995, 1296.397175313465, 22097.668534971668, 22491.100355985578, 22518.549629007655, 22536.5492690142, 22613.208537701103, 61127.69436152791, 61219.0, 62010.0, 62160.68919655553, 63466.0, 74355.62822185854, 75960.62019689866, 76300.0, 77143.61428192822, 77235.0, 15814.051156930622, 16242.918785405996, 16266.674666506367, 16274.67450651004, 16351.918240408722, 24856.0, 24858.50282994366, 24927.750722492543, 24941.875290624157, 24942.37644058913, 19225.903870480557, 19719.40841774749, 20161.0, 20181.899090504452, 20316.390508284774, 17577.912110439367, 17627.82372176262, 18076.186571604572, 18203.089845507406, 18208.544786380447, 20008.89995550013, 20751.688724669442, 20863.165473380894, 21110.894445527672, 21130.260440884496, 15785.447509337118, 16006.119663418624, 16117.516474505783, 16193.838061619233, 16241.51275461738, 20040.098195581526, 20072.197112115937, 20196.29312974039, 20206.0, 20250.08874600617], "value": 13155.673768691118, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.1323499282933, 1540.0528674864954, 1553.277725857476, 1567.733485307497, 1570.9371625134995, 18457.169427375768, 18860.151293191804, 19010.809891901077, 19039.0, 19042.238310467583, 18451.815481845177, 18519.537011574685, 18539.44381668549, 18649.440516784518, 18673.813261867377, 2800.2159395369276, 2906.229849089993, 2906.3170155013554, 2907.622009138809, 2909.3308539036034, 2784.763295119907, 2887.119428574284, 2890.523063694488, 2898.043645596948, 2899.3911278631513, 2791.3719413131985, 2881.9279518012113, 2889.2343528964734, 2891.4939885520057, 2892.117904039267, 2848.686644469107, 2860.67102283238, 2878.6113874626867, 2879.4672985497646, 2885.8701358438816, 2738.5070687276284, 2767.3081729567607, 2768.1695491352716, 2783.1233161554246, 2788.3726161613677, 17252.56868578283, 17292.56768580783, 17293.567660808454, 17361.565960850952, 17392.826071739248, 8783.868241976375, 9178.219851312646, 9198.218151457135, 9199.218066464358, 9219.078092190794, 6202.658853763041, 6212.099245609361, 6340.429361357454, 6388.201474815648, 6392.2968473468345, 2065.297798748433, 2141.154244073598, 2145.10977944153, 2183.639699449589, 2192.210804110519, 32492.999999999764, 32548.186295342806, 32779.836100819346, 32780.344393112246, 32902.6709732902, 7602.201768814195, 7607.847843043219, 7653.57905315213, 7667.808304792425, 7773.533587984739, 20755.68866467004, 20761.792382075986, 20768.79231207699, 20778.48053798637, 20779.8961005194, 8830.911690883137, 9001.684941027033, 9021.413608115452, 9023.323250756219, 9025.097490250922, 7998.64006119726, 8150.144234855374, 8154.836903261901, 8244.54654993981, 8264.586770661563, 5782.942170578324, 5965.105234214816, 5981.641101533922, 6039.094135879654, 6049.576529642971, 1570.1207323898652, 1650.2326418215587, 1714.3314107498086, 1723.1212081838353, 1766.1875537253009, 1011.4032720694826, 1041.7864337810731, 1052.2634156090767, 1055.9208059395576, 1065.5524679634573, 10332.276740628084, 10403.687889363331, 10529.57881684724, 10689.198310126772, 10692.572297108185, 824.7731873734651, 836.782436566497, 839.6179738219096, 843.9957800210959, 909.9226565741853, 6105.419985101408, 6383.648899310582, 6392.808215753442, 6609.074729537869, 6673.766418175438, 25893.352666183495, 27004.05485807987, 27321.590176147372, 27329.453410932067, 27605.723942760716, 26781.73218267831, 26802.865985670338, 27025.729742702715, 27269.590956135675, 27395.0, 12809.871901281054, 13090.803637945439, 13279.20324780497, 13290.20258784476, 13401.329933503286, 9991.450470224207, 10190.08289253941, 10307.020833020852, 10331.32846364984, 10383.117435018108, 22104.447388814766, 22309.888450557642, 22525.436864077874, 22697.546049079258, 22999.770002299763, 23257.88371058134, 23926.760732392453, 24044.15845445401, 24114.87942560346, 24493.75506244915, 12872.292023938773, 13133.277669727875, 13136.40886160106, 13144.0, 13145.474181032652, 16147.838521615104, 16188.109653969144, 16331.265093071079, 16431.589210269838, 16486.34054637801, 13194.868051319363, 13218.933905330412, 13318.733625327633, 13407.865921341052, 13801.861981380058, 12085.220399308384, 12306.138570299992, 12476.563320283747, 12557.87442125567, 12643.620691379274, 11681.707957301136, 11735.295882247092, 11796.823047654121, 11799.882001179878, 11809.468573914022, 7956.5226086435, 8057.435979481615, 8063.153368896416, 8086.959565202136, 8125.309348705427, 8753.387262891536, 8797.38418310712, 8807.471551706918, 8818.250448711675, 8850.070742571937], "value": 7693.067516311348, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7249161664973, 587.8647910980471, 588.6232811000958, 591.5415552946466, 594.4768603628803, 6507.089007538936, 6575.487637843293, 6585.440237579805, 6640.833979150518, 6659.866802663956, 6398.552101352895, 6424.486041116711, 6436.324185960465, 6504.252011018734, 6608.636524991123, 5329.294625719762, 5398.757055932492, 5418.783248670048, 5424.945750542483, 5435.130379139338, 5109.923351149736, 5346.4118946915805, 5348.224507446418, 5418.810341638044, 5420.24116623673, 5093.414257360396, 5146.897062058757, 5165.527824569998, 5166.844994650148, 5190.4031036430915, 5142.125838607446, 5212.53087222148, 5212.791488340462, 5223.817166399177, 5231.607629427808, 4706.482286948433, 4712.2224832902875, 4718.363020992157, 4719.480857105716, 4756.191447453941, 6356.968215158895, 6372.330905254974, 6428.292887782341, 6429.935700642981, 6459.61242325462, 6120.0, 6145.4161854623735, 6151.200343955302, 6202.534809889276, 6212.949726590215, 6863.691133898987, 6897.068895699117, 6905.413039891615, 6918.1698196216275, 6957.65211739411, 5284.969430960964, 5292.444293349181, 5312.203169524563, 5319.6808191508635, 5321.1752178412025, 6961.338672826073, 7050.285640028575, 7211.134663840373, 7235.746748863817, 7261.673224704901, 5381.9461805382225, 5418.431064738224, 5421.566274698014, 5434.10337294342, 5442.2108794225405, 5452.672839629635, 5467.988422141916, 5481.369642491085, 5523.972380138154, 5561.443855614487, 6062.727177277033, 6111.786087487006, 6112.969435152885, 6113.969430152821, 6122.234720659918, 6968.163820341591, 6986.4061554767395, 7001.894971575431, 7016.614351120644, 7032.085828842218, 1898.3450709505198, 1898.6107847891149, 1912.4453908366418, 1914.5787926656114, 1915.4445210888964, 1273.9235046873537, 1303.2766814417898, 1330.82699249097, 1342.64392963106, 1355.9322033898266, 6445.645489498029, 6495.902561461582, 6526.0, 6528.51036172289, 6549.312322206099, 6907.481938854606, 6966.860662786818, 7062.223155452896, 7074.0, 7085.716571337089, 6540.117084193573, 6586.473082153416, 6592.736290548324, 6616.239132499824, 6619.106420633249, 3709.091272638167, 3740.251949610089, 3760.8972597607085, 3799.3351163546267, 3800.7149463790324, 7204.4956853019785, 7270.9636451817405, 7290.526115802562, 7302.233265507151, 7361.190269070398, 7131.536450130725, 7202.315780000891, 7286.344229019413, 7304.306090921354, 7367.373773229228, 7291.833306670907, 7340.853182936311, 7452.813679657944, 7466.328030477174, 7467.087835743955, 6996.6151861648095, 7010.334018268256, 7091.432685385053, 7105.360517553445, 7148.749793757193, 6933.237343892067, 6957.75647852343, 6961.89557156633, 6964.756233531802, 6965.268646792217, 7119.82200444993, 7209.963950180216, 7255.274472552703, 7296.160941491584, 7347.55914645123, 5417.485338892799, 5448.509634132947, 5464.153056276284, 5490.945090549043, 5518.172274158908, 6872.0, 7041.471889608198, 7086.362227399559, 7130.180029296697, 7189.640517974185, 6664.467832049022, 6772.814757417334, 6774.0, 6787.083743694538, 6885.036094946811, 6690.264070952094, 6695.397414232742, 6834.658267086526, 6841.17905851301, 6872.144520979207, 6625.734970601122, 6633.436157926437, 6633.568818026813, 6657.167854018247, 6711.328867113445, 6824.93175068243, 6922.988500002515, 6957.9215221640725, 6983.2318444972025, 7003.96498017527, 6618.801435956929, 6693.866122677617, 6802.489813263926, 6809.718744220543, 6853.965730171317], "value": 5419.578434363738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1004.8392257238843, 1011.9291649584527, 1020.3724709303776, 1043.577351172775, 1050.758325585115, 20006.399808005746, 20074.598508029867, 20177.09203085861, 21802.563948721017, 22390.776092239073, 20041.398758037245, 20231.291904783335, 20304.0, 20315.796842031574, 20327.186912523517, 1087.374759513279, 1087.4943151434582, 1092.6667366453228, 1099.4612639806496, 1100.02098132662, 1103.7351035751442, 1104.0119093411392, 1104.9558017679283, 1105.5909313553957, 1107.3134656512932, 1100.114407901639, 1137.9886201137965, 1143.2054721968236, 1145.7250259937596, 1146.776378606172, 1139.8746137924904, 1139.9943000284986, 1141.3209140561435, 1144.5536240866027, 1151.067635215478, 834.9582520873932, 835.0563862834957, 838.2916435611959, 839.2572573272637, 840.2143995364293, 21708.348749537538, 21743.0, 22402.88798556013, 22708.545829083327, 22709.77290227093, 23398.298051058326, 23717.169899053624, 23768.524629507487, 24325.635115473284, 24344.756552434425, 19645.607087858163, 19646.312379066807, 19804.80195198044, 19806.70289945652, 19934.900325498278, 3798.905027374338, 3839.2321535692695, 3846.442265871461, 3872.1481274119647, 3879.592642772525, 128862.0, 148912.0, 162808.0, 162856.0, 166814.1659291708, 19350.8064919349, 19389.8061019388, 19513.609727805648, 19870.503237418892, 19883.701744473845, 35590.46614300788, 35623.28753424917, 35782.0, 35924.820375898475, 36086.278274434364, 10662.680119596425, 10687.25189236746, 10691.518881650189, 10705.197110216764, 10709.839352409721, 5037.722925239147, 5072.923906141411, 5074.188129899198, 5148.021875843652, 5154.329937108152, 5963.224780778471, 6010.308814486302, 6074.787382441594, 6075.2405949256345, 6082.452579267887, 1242.782513060229, 1298.4157129291857, 1302.446460254407, 1307.4966138036925, 1312.3962977030674, 753.4537460341319, 770.0874463760462, 774.5275382016965, 779.4426984705849, 789.06889869954, 12775.936120319338, 12949.352532373343, 14235.85764142366, 15647.452339168301, 15758.369665213264, 723.2984005514747, 751.537804250393, 751.7342946540537, 759.1535437986605, 760.2093822424616, 6686.699098540577, 6687.264400915896, 6712.328767123347, 6764.3573860483175, 6770.289119642465, 146853.26573367277, 148671.0, 148877.0, 150491.0, 153946.0, 103847.4807625957, 106305.0, 131467.0, 139608.0, 144025.0, 103925.48037259765, 105110.0, 106740.46629766801, 109032.45483772531, 109292.4535377334, 14198.361073751912, 14708.191049492381, 14816.185109818633, 15022.549323520312, 15269.236538173269, 56595.434045659014, 57650.711746441, 57913.71043144757, 58072.709636451546, 58166.12750808826, 98509.0, 103867.0, 104304.0, 104750.0, 104757.0, 21054.368368948955, 21588.46028849291, 21634.567308653423, 21804.563908722055, 21904.45238869041, 24744.752552474245, 24754.628680569447, 24860.627090593294, 24954.251372458857, 25202.36994075163, 22074.006669699582, 22602.886985565623, 22659.320220393416, 22951.081956721544, 22978.540429191657, 21165.894170529664, 21318.360449186548, 21397.358079257647, 21399.144034238456, 21537.676934846302, 22230.999605018136, 22609.208677696202, 22625.321240362817, 22650.207242746426, 22743.88628056849, 16199.838001620305, 16287.348506059625, 16537.421190258283, 16670.24983875753, 16749.74875376846, 16092.195390230676, 16185.433509827571, 16222.675546488768, 16294.511164665078, 16502.587435314214], "value": 10810.095678115318, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1360.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 105.0, 104.0, 105.0, 104.0, 107.0, 105.0, 104.0, 105.0, 104.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 120.0, 110.0, 113.0, 139.0, 109.0, 114.0, 115.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 72.0, 72.0, 77.0, 76.0, 75.0, 74.0, 72.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 81.0, 83.0, 85.0, 77.0, 78.0, 76.0, 75.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 109.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 148.0, 162.0, 149.0, 148.0, 149.0, 149.0, 148.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 93.0, 94.0, 93.0, 94.0, 94.0, 96.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 45.0, 50.0, 42.0, 44.0, 42.0, 44.0, 42.0, 42.0, 43.0], "value": 44.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 37.0, 37.0, 38.0, 37.0, 38.0, 43.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 77.0, 69.0, 68.0, 74.0, 69.0, 69.0, 74.0, 69.0, 66.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 98.0, 101.0, 104.0, 109.0, 103.0, 114.0, 98.0, 120.0], "value": 105.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 152.0, 148.0, 151.0, 156.0, 160.0, 149.0, 156.0, 151.0, 153.0], "value": 152.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 58.0, 60.0, 55.0, 57.0, 58.0, 63.0, 59.0], "value": 58.2, "unit": "score"}]}]} 08:18:30 INFO - Return code: 0 08:18:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:18:30 INFO - # TBPL SUCCESS # 08:18:30 INFO - Running post-action listener: _package_coverage_data 08:18:30 INFO - Running post-action listener: _resource_record_post_action 08:18:30 INFO - [mozharness: 2017-10-24 15:18:30.472468Z] Finished run-tests step (success) 08:18:30 INFO - Running post-run listener: _resource_record_post_run 08:18:30 INFO - Total resource usage - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290631680; Read time: 16; Write time: 189012 08:18:30 INFO - TinderboxPrint: CPU usage
13.1% 08:18:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:18:30 INFO - TinderboxPrint: I/O write bytes / time
290,631,680 / 189,012 08:18:30 INFO - TinderboxPrint: CPU idle
8,172.8 (86.9%) 08:18:30 INFO - TinderboxPrint: CPU user
1,179.0 (12.5%) 08:18:30 INFO - TinderboxPrint: Swap in / out
0 / 0 08:18:30 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9134080; Read time: 0; Write time: 1276 08:18:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:18:30 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 0; Write bytes: 280952832; Read time: 0; Write time: 187576 08:18:31 INFO - Running post-run listener: _upload_blobber_files 08:18:31 INFO - Blob upload gear active. 08:18:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:31 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 08:18:31 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', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:18:31 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 Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:18:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:18:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:32 INFO - (blobuploader) - INFO - Done attempting. 08:18:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:18:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:39 INFO - (blobuploader) - INFO - Done attempting. 08:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:40 INFO - (blobuploader) - INFO - Done attempting. 08:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:41 INFO - (blobuploader) - INFO - Done attempting. 08:18:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:41 INFO - Return code: 0 08:18:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b448a093c28040de33a4b9e86e6bfac04b338405892bd3fe75a00a9b9225ab844388fff9cec2475df086e6fad06af1e75fc444e0c5ebf809239a9089753fc35f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/465cf19490c065128bf2f9424f472a6aea8f1befe0bb495bd6b32ba34a08f7b4eeedcbec9bfefec7acfb8afa822c7e554304a9622bf3b9912759bcc3bba50adb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7c43eb506922ede732472dd68d8a2c90e8ffde6be9b47d125cc3e7b8ec36a33ef88f1ad1ab634c685bb8a3a29b14adc781aa605bc6429b5cee6322bf6a5150cf", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bcb525705ee19eec11595f2db44f94f5259f5af92ce60cb3caa1034ff83dd95d253984693b3a4aa0f5f8121deae90d25eaaf9a0fc43e5b5ae74a1930d1b55914"} 08:18:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:41 INFO - Contents: 08:18:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b448a093c28040de33a4b9e86e6bfac04b338405892bd3fe75a00a9b9225ab844388fff9cec2475df086e6fad06af1e75fc444e0c5ebf809239a9089753fc35f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/465cf19490c065128bf2f9424f472a6aea8f1befe0bb495bd6b32ba34a08f7b4eeedcbec9bfefec7acfb8afa822c7e554304a9622bf3b9912759bcc3bba50adb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7c43eb506922ede732472dd68d8a2c90e8ffde6be9b47d125cc3e7b8ec36a33ef88f1ad1ab634c685bb8a3a29b14adc781aa605bc6429b5cee6322bf6a5150cf", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bcb525705ee19eec11595f2db44f94f5259f5af92ce60cb3caa1034ff83dd95d253984693b3a4aa0f5f8121deae90d25eaaf9a0fc43e5b5ae74a1930d1b55914"} 08:18:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:41 INFO - Copying logs to upload dir... 08:18:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.314480 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-10-24 08:18:41.149923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 08:18:41.155183) ========= 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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b448a093c28040de33a4b9e86e6bfac04b338405892bd3fe75a00a9b9225ab844388fff9cec2475df086e6fad06af1e75fc444e0c5ebf809239a9089753fc35f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/465cf19490c065128bf2f9424f472a6aea8f1befe0bb495bd6b32ba34a08f7b4eeedcbec9bfefec7acfb8afa822c7e554304a9622bf3b9912759bcc3bba50adb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7c43eb506922ede732472dd68d8a2c90e8ffde6be9b47d125cc3e7b8ec36a33ef88f1ad1ab634c685bb8a3a29b14adc781aa605bc6429b5cee6322bf6a5150cf", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bcb525705ee19eec11595f2db44f94f5259f5af92ce60cb3caa1034ff83dd95d253984693b3a4aa0f5f8121deae90d25eaaf9a0fc43e5b5ae74a1930d1b55914"} build_url:https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/V6YglzPlQzGg6x2Q8QynfQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/b448a093c28040de33a4b9e86e6bfac04b338405892bd3fe75a00a9b9225ab844388fff9cec2475df086e6fad06af1e75fc444e0c5ebf809239a9089753fc35f", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/465cf19490c065128bf2f9424f472a6aea8f1befe0bb495bd6b32ba34a08f7b4eeedcbec9bfefec7acfb8afa822c7e554304a9622bf3b9912759bcc3bba50adb", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/7c43eb506922ede732472dd68d8a2c90e8ffde6be9b47d125cc3e7b8ec36a33ef88f1ad1ab634c685bb8a3a29b14adc781aa605bc6429b5cee6322bf6a5150cf", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/bcb525705ee19eec11595f2db44f94f5259f5af92ce60cb3caa1034ff83dd95d253984693b3a4aa0f5f8121deae90d25eaaf9a0fc43e5b5ae74a1930d1b55914"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-24 08:18:41.190551) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:18:41.190962) ========= 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=ed14279e38b05397cf4aa391000001a4-1508856246.286996-904903618 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-24 08:18:41.273109) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 08:18:41.273503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-24 08:18:41.274008) ========= ========= Total master_lag: 0.30 =========