builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-022 starttime: 1505599799.3 results: success (0) revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.300055) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.300486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.301055) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.353379) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.353765) ========= 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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-16 15:09:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 99.6M=0s 2017-09-16 15:09:59 (99.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151485 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.543189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.543497) ========= 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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.592432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:09:59.595829) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 --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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-16 15:09:59,653 truncating revision to first 12 chars 2017-09-16 15:09:59,654 Setting DEBUG logging. 2017-09-16 15:09:59,654 attempt 1/10 2017-09-16 15:09:59,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45b63125a430?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-16 15:09:59,907 unpacking tar archive at: mozilla-central-45b63125a430/testing/mozharness/ program finished with exit code 0 elapsedTime=0.519282 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:10:00.131004) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 15:10:00.131334) ========= script_repo_revision: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-16 15:10:00.131724) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 15:10:00.132005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-16 15:10:00.145775) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 15:10:00.146100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:10:00 INFO - MultiFileLogger online at 20170916 15:10:00 in /builds/slave/test 15:10:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 15:10:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:10:00 INFO - {'append_to_log': False, 15:10:00 INFO - 'base_work_dir': '/builds/slave/test', 15:10:00 INFO - 'blob_upload_branch': 'Firefox', 15:10:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:10:00 INFO - 'branch': 'Firefox', 15:10:00 INFO - 'buildbot_json_path': 'buildprops.json', 15:10:00 INFO - 'code_coverage': False, 15:10:00 INFO - 'config_files': ('talos/linux_config.py',), 15:10:00 INFO - 'default_actions': ('clobber', 15:10:00 INFO - 'read-buildbot-config', 15:10:00 INFO - 'download-and-extract', 15:10:00 INFO - 'populate-webroot', 15:10:00 INFO - 'create-virtualenv', 15:10:00 INFO - 'install', 15:10:00 INFO - 'setup-mitmproxy', 15:10:00 INFO - 'run-tests'), 15:10:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:10:00 INFO - 'disable_ccov_upload': False, 15:10:00 INFO - 'disable_stylo': False, 15:10:00 INFO - 'download_minidump_stackwalk': True, 15:10:00 INFO - 'download_symbols': 'ondemand', 15:10:00 INFO - 'enable_stylo': False, 15:10:00 INFO - 'enable_webrender': False, 15:10:00 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 15:10:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:10:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:10:00 INFO - 'gecko_profile': False, 15:10:00 INFO - 'gecko_profile_interval': 0, 15:10:00 INFO - 'installer_path': 'installer.exe', 15:10:00 INFO - 'log_level': 'info', 15:10:00 INFO - 'log_name': 'talos', 15:10:00 INFO - 'log_to_console': True, 15:10:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:10:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:10:00 INFO - 'opt_config_files': (), 15:10:00 INFO - 'pip_index': False, 15:10:00 INFO - 'suite': 'dromaeojs-e10s', 15:10:00 INFO - 'system_bits': '32', 15:10:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:10:00 INFO - 'title': 'talos-linux64-ix-022', 15:10:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:10:00 INFO - 'use_talos_json': True, 15:10:00 INFO - 'verify': 'False', 15:10:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:10:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:10:00 INFO - 'work_dir': 'build'} 15:10:00 INFO - [mozharness: 2017-09-16 22:10:00.433969Z] Running clobber step. 15:10:00 INFO - Running pre-action listener: _resource_record_pre_action 15:10:00 INFO - Running main action method: clobber 15:10:00 INFO - rmtree: /builds/slave/test/build 15:10:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:10:01 INFO - Running post-action listener: _resource_record_post_action 15:10:01 INFO - [mozharness: 2017-09-16 22:10:01.377477Z] Finished clobber step (success) 15:10:01 INFO - [mozharness: 2017-09-16 22:10:01.377574Z] Running read-buildbot-config step. 15:10:01 INFO - Running pre-action listener: _resource_record_pre_action 15:10:01 INFO - Running main action method: read_buildbot_config 15:10:01 INFO - Using buildbot properties: 15:10:01 INFO - { 15:10:01 INFO - "project": "", 15:10:01 INFO - "product": "firefox", 15:10:01 INFO - "who": "ryanvm@gmail.com", 15:10:01 INFO - "installer_path": "public/build/target.tar.bz2", 15:10:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:10:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:10:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:10:01 INFO - "stage_platform": "linux64-pgo", 15:10:01 INFO - "basedir": "/builds/slave/test", 15:10:01 INFO - "buildnumber": 190, 15:10:01 INFO - "platform": "ubuntu64_hw", 15:10:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:10:01 INFO - "slavebuilddir": "test", 15:10:01 INFO - "taskId": "JcvKjjfcTVSdu8UWFMe1JQ", 15:10:01 INFO - "branch": "mozilla-central", 15:10:01 INFO - "script_repo_revision": "production", 15:10:01 INFO - "revision": "45b63125a4301eb89e7a4d70d0da1c650f11c7e4", 15:10:01 INFO - "slavename": "talos-linux64-ix-022", 15:10:01 INFO - "repo_path": "mozilla-central" 15:10:01 INFO - } 15:10:01 INFO - Finding installer, test and symbols from parent task. 15:10:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcvKjjfcTVSdu8UWFMe1JQ'}, attempt #1 15:10:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JcvKjjfcTVSdu8UWFMe1JQ'}, attempt #1 15:10:02 INFO - Task dependencies: TunYm-W5SkGt7UspvBxWuA 15:10:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA'}, attempt #1 15:10:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 15:10:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.test_packages.json 15:10:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.crashreporter-symbols.zip 15:10:02 INFO - Running post-action listener: _resource_record_post_action 15:10:02 INFO - [mozharness: 2017-09-16 22:10:02.785641Z] Finished read-buildbot-config step (success) 15:10:02 INFO - [mozharness: 2017-09-16 22:10:02.785864Z] Running download-and-extract step. 15:10:02 INFO - Running pre-action listener: _resource_record_pre_action 15:10:02 INFO - Running main action method: download_and_extract 15:10:02 INFO - mkdir: /builds/slave/test/build/tests 15:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:02 INFO - trying https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.test_packages.json 15:10:02 INFO - Downloading https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:10:03 INFO - Downloaded 989 bytes. 15:10:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:10:03 INFO - Using the following test package requirements: 15:10:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:10:03 INFO - u'common': [u'target.common.tests.zip'], 15:10:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:10:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:10:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:10:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:10:03 INFO - u'mozbase': [u'target.common.tests.zip'], 15:10:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:10:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:10:03 INFO - u'web-platform': [u'target.common.tests.zip', 15:10:03 INFO - u'target.web-platform.tests.tar.gz'], 15:10:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:10:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 15:10:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.common.tests.zip 15:10:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:10:03 INFO - Fetch https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.common.tests.zip into memory 15:10:04 INFO - Content-Length response header: 55322110 15:10:04 INFO - Bytes received: 55322110 15:10:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.talos.tests.zip 15:10:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:10:15 INFO - Fetch https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.talos.tests.zip into memory 15:10:16 INFO - Content-Length response header: 14508748 15:10:16 INFO - Bytes received: 14508748 15:10:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:16 INFO - trying https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 15:10:16 INFO - Downloading https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:10:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:10:17 INFO - Downloaded 62176091 bytes. 15:10:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 15:10:17 INFO - mkdir: /builds/slave/test/properties 15:10:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:10:17 INFO - Writing to file /builds/slave/test/properties/build_url 15:10:17 INFO - Contents: 15:10:17 INFO - build_url:https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 15:10:17 INFO - Running post-action listener: _resource_record_post_action 15:10:17 INFO - Running post-action listener: find_tests_for_verification 15:10:17 INFO - Running post-action listener: set_extra_try_arguments 15:10:17 INFO - [mozharness: 2017-09-16 22:10:17.459984Z] Finished download-and-extract step (success) 15:10:17 INFO - [mozharness: 2017-09-16 22:10:17.460083Z] Running populate-webroot step. 15:10:17 INFO - Running pre-action listener: _resource_record_pre_action 15:10:17 INFO - Running main action method: populate_webroot 15:10:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:10:17 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['tresize', 15:10:17 INFO - 'tcanvasmark']}, 15:10:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:10:17 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['dromaeo_css', 15:10:17 INFO - 'kraken']}, 15:10:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:17 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:10:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'tests': ['damp', 'tps']}, 15:10:17 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['damp', 'tps']}, 15:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:10:17 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['dromaeo_dom']}, 15:10:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:10:17 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['basic_compositor_video', 15:10:17 INFO - 'glvideo']}, 15:10:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:10:17 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['ts_paint_webext', 15:10:17 INFO - 'tp5o_webext']}, 15:10:17 INFO - 'other-e10s': {'tests': ['a11yr', 15:10:17 INFO - 'ts_paint', 15:10:17 INFO - 'tpaint', 15:10:17 INFO - 'sessionrestore', 15:10:17 INFO - 'sessionrestore_many_windows', 15:10:17 INFO - 'sessionrestore_no_auto_restore', 15:10:17 INFO - 'tabpaint']}, 15:10:17 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['a11yr', 15:10:17 INFO - 'ts_paint', 15:10:17 INFO - 'tpaint', 15:10:17 INFO - 'sessionrestore', 15:10:17 INFO - 'sessionrestore_many_windows', 15:10:17 INFO - 'sessionrestore_no_auto_restore', 15:10:17 INFO - 'tabpaint']}, 15:10:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:10:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 15:10:17 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['perf_reftest_singletons']}, 15:10:17 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['bloom_basic']}, 15:10:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:10:17 INFO - 'tsvgr_opacity', 15:10:17 INFO - 'tart', 15:10:17 INFO - 'tscrollx', 15:10:17 INFO - 'tsvg_static']}, 15:10:17 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['tsvgx', 15:10:17 INFO - 'tsvgr_opacity', 15:10:17 INFO - 'tart', 15:10:17 INFO - 'tscrollx', 15:10:17 INFO - 'tsvg_static']}, 15:10:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:10:17 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo'], 15:10:17 INFO - 'tests': ['tp5o']}, 15:10:17 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:17 INFO - 'talos_options': ['--mitmproxy', 15:10:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:17 INFO - '--firstNonBlankPaint'], 15:10:17 INFO - 'tests': ['tp6_google', 15:10:17 INFO - 'tp6_youtube', 15:10:17 INFO - 'tp6_amazon', 15:10:17 INFO - 'tp6_facebook']}, 15:10:17 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo', 15:10:17 INFO - '--mitmproxy', 15:10:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:17 INFO - '--firstNonBlankPaint'], 15:10:17 INFO - 'tests': ['tp6_google', 15:10:17 INFO - 'tp6_youtube', 15:10:17 INFO - 'tp6_amazon', 15:10:17 INFO - 'tp6_facebook']}, 15:10:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:10:17 INFO - 'talos_options': ['--stylo-threads=1', 15:10:17 INFO - '--mitmproxy', 15:10:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:10:17 INFO - '--firstNonBlankPaint'], 15:10:17 INFO - 'tests': ['tp6_google', 15:10:17 INFO - 'tp6_youtube', 15:10:17 INFO - 'tp6_amazon', 15:10:17 INFO - 'tp6_facebook']}, 15:10:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--xperf_path', 15:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:17 INFO - 'tests': ['tp5n']}, 15:10:17 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 15:10:17 INFO - 'talos_options': ['--disable-stylo', 15:10:17 INFO - '--xperf_path', 15:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:10:17 INFO - 'tests': ['tp5n']}}} 15:10:17 INFO - Running post-action listener: _resource_record_post_action 15:10:17 INFO - [mozharness: 2017-09-16 22:10:17.474962Z] Finished populate-webroot step (success) 15:10:17 INFO - [mozharness: 2017-09-16 22:10:17.475051Z] Running create-virtualenv step. 15:10:17 INFO - Running pre-action listener: _resource_record_pre_action 15:10:17 INFO - Running main action method: create_virtualenv 15:10:17 INFO - Creating virtualenv /builds/slave/test/build/venv 15:10:17 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:10:17 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 15:10:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:10:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:10:18 INFO - Installing distribute.............................................................................................................................................................................................done. 15:10:18 INFO - Installing pip...............done. 15:10:18 INFO - Return code: 0 15:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:10:18 INFO - Reading from file tmpfile_stdout 15:10:18 INFO - Output received: 15:10:18 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 15:10:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:18 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:10:18 INFO - Using env: {'DISPLAY': ':0', 15:10:18 INFO - 'HOME': '/home/cltbld', 15:10:18 INFO - 'LANG': 'en_US.UTF-8', 15:10:18 INFO - 'LANGUAGE': 'en_US:en', 15:10:18 INFO - 'LOGNAME': 'cltbld', 15:10:18 INFO - 'MAIL': '/var/mail/cltbld', 15:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:18 INFO - 'MOZ_NO_REMOTE': '1', 15:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:18 INFO - 'NO_EM_RESTART': '1', 15:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:18 INFO - 'PWD': '/builds/slave/test', 15:10:18 INFO - 'SHELL': '/bin/bash', 15:10:18 INFO - 'SHLVL': '1', 15:10:18 INFO - 'TERM': 'linux', 15:10:18 INFO - 'TMOUT': '86400', 15:10:18 INFO - 'USER': 'cltbld', 15:10:18 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:18 INFO - '_': '/tools/buildbot/bin/python'} 15:10:19 INFO - Ignoring indexes: http://pypi.python.org/simple/ 15:10:19 INFO - Downloading/unpacking pip>=1.5 15:10:19 INFO - Running setup.py egg_info for package pip 15:10:19 INFO - warning: no files found matching 'pip/cacert.pem' 15:10:20 INFO - warning: no files found matching '*.html' under directory 'docs' 15:10:20 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:10:20 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:10:20 INFO - Installing collected packages: pip 15:10:20 INFO - Found existing installation: pip 1.1 15:10:20 INFO - Uninstalling pip: 15:10:20 INFO - Successfully uninstalled pip 15:10:20 INFO - Running setup.py install for pip 15:10:20 INFO - warning: no files found matching 'pip/cacert.pem' 15:10:20 INFO - warning: no files found matching '*.html' under directory 'docs' 15:10:20 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 15:10:20 INFO - no previously-included directories found matching 'docs/_build/_sources' 15:10:20 INFO - Installing pip script to /builds/slave/test/build/venv/bin 15:10:20 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 15:10:20 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 15:10:20 INFO - Successfully installed pip 15:10:20 INFO - Cleaning up... 15:10:20 INFO - Return code: 0 15:10:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:20 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:10:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:10:20 INFO - Using env: {'DISPLAY': ':0', 15:10:20 INFO - 'HOME': '/home/cltbld', 15:10:20 INFO - 'LANG': 'en_US.UTF-8', 15:10:20 INFO - 'LANGUAGE': 'en_US:en', 15:10:20 INFO - 'LOGNAME': 'cltbld', 15:10:20 INFO - 'MAIL': '/var/mail/cltbld', 15:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:20 INFO - 'MOZ_NO_REMOTE': '1', 15:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:20 INFO - 'NO_EM_RESTART': '1', 15:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:20 INFO - 'PWD': '/builds/slave/test', 15:10:20 INFO - 'SHELL': '/bin/bash', 15:10:20 INFO - 'SHLVL': '1', 15:10:20 INFO - 'TERM': 'linux', 15:10:20 INFO - 'TMOUT': '86400', 15:10:20 INFO - 'USER': 'cltbld', 15:10:20 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:20 INFO - '_': '/tools/buildbot/bin/python'} 15:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:20 INFO - Downloading/unpacking psutil>=3.1.1 15:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:10:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:21 INFO - Installing collected packages: psutil 15:10:21 INFO - Running setup.py install for psutil 15:10:21 INFO - building 'psutil._psutil_linux' extension 15:10:21 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:10:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:10:22 INFO - building 'psutil._psutil_posix' extension 15:10:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:10:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:10:22 INFO - Successfully installed psutil 15:10:22 INFO - Cleaning up... 15:10:22 INFO - Return code: 0 15:10:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:22 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:10:22 INFO - Using env: {'DISPLAY': ':0', 15:10:22 INFO - 'HOME': '/home/cltbld', 15:10:22 INFO - 'LANG': 'en_US.UTF-8', 15:10:22 INFO - 'LANGUAGE': 'en_US:en', 15:10:22 INFO - 'LOGNAME': 'cltbld', 15:10:22 INFO - 'MAIL': '/var/mail/cltbld', 15:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:22 INFO - 'MOZ_NO_REMOTE': '1', 15:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:22 INFO - 'NO_EM_RESTART': '1', 15:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:22 INFO - 'PWD': '/builds/slave/test', 15:10:22 INFO - 'SHELL': '/bin/bash', 15:10:22 INFO - 'SHLVL': '1', 15:10:22 INFO - 'TERM': 'linux', 15:10:22 INFO - 'TMOUT': '86400', 15:10:22 INFO - 'USER': 'cltbld', 15:10:22 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:22 INFO - '_': '/tools/buildbot/bin/python'} 15:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:10:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:10:25 INFO - Installing collected packages: mozsystemmonitor 15:10:25 INFO - Running setup.py install for mozsystemmonitor 15:10:25 INFO - Successfully installed mozsystemmonitor 15:10:25 INFO - Cleaning up... 15:10:25 INFO - Return code: 0 15:10:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:25 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:10:25 INFO - Using env: {'DISPLAY': ':0', 15:10:25 INFO - 'HOME': '/home/cltbld', 15:10:25 INFO - 'LANG': 'en_US.UTF-8', 15:10:25 INFO - 'LANGUAGE': 'en_US:en', 15:10:25 INFO - 'LOGNAME': 'cltbld', 15:10:25 INFO - 'MAIL': '/var/mail/cltbld', 15:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:25 INFO - 'MOZ_NO_REMOTE': '1', 15:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:25 INFO - 'NO_EM_RESTART': '1', 15:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:25 INFO - 'PWD': '/builds/slave/test', 15:10:25 INFO - 'SHELL': '/bin/bash', 15:10:25 INFO - 'SHLVL': '1', 15:10:25 INFO - 'TERM': 'linux', 15:10:25 INFO - 'TMOUT': '86400', 15:10:25 INFO - 'USER': 'cltbld', 15:10:25 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:25 INFO - '_': '/tools/buildbot/bin/python'} 15:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:25 INFO - Downloading/unpacking jsonschema==2.5.1 15:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:10:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:10:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:10:26 INFO - warning: no files found matching '*.txt' 15:10:26 INFO - no previously-included directories found matching 'build' 15:10:26 INFO - no previously-included directories found matching 'dist' 15:10:26 INFO - no previously-included directories found matching '.git*' 15:10:26 INFO - Installing collected packages: jsonschema, functools32 15:10:26 INFO - Running setup.py install for functools32 15:10:26 INFO - warning: no files found matching '*.txt' 15:10:26 INFO - no previously-included directories found matching 'build' 15:10:26 INFO - no previously-included directories found matching 'dist' 15:10:26 INFO - no previously-included directories found matching '.git*' 15:10:26 INFO - Successfully installed jsonschema functools32 15:10:26 INFO - Cleaning up... 15:10:26 INFO - Return code: 0 15:10:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:26 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:10:27 INFO - Using env: {'DISPLAY': ':0', 15:10:27 INFO - 'HOME': '/home/cltbld', 15:10:27 INFO - 'LANG': 'en_US.UTF-8', 15:10:27 INFO - 'LANGUAGE': 'en_US:en', 15:10:27 INFO - 'LOGNAME': 'cltbld', 15:10:27 INFO - 'MAIL': '/var/mail/cltbld', 15:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:27 INFO - 'MOZ_NO_REMOTE': '1', 15:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:27 INFO - 'NO_EM_RESTART': '1', 15:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:27 INFO - 'PWD': '/builds/slave/test', 15:10:27 INFO - 'SHELL': '/bin/bash', 15:10:27 INFO - 'SHLVL': '1', 15:10:27 INFO - 'TERM': 'linux', 15:10:27 INFO - 'TMOUT': '86400', 15:10:27 INFO - 'USER': 'cltbld', 15:10:27 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:27 INFO - '_': '/tools/buildbot/bin/python'} 15:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:10:27 INFO - Cleaning up... 15:10:27 INFO - Return code: 0 15:10:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10: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')]} 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:27 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:10:27 INFO - Using env: {'DISPLAY': ':0', 15:10:27 INFO - 'HOME': '/home/cltbld', 15:10:27 INFO - 'LANG': 'en_US.UTF-8', 15:10:27 INFO - 'LANGUAGE': 'en_US:en', 15:10:27 INFO - 'LOGNAME': 'cltbld', 15:10:27 INFO - 'MAIL': '/var/mail/cltbld', 15:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:27 INFO - 'MOZ_NO_REMOTE': '1', 15:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:27 INFO - 'NO_EM_RESTART': '1', 15:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:27 INFO - 'PWD': '/builds/slave/test', 15:10:27 INFO - 'SHELL': '/bin/bash', 15:10:27 INFO - 'SHLVL': '1', 15:10:27 INFO - 'TERM': 'linux', 15:10:27 INFO - 'TMOUT': '86400', 15:10:27 INFO - 'USER': 'cltbld', 15:10:27 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:27 INFO - '_': '/tools/buildbot/bin/python'} 15:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:27 INFO - Downloading/unpacking blobuploader==1.2.4 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:28 INFO - Downloading blobuploader-1.2.4.tar.gz 15:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:10:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:10:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:29 INFO - Downloading docopt-0.6.1.tar.gz 15:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:10:29 INFO - Installing collected packages: blobuploader, requests, docopt 15:10:29 INFO - Running setup.py install for blobuploader 15:10:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:10:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:10:29 INFO - Running setup.py install for requests 15:10:29 INFO - Running setup.py install for docopt 15:10:29 INFO - Successfully installed blobuploader requests docopt 15:10:29 INFO - Cleaning up... 15:10:29 INFO - Return code: 0 15:10:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:29 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:10:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:10:29 INFO - Using env: {'DISPLAY': ':0', 15:10:29 INFO - 'HOME': '/home/cltbld', 15:10:29 INFO - 'LANG': 'en_US.UTF-8', 15:10:29 INFO - 'LANGUAGE': 'en_US:en', 15:10:29 INFO - 'LOGNAME': 'cltbld', 15:10:29 INFO - 'MAIL': '/var/mail/cltbld', 15:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:29 INFO - 'MOZ_NO_REMOTE': '1', 15:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:29 INFO - 'NO_EM_RESTART': '1', 15:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:29 INFO - 'PWD': '/builds/slave/test', 15:10:29 INFO - 'SHELL': '/bin/bash', 15:10:29 INFO - 'SHLVL': '1', 15:10:29 INFO - 'TERM': 'linux', 15:10:29 INFO - 'TMOUT': '86400', 15:10:29 INFO - 'USER': 'cltbld', 15:10:29 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:29 INFO - '_': '/tools/buildbot/bin/python'} 15:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:29 INFO - Running setup.py (path:/tmp/pip-L8hMwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:29 INFO - Running setup.py (path:/tmp/pip-CaLKW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:30 INFO - Running setup.py (path:/tmp/pip-UaRsMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:30 INFO - Running setup.py (path:/tmp/pip-itQIe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:30 INFO - Running setup.py (path:/tmp/pip-2R27FK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:30 INFO - Running setup.py (path:/tmp/pip-QEXWEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:30 INFO - Running setup.py (path:/tmp/pip-L2N43T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:30 INFO - Running setup.py (path:/tmp/pip-62Rg5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:30 INFO - Running setup.py (path:/tmp/pip-lBfIbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:30 INFO - Running setup.py (path:/tmp/pip-6RsriD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:30 INFO - Running setup.py (path:/tmp/pip-QIlo5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:30 INFO - Running setup.py (path:/tmp/pip-YvUAEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:30 INFO - Running setup.py (path:/tmp/pip-SY4b41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:30 INFO - Running setup.py (path:/tmp/pip-sDmzot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:30 INFO - Running setup.py (path:/tmp/pip-k45uBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:30 INFO - Running setup.py (path:/tmp/pip-L7fD8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:31 INFO - Running setup.py (path:/tmp/pip-F20efd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:10:31 INFO - Running setup.py install for manifestparser 15:10:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Running setup.py install for mozcrash 15:10:31 INFO - Running setup.py install for mozdebug 15:10:31 INFO - Running setup.py install for mozdevice 15:10:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Running setup.py install for mozfile 15:10:31 INFO - Running setup.py install for mozhttpd 15:10:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Running setup.py install for mozinfo 15:10:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Running setup.py install for mozInstall 15:10:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:10:31 INFO - Running setup.py install for mozleak 15:10:31 INFO - Running setup.py install for mozlog 15:10:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Running setup.py install for moznetwork 15:10:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Running setup.py install for mozprocess 15:10:32 INFO - Running setup.py install for mozprofile 15:10:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Running setup.py install for mozrunner 15:10:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Running setup.py install for mozscreenshot 15:10:32 INFO - Running setup.py install for moztest 15:10:32 INFO - Running setup.py install for mozversion 15:10:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:10:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:10:32 INFO - Cleaning up... 15:10:32 INFO - Return code: 0 15:10:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:32 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:10:32 INFO - Using env: {'DISPLAY': ':0', 15:10:32 INFO - 'HOME': '/home/cltbld', 15:10:32 INFO - 'LANG': 'en_US.UTF-8', 15:10:32 INFO - 'LANGUAGE': 'en_US:en', 15:10:32 INFO - 'LOGNAME': 'cltbld', 15:10:32 INFO - 'MAIL': '/var/mail/cltbld', 15:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:32 INFO - 'MOZ_NO_REMOTE': '1', 15:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:32 INFO - 'NO_EM_RESTART': '1', 15:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:32 INFO - 'PWD': '/builds/slave/test', 15:10:32 INFO - 'SHELL': '/bin/bash', 15:10:32 INFO - 'SHLVL': '1', 15:10:32 INFO - 'TERM': 'linux', 15:10:32 INFO - 'TMOUT': '86400', 15:10:32 INFO - 'USER': 'cltbld', 15:10:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:32 INFO - '_': '/tools/buildbot/bin/python'} 15:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:10:33 INFO - Running setup.py (path:/tmp/pip-IFNHZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:10:33 INFO - Running setup.py (path:/tmp/pip-LZeuaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:10:33 INFO - Running setup.py (path:/tmp/pip-2kih8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:10:33 INFO - Running setup.py (path:/tmp/pip-YfxOCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:10:33 INFO - Running setup.py (path:/tmp/pip-i1dcvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:10:33 INFO - Running setup.py (path:/tmp/pip-Ap8fYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:10:33 INFO - Running setup.py (path:/tmp/pip-lSryqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:10:33 INFO - Running setup.py (path:/tmp/pip-Ekzc72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:10:33 INFO - Running setup.py (path:/tmp/pip-ZlrE5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:10:33 INFO - Running setup.py (path:/tmp/pip-ds0LWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:10:33 INFO - Running setup.py (path:/tmp/pip-hSY3WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:10:33 INFO - Running setup.py (path:/tmp/pip-IAF9Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:10:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:10:33 INFO - Running setup.py (path:/tmp/pip-2n7ut9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:10:34 INFO - Running setup.py (path:/tmp/pip-r_u9vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:34 INFO - Running setup.py (path:/tmp/pip-ydvTVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:10:34 INFO - Running setup.py (path:/tmp/pip-xykaZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:10:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:10:34 INFO - Running setup.py (path:/tmp/pip-825MGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:10:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:35 INFO - Downloading blessings-1.6.tar.gz 15:10:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:10:35 INFO - Installing collected packages: blessings 15:10:35 INFO - Running setup.py install for blessings 15:10:35 INFO - Successfully installed blessings 15:10:35 INFO - Cleaning up... 15:10:35 INFO - Return code: 0 15:10:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:35 INFO - Reading from file tmpfile_stdout 15:10:35 INFO - Current package versions: 15:10:35 INFO - argparse == 1.2.1 15:10:35 INFO - blessings == 1.6 15:10:35 INFO - blobuploader == 1.2.4 15:10:35 INFO - docopt == 0.6.1 15:10:35 INFO - functools32 == 3.2.3-2 15:10:35 INFO - jsonschema == 2.5.1 15:10:35 INFO - manifestparser == 1.1 15:10:35 INFO - mozInstall == 1.13 15:10:35 INFO - mozcrash == 1.0 15:10:35 INFO - mozdebug == 0.1 15:10:35 INFO - mozdevice == 0.51 15:10:35 INFO - mozfile == 1.2 15:10:35 INFO - mozhttpd == 0.7 15:10:35 INFO - mozinfo == 0.10 15:10:35 INFO - mozleak == 0.1 15:10:35 INFO - mozlog == 3.5 15:10:35 INFO - moznetwork == 0.27 15:10:35 INFO - mozprocess == 0.25 15:10:35 INFO - mozprofile == 0.28 15:10:35 INFO - mozrunner == 6.13 15:10:35 INFO - mozscreenshot == 0.1 15:10:35 INFO - mozsystemmonitor == 0.3 15:10:35 INFO - moztest == 0.8 15:10:35 INFO - mozversion == 1.4 15:10:35 INFO - psutil == 3.1.1 15:10:35 INFO - requests == 1.2.3 15:10:35 INFO - wsgiref == 0.1.2 15:10:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10:35 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 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:10:35 INFO - Using env: {'DISPLAY': ':0', 15:10:35 INFO - 'HOME': '/home/cltbld', 15:10:35 INFO - 'LANG': 'en_US.UTF-8', 15:10:35 INFO - 'LANGUAGE': 'en_US:en', 15:10:35 INFO - 'LOGNAME': 'cltbld', 15:10:35 INFO - 'MAIL': '/var/mail/cltbld', 15:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:35 INFO - 'MOZ_NO_REMOTE': '1', 15:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:35 INFO - 'NO_EM_RESTART': '1', 15:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:35 INFO - 'PWD': '/builds/slave/test', 15:10:35 INFO - 'SHELL': '/bin/bash', 15:10:35 INFO - 'SHLVL': '1', 15:10:35 INFO - 'TERM': 'linux', 15:10:35 INFO - 'TMOUT': '86400', 15:10:35 INFO - 'USER': 'cltbld', 15:10:35 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:35 INFO - '_': '/tools/buildbot/bin/python'} 15:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:10:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:10:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:10:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:10:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:10:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:10:37 INFO - Installing collected packages: simplejson 15:10:37 INFO - Running setup.py install for simplejson 15:10:37 INFO - building 'simplejson._speedups' extension 15:10:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 15:10:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 15:10:38 INFO - Successfully installed simplejson 15:10:38 INFO - Cleaning up... 15:10:38 INFO - Return code: 0 15:10:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:10: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')]} 15:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:10: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')]} 15:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:10: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf53a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f6a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, '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': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:10: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', 'jsonschema'] in /builds/slave/test/build 15:10: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 jsonschema 15:10:38 INFO - Using env: {'DISPLAY': ':0', 15:10:38 INFO - 'HOME': '/home/cltbld', 15:10:38 INFO - 'LANG': 'en_US.UTF-8', 15:10:38 INFO - 'LANGUAGE': 'en_US:en', 15:10:38 INFO - 'LOGNAME': 'cltbld', 15:10:38 INFO - 'MAIL': '/var/mail/cltbld', 15:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:38 INFO - 'MOZ_NO_REMOTE': '1', 15:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:38 INFO - 'NO_EM_RESTART': '1', 15:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:38 INFO - 'PWD': '/builds/slave/test', 15:10:38 INFO - 'SHELL': '/bin/bash', 15:10:38 INFO - 'SHLVL': '1', 15:10:38 INFO - 'TERM': 'linux', 15:10:38 INFO - 'TMOUT': '86400', 15:10:38 INFO - 'USER': 'cltbld', 15:10:38 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:38 INFO - '_': '/tools/buildbot/bin/python'} 15:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:10:38 INFO - Cleaning up... 15:10:38 INFO - Return code: 0 15:10:38 INFO - Running post-action listener: _resource_record_post_action 15:10:38 INFO - Running post-action listener: _start_resource_monitoring 15:10:38 INFO - Starting resource monitoring. 15:10:38 INFO - [mozharness: 2017-09-16 22:10:38.616246Z] Finished create-virtualenv step (success) 15:10:38 INFO - [mozharness: 2017-09-16 22:10:38.617244Z] Running install step. 15:10:38 INFO - Running pre-action listener: _resource_record_pre_action 15:10:38 INFO - Running main action method: install 15:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:10:38 INFO - Reading from file tmpfile_stdout 15:10:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:10:38 INFO - Reading from file tmpfile_stdout 15:10:38 INFO - Output received: 15:10:38 INFO - Usage: mozinstall [options] installer 15:10:38 INFO - Options: 15:10:38 INFO - -h, --help show this help message and exit 15:10:38 INFO - -d DEST, --destination=DEST 15:10:38 INFO - Directory to install application into. [default: 15:10:38 INFO - "/builds/slave/test"] 15:10:38 INFO - --app=APP Application being installed. [default: firefox] 15:10:38 INFO - mkdir: /builds/slave/test/build/application 15:10:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:10:56 INFO - Reading from file tmpfile_stdout 15:10:56 INFO - Output received: 15:10:56 INFO - /builds/slave/test/build/application/firefox/firefox 15:10:56 INFO - Running post-action listener: _resource_record_post_action 15:10:56 INFO - [mozharness: 2017-09-16 22:10:56.559773Z] Finished install step (success) 15:10:56 INFO - [mozharness: 2017-09-16 22:10:56.560023Z] Running setup-mitmproxy step. 15:10:56 INFO - Running pre-action listener: _resource_record_pre_action 15:10:56 INFO - Running main action method: setup_mitmproxy 15:10:56 INFO - Skipping: mitmproxy is not required 15:10:56 INFO - Running post-action listener: _resource_record_post_action 15:10:56 INFO - [mozharness: 2017-09-16 22:10:56.561148Z] Finished setup-mitmproxy step (success) 15:10:56 INFO - [mozharness: 2017-09-16 22:10:56.561366Z] Running run-tests step. 15:10:56 INFO - Running pre-action listener: _resource_record_pre_action 15:10:56 INFO - Running pre-action listener: _set_gcov_prefix 15:10:56 INFO - Running main action method: run_tests 15:10:56 WARNING - Try message not found. 15:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:10:56 INFO - Python 2.7.3 15:10:56 INFO - Return code: 0 15:10:56 INFO - grabbing minidump binary from tooltool 15:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:10:56 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 0x10fa090>, '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 0x10fad80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f4f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:10:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:10:56 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:10:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:10:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:10:56 INFO - Return code: 0 15:10:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:10:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:10:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:10:56 INFO - ENV: RUST_BACKTRACE is now full 15:10:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:10:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:10:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:10:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 15:10:56 INFO - Using env: {'DISPLAY': ':0', 15:10:56 INFO - 'HOME': '/home/cltbld', 15:10:56 INFO - 'LANG': 'en_US.UTF-8', 15:10:56 INFO - 'LANGUAGE': 'en_US:en', 15:10:56 INFO - 'LOGNAME': 'cltbld', 15:10:56 INFO - 'MAIL': '/var/mail/cltbld', 15:10:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:10:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:10:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:10:56 INFO - 'MOZ_NO_REMOTE': '1', 15:10:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:10:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:10:56 INFO - 'NO_EM_RESTART': '1', 15:10:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:10:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:10:56 INFO - 'PWD': '/builds/slave/test', 15:10:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:10:56 INFO - 'RUST_BACKTRACE': 'full', 15:10:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:10:56 INFO - 'SHELL': '/bin/bash', 15:10:56 INFO - 'SHLVL': '1', 15:10:56 INFO - 'TERM': 'linux', 15:10:56 INFO - 'TMOUT': '86400', 15:10:56 INFO - 'USER': 'cltbld', 15:10:56 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:10:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:10:56 INFO - '_': '/tools/buildbot/bin/python'} 15:10:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 15:10:57 INFO - mozversion application_buildid: 20170916205151 15:10:57 INFO - mozversion application_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 15:10:57 INFO - mozversion application_display_name: Nightly 15:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:10:57 INFO - mozversion application_name: Firefox 15:10:57 INFO - mozversion application_remotingname: firefox 15:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:10:57 INFO - mozversion application_vendor: Mozilla 15:10:57 INFO - mozversion application_version: 57.0a1 15:10:57 INFO - mozversion platform_buildid: 20170916205151 15:10:57 INFO - mozversion platform_changeset: 45b63125a4301eb89e7a4d70d0da1c650f11c7e4 15:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:10:57 INFO - mozversion platform_version: 57.0a1 15:10:57 INFO - using testdate: 1505599857 15:10:57 INFO - actual date: 1505599857 15:10:57 INFO - starting webserver on 'localhost:33590' 15:10:57 INFO - SUITE-START | Running 2 tests 15:10:57 INFO - TEST-START | dromaeo_css 15:10:57 INFO - Initialising browser for dromaeo_css test... 15:10:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33590/getInfo.html -profile /tmp/tmp_LNawA/profile 15:10:57 INFO - TEST-INFO | started process 3508 (/builds/slave/test/build/application/firefox/firefox http://localhost:33590/getInfo.html) 15:11:04 INFO - TEST-INFO | 3508: exit 0 15:11:04 INFO - Browser initialized. 15:11:04 INFO - Running cycle 1/1 for dromaeo_css test... 15:11:04 INFO - Using env: {'DISPLAY': ':0', 15:11:04 INFO - 'HOME': '/home/cltbld', 15:11:04 INFO - 'JSGC_DISABLE_POISONING': '1', 15:11:04 INFO - 'LANG': 'en_US.UTF-8', 15:11:04 INFO - 'LANGUAGE': 'en_US:en', 15:11:04 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:11:04 INFO - 'LOGNAME': 'cltbld', 15:11:04 INFO - 'MAIL': '/var/mail/cltbld', 15:11:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:11:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:11:04 INFO - 'MOZ_CRASHREPORTER': '1', 15:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:11:04 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:11:04 INFO - 'MOZ_NO_REMOTE': '1', 15:11:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:11:04 INFO - 'NO_EM_RESTART': '1', 15:11:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:11:04 INFO - 'PWD': '/builds/slave/test', 15:11:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:11:04 INFO - 'RUST_BACKTRACE': 'full', 15:11:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:11:04 INFO - 'SHELL': '/bin/bash', 15:11:04 INFO - 'SHLVL': '1', 15:11:04 INFO - 'TERM': 'linux', 15:11:04 INFO - 'TMOUT': '86400', 15:11:04 INFO - 'USER': 'cltbld', 15:11:04 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:11:04 INFO - '_': '/tools/buildbot/bin/python'} 15:11:04 INFO - TEST-INFO | started process 3745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_LNawA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:11:05 INFO - PID 3745 | 15:11:05 INFO - PID 3745 | (/builds/slave/test/build/application/firefox/firefox:3794): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:11:05 INFO - PID 3745 | 15:11:15 INFO - PID 3745 | RSS: Main: 147746816 15:11:15 INFO - PID 3745 | 15:14:13 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33590/tests/dromaeo/cssquery-ext.html) 15:14:14 INFO - PID 3745 | RSS: Main: 148832256 15:14:14 INFO - PID 3745 | 15:17:16 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-ext.html (next: http://localhost:33590/tests/dromaeo/cssquery-jquery.html) 15:17:17 INFO - PID 3745 | RSS: Main: 146960384 15:17:17 INFO - PID 3745 | 15:20:18 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33590/tests/dromaeo/cssquery-mootools.html) 15:20:19 INFO - PID 3745 | RSS: Main: 150949888 15:20:19 INFO - PID 3745 | 15:23:20 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33590/tests/dromaeo/cssquery-prototype.html) 15:23:21 INFO - PID 3745 | RSS: Main: 149172224 15:23:21 INFO - PID 3745 | 15:26:24 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33590/tests/dromaeo/cssquery-yui.html) 15:26:25 INFO - PID 3745 | RSS: Main: 150679552 15:26:25 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | Cycle 1(1): loaded http://localhost:33590/tests/dromaeo/cssquery-yui.html (next: http://localhost:33590/tests/dromaeo/cssquery-dojo.html) 15:29:26 INFO - PID 3745 | RSS: Main: 152969216 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | __start_tp_report 15:29:26 INFO - PID 3745 | _x_x_mozilla_page_load 15:29:26 INFO - PID 3745 | _x_x_mozilla_page_load_details 15:29:26 INFO - PID 3745 | |i|pagename|runs| 15:29:26 INFO - PID 3745 | |0;dojo.html;3875.8643447479335;3890.2997460457113;3938.4879965604487;3947.526296844377;3952.446657467953;6240.282367527736;6315.115883776275;6381.361863813617;6384.297727250005;6412.166418365612;6302.1177035215105;6302.905456418146;6318.842028949279;6323.873522529558;6374.521910856681;5618.887622247553;5674.744636491368;5679.602427830054;5691.146328050784;5762.769489220447;5701.173329867188;5712.22884910536;5764.135379693038;5804.854878628026;5843.824685259449;5561.360443549003;5665.065264231397;5751.079827227644;5818.476337129658;5872.207252020987;5316.893662126775;5659.377468478505;5684.403137670526;5758.856028599276;5790.797322093748;5651.491365777099;5689.061304884689;5746.540276777848;5757.740901659394;5781.566382521328;6204.6587437690905;6264.9686751566405;6294.685265736694;6355.872882542323;6356.14192084072;6783.6269005204695;6803.047573339736;6804;6850.520463567503;6858.451323894076;6791.932080679179;6816.556923799937;6828.863422731567;6962.338577835098;6970.30296970304;6317.178766760292;6419.8395040123905;6474.935250647481;6495.025746138117;6495.123158373606;7089.432845372357;7092.4680648951535;7162.641867906584;7172.426205903515;7178.353948144588;6762.661866906635;6791.626460544619;6798.388145066968;6805.591664500146;6809.5233333666165;6910.343517365842;6921.826954326182;6923.6884340204815;6939.965300173568;6971.895421568681;6762.425193858478;6795.694193761293;6805.795826125224;6847;6896.517243792886;6735.461163106939;6792.150981127359;6823.351781580742;6832.726690932406;6907.309269073053;4950.504949505021;4968.950310496849;5004.999000199975;5008.073506401327;5025.698458092526;4465.620422264079;4516.029053753458;4528.750918699503;4538.773061346986;4541.182587134282;6207.317195108534;6211.503079753609;6273.215848018997;6287.088372186099;6298.968505157445;6669.899951500732;6674.566153200027;6756.560823546453;6782.1861376635115;6795.116634837439;6278.717457714414;6290.496760259169;6377.394147555975;6400.135981642512;6408.903866442007;5552.194931734876;5608.439156084441;5622.184783206412;5624.268845050199;5624.29696287964;6990.335918087773;7065.89401158983;7109.92890071103;7162.391196748231;7163.42692584592;6629.403353698191;6718.294579069127;6719.227288861844;6722.462203023844;6841.076454678555;6993.8251543709775;7000;7001.054857594159;7007.474439417166;7032.683529241094;6699.430548403246;6808.148981377328;6846.691898864464;6851.143607049119;6862.936244882051;6878.65606719672;6890.173179218526;6953.617551034742;6965.47758918073;6965.79102626922;6489.643069631215;6595.94464885616;6618.867622647616;6621.635810030302;6713.6643167842385;6635.6350400728425;6639.03733958583;6690.531662783558;6690.765823196165;6704.463642908653;6587.571807832475;6649.734010639714;6678.532502724957;6678.666066696548;6680.3987641112535;6626.933730662825;6695.598264104169;6703.262641109572;6796.422304104207;6798.694058767466;6403.07155462446;6486.513511486752;6491.870162596816;6543.345665433419;6546.738130474918 15:29:26 INFO - PID 3745 | |1;ext.html;939.9718008459748;950.3157726436963;960.5245403525255;989.4310771306498;1003.4079892863209;43936.78031609841;44525.554744452544;44570.554294457084;44653;44680.55319446805;41359.58640413595;41729.58270417295;41824.58175418245;41897;42010;7397;7508.249175082503;7520.661570229353;7523.360514356286;7525.397968162534;7372.299631534996;7449.143348514936;7453.739119130832;7455.589942553157;7459.067616547932;7981.680732770682;8070.394720395964;8080.353571714249;8081.313088387494;8084.919150808475;7903.130655627876;7992.400569957247;8033.517988920654;8062.113167551594;8062.475939063942;7993;8026.759197224034;8052.43632945694;8058.274755272054;8072.475289106189;40498.39252411216;41143;41295.7935210325;41361.79319103385;41463;3669.2478042001326;3671.155634204148;3680.208755117636;3681.245344704329;3692.7599706019023;32928.67071329304;33195.66804331974;33947.83026084854;33998.83000584981;34249.48625770616;5453.945460545384;5476.863078423032;5477.917831232535;5515.227868098469;5580.414056524047;211108;211460.99999999846;211539;212892;214072;53012.469875301525;53117;53215.20177197345;53351;53457;55871.441285586625;56180.71909640425;56213;56511.43488565144;56665;16866.241019154168;17091.658166836594;17116.40092596778;17135.143242837807;17137;13800.585982420343;13804.654883627989;13805.723885522233;13813.447462101403;13820.308984550733;15669.451569195024;15797.36810527589;15828.366865325257;15846;15929.920350398406;5886.823395298063;5907.793227237026;5939.287285525678;5954.612950158225;6197.690115494207;1086.3047649504324;1094.9397783121844;1098.6594155811724;1103.5971870267294;1118.278710231896;25243.368915776886;25336.239912802645;25448.49103017929;25485.3628659285;25623.359416014748;1177.611388241878;1186.7626474705094;1201.3692811274152;1204.3978010994504;1224.412282104577;13246.668833279053;13400.798988015187;13483.52807651747;13498.595042148554;13615.18308901469;275718;277983;278052;278250;278569;51362.48637513652;51652.48347516552;58338.416615833296;58718.706406467696;58739;1403.9508617198348;1503.4662694743208;1505.2699440771216;1520.148716718641;1523.5733994481564;30267.394652107276;30389.392212156075;30428.391432171677;30626.387472250877;30996.791614356174;39307.410388844764;39548.40677389899;39605.40591891181;39647.2070558593;39730.40404393994;213546;214000;214014;214281;215147;35164.296714066084;36256;36893.44659830051;36971.44542831806;37060.07349816276;44571.554284458034;45368;45371;45706;45757;33866.322673546885;34374.31251375008;34553;34725.82637086798;34807;33940.321193575495;34330.31339373248;34612.65387346094;34707.13232169115;34719.4792078114;39466.21067578575;40012.39981400223;40153.79923100366;40429.79785101055;40476.59523404728;33574.66425335813;33750.66249337475;33868;34172.14569635779;34337.828310858284;24624.384390390383;25037.74962250427;25394.365140870887;25690.22929312049;25828.612570811827 15:29:26 INFO - PID 3745 | |2;jquery.html;592.126613245463;593.8159170657096;598.9790357337494;607.7568972411037;621.5928566788754;23280;23968.280951571436;24044.87977560114;24050.27849164528;24108.517829643395;22584.322470325875;22643;22655.773442265574;22761.544769104607;24248.515029699396;6640.767573134929;6851.3491218334175;6851.623160726158;6852.931470685304;6853.897191542131;6609.570377925419;6619.106420633225;6716.395524402803;6824.4199243064395;6853.691583878713;6807.455403567703;6809.455243580502;6810.727570897183;6811.897821532681;6815.454763618924;6570.540062195648;6760.695768690421;6780.118584583997;6801.523893327469;6810.693518791666;6232.594881332699;6273.247210334789;6288.779892703779;6290.842728931813;6329.873402531924;29505.557416638552;29694.851525742233;29851.552226716398;29941.101766947027;30052;2228.19784877444;2241.2267767620147;2246.3261021693424;2255.0754190781863;2256.187772401934;20339.288124915558;20695.27566535179;20717.585648287102;20909.26817561393;20909.790902090936;2482.3173627252468;2505.1232068775967;2540.0347867810297;2573.8713064346707;2582.109172335541;138865;142990.2850485741;152786;159388;160404;15090.74210873073;15503.457378991681;15902.840971590136;15987.840121598867;16044.197790110447;24771.13301034455;24773.876130619592;24827.255182344557;24879.253622391356;24957;10805.189610779224;10867.619633312954;10985.121190304757;11070.335779853234;11126.054285385833;10142.492875356204;10155.746106347253;10203;10290.794184116425;10310.381377117397;9504.667336643322;9610.51947402627;9661.488013116641;9764.414135151772;9777.168940640126;2756.9385786472353;2786.9442611147665;2821.2523681224493;2877.510823160068;2926.2976885547314;1044.5978298355035;1046.9057784799404;1054.1566746602687;1061.8141825180717;1082.1342925659442;21407.78592214089;21455.463613409476;21753.45616359572;21757.23849665286;21882.671759923614;1124.8481455003634;1130.971725706864;1132.592266783957;1137.1016896651552;1139.7264656482384;11567.248128871597;11686.532538698357;11746.647600571996;11849.644510664693;11899.405029748477;562404;577051;582061;591101;597214;128269;131113.34443327723;131827.340863297;134688;135469;1107.9058280046286;1176.0297754352694;1233.5929143382662;1251.9186252893533;1289.9161554498928;22116.889415552818;22369.105235791038;22380.888095559418;22390.850104476387;22765.08939642462;60960.69519652373;65460.67269663621;65473.67263163654;65929;67474.66262668655;78697;79423;80312.59843700744;82931.5853420729;83511;15285.235738213267;15597.688046238785;15636.530904072895;15727.606809829846;15768.211589420713;24875;25012.249632511055;25137.87431062833;25220.873895630404;25389.238322850342;19885.900570497055;19974;20026.499337516096;20085.49786255355;20452.897735511226;17676.116194190497;17683.469495915142;17910.373136940143;18700.345487908402;18716.719249211;20240.69638955446;20248.392548223575;20432.489187770425;20438.28466003683;20789.168433263105;15339.309731061905;15340.156291403633;15391.923040384727;15526.534203973899;15528.844711553193;19813.405597831512;19905.502362441053;20063.29778457747;20072.49818754543;20085 15:29:26 INFO - PID 3745 | |3;mootools.html;1390.4855203574677;1487.4347747855813;1512.8033355663765;1519.263157368676;1520.125927591635;16405.179741012947;16976;17005.31978720851;17055.573610659707;17075.48773536793;16540.42108526202;16624.418145364914;16690.082045487525;16695.91652041741;16715.91642041791;2836.489431902267;2891.074856046066;2932.66274378446;2948.3218859662293;2951.8228906265585;2921.2988882668114;2928.9414211715753;2950.100219433072;2952.4833154198036;2963.955540666892;2904.7966642335045;2918.9124326270244;2985.567092771547;2988.5218365061596;3008.7743419243534;2900.8549572521288;2914.28599993002;2917.460269850074;2943.8528073596235;2944.1461976026926;2833.065088520804;2849.4443583501225;2865.3409715765283;2867.7275658812378;2867.752527650479;16598.83401165985;16747.246373913204;16829.495115146565;16858.325666973305;16945.830541694548;8655.913440865637;8901.821963560757;8923.821523569492;8934.28525717941;8942;5691.743871525791;5880.235569375954;5929.229200203989;5940.316863560703;6014.12795144706;2124.447643612672;2165.967510487344;2172.6089303925446;2215.8670479771104;2216.116301144015;30145;30359.848200758854;30413.087607371814;30417.847910760527;30445.543316850264;7362.558246505227;7426.14599321085;7481.8877716834295;7491.925080749123;7649.38804895607;16542.255598498097;17068.743968840477;19274.22903083889;19286.4214073578;19505.219791208478;8437.578121094044;8790.120987901286;8790.208881200722;8792.912070879209;8796.648134074694;7796.142424333319;7955.2840244378285;7973.800654983555;8044.83910321802;8062.153473885275;5745.482906538432;5819.127130930395;5870.911936320958;5925.9407405925385;5936.436038576328;1699.3967141664778;1731.4978656189564;1731.9393821216197;1742.9564260893326;1749.8162692917315;969.9078587534173;970.7087873638021;988.41189492252;993.036754348281;993.8906720260766;8232.917670823215;8265.83468330642;8266.462679925786;8279.337652987746;8282.668693252203;791.0625908298684;793.8094857234222;800.9627532345627;804.3967024731452;812.544974814106;5286.3920649125075;5628.690422026828;5632.408597097327;5757.596968212269;5840.182374467578;24618.876905615714;25850.095246666653;25891;26090.608640870403;26139;24377;24982.750172498407;25022.624660630107;25667.35831604225;25681.614775778376;12164.2701437914;12223.633291001284;12367.93816030932;12421.627351179299;12471.438785254686;8854.822903541764;8910.287177025952;8926.06276340975;8979.416337938013;8984.505852177932;20852.895735521226;21050.263240787113;21485;21492;21925.890370548044;21920.89039554792;22378;22473.550528989657;22562.887185563966;22982.540349192586;12418.130730848754;12561.874381256435;12568.371581421075;12574.245545267313;12583;15418.768718469008;15471;15601.141937193563;15622.765658515358;15627.687446250784;12338.074644401526;12371.814422783846;12490.687732806753;12526.060545458944;12742.872571274169;12315;12341.420374958094;12382.195157314745;12382.195157314745;12791.232526048467;10563.366198028143;10567.577296908037;10639.468026598484;10691.09125724322;10696.197785165989;7938.801529961797;7974.641141148546;7987.241212084843;8012.799680008046;8165.959170204111;8036.598170091589;8093.676252949816;8121.8375632488205;8164.428490005643;8185.5497947611075 15:29:26 INFO - PID 3745 | |4;prototype.html;545.5172172627224;564.9604527683061;570.7289037707093;584.0742423259136;585.7364186116246;6202.410770976756;6205.658688772116;6213.502919766419;6225.159603453532;6317.494600431966;6160.383961603838;6185.783497577586;6192.451887028243;6218.25380954285;6219.19150510433;5127.282180494733;5136.5890728741615;5138.434772175057;5150.768215430296;5160.096983027974;5113.565346945496;5129.281900533928;5134.074721979257;5155.2524883892;5168.7415629218385;4754.572088512034;4923.655344125913;4924.950750492503;4940.777665005084;4947.802087916497;4915.5330243626795;4917.582005529534;4921.966387058722;4933.80264789408;4936.815164360528;4373.715708478939;4448.243798554254;4467.419235499397;4472.843450479218;4479.552044795527;6039.912815693174;6086.269647642267;6088.726007329681;6105.542084343692;6106.633601983851;5811.3316968548315;5828.504577110951;5832.562557808139;5836.64980101191;5845.795397161079;6568.901466478007;6576.276609572943;6589.308122647149;6603.009548567753;6607;5003.274525193827;5012.523810238022;5014.971930754186;5019.372578427697;5019.874503137451;6571.141553424276;6638.634875081869;6760.391564759196;6796.757070166833;6912.516123871331;5088.287639730441;5103.668261562986;5107.00413419387;5142.965650266286;5149.124648809711;5171.120909445403;5211.166213405837;5212.55693266069;5236.345456817898;5236.528712415901;5759.510441612426;5791.88416231673;5800.4489573490455;5803.506701930383;5804.622699524517;6435.584171482266;6545.05096760967;6595.505337099737;6641.634710090895;6704.463642908556;1760.8943463392238;1767.3284152022406;1769.672610567049;1793.9282428702966;1798.190814133619;1235.873077323969;1266.8859802617808;1268.5475130975167;1274.7698470975554;1278.878506541877;6079.209702738615;6088.178095956989;6126.479249263863;6130.693465326716;6144.754209831557;6556.541042127101;6590.340965903371;6598.31742905556;6639.236487803868;6647.335266473314;5849.561282903799;6043.516518678495;6074.54440916933;6117.847053823601;6166.321704612489;3443.6384179661277;3462.342154990544;3485.4771784232566;3532.315440265417;3536.982315088408;6905.89505679089;6920.411765000032;6927;6952.617606031616;6952.965235173791;6694.9580377985185;6780.627065511346;6797.354251346114;6837.829054273683;6894.345037221456;6905.309469053155;6954.130733658293;7007.229204787572;7027.683754231072;7051.048108505492;6452.257990331172;6539;6684.685674888573;6687.699053542505;6709.865802683821;6572.521182734038;6617.536772425884;6643.900341494785;6657.101291325609;6665.3001434850585;6898.172219333712;6957.851954427463;6970.581765094111;7012.211885969045;7023.508354415142;5035.546800787946;5110.1568241239775;5141.71720555373;5152.5620322271525;5167.509086636764;6511.2512061113575;6569.9014514783275;6621.470282377494;6690.230623478362;6702.329767023259;6307.306196318493;6426.742930282736;6497.805065848032;6498.837529061622;6499.4800415965665;6394;6443.74590831627;6443.96778016107;6455.870882582228;6544.8363790905605;6305.856008956976;6348.777792777415;6359.17330747;6383.2978372378075;6429.22849258092;6448.032795080775;6502.934970650233;6517.315681853527;6531.477481801539;6580.276169621434;6255.96872015637;6280.026595877646;6302.502111328074;6318.968405157945;6356.806901618934 15:29:26 INFO - PID 3745 | |5;yui.html;951.3768481644526;981.1905178227961;982.3418309732479;1002.0880998291556;1009.8889122196559;22446.102155913763;23617.527649447;24672.38319042025;24818.50362992739;24958.999999999978;19389.32137375192;20845.68731469029;23622.173223937167;23691.407714807137;23735.40661483464;1045.4459136657583;1045.5295117197254;1046.089901785444;1049.7113293844216;1084.105612869382;1067.0503252105632;1094.9069329107035;1100.9889901100967;1118.7370967822596;1118.7818375416798;1160.3386069940095;1163.2671417007273;1164.1385374822655;1164.4177911044478;1164.930104193747;1153.81538953767;1158.108256642389;1159.3739380734394;1160.7620437810272;1163.2206421697483;836.0844874862016;842.2083241752733;845.1970627903517;849.1678155407674;849.5582297205418;18994.620107597908;19265.518362040923;19339.12973916163;19438.80561194384;20505;23259;23411.180608678784;23723.881380592986;23831.09351251913;23883.164089256967;18694.439166824883;18744.812551874442;18985.90507047456;19025.238990440364;19044.714329284932;4008.939865902014;4016.2770701273757;4056;4057.0871553900433;4062.0860306431114;156739;157304;158665;159845;160507;17106.657866842594;17130;17339.56651083733;17585.7362139568;17602.207900644247;30253.243668908453;30631.081067568008;30837.229069273446;30854.074377768702;31007.68992310048;9060;9096.8635470468;9181.816363672822;9187.2190863776;9190.540472976458;4170.416141740159;4215.304474761691;4263.531011588722;4268.615824575803;4306.956930430718;6091.360407157274;6121.265448146251;6166.660833654102;6170.382961703794;6183.258009038944;1102.8345748137683;1128.6049882541208;1135.4209353229912;1141.9543218271342;1145.6505765741529;715.8138883890226;725;725.4015437264278;737.4395459450856;750.1410884537174;11828.52685892572;12032.338221397908;12806.447108575592;13386.330683465787;13653.726925461633;726.8509955459118;731.9963400183071;738.0663460722191;741.6921977379327;748.3975399803102;5718.485336319751;5723.6851973141875;5754.252741488289;5838.503727183237;5878.911816322759;142667;145332.27333863263;145387;146739;147600.52399476082;116225;120603;121412;122426.38786806187;127788;113667;114453.4277328608;114638;115767.42116289365;115859.42070289595;10568.313059651406;10867.945660271647;10898.618548350769;10911.890881091087;11087.501062452047;52169;54207.18689219586;54814;55377.723111384184;55929.720351397984;66146.66926665336;67613;68685.31314686789;70162.29837701557;70302.64848675724;16916.74624880603;16943.068131252898;17085.914570427067;17165.57086072858;17177.57056073558;19131.521711957314;19363.515912101746;19454.90272548628;19472.513187170433;19571.412857614294;17288.222030008932;17380.652386952443;17394.117998447146;17501.03744294076;17702.468925932244;16943.576410589834;17060.23228954725;17121.143942802562;17136.48590542286;17157.485275441755;16229.513114606581;16319.510414687578;16326.18369081565;16397.590060248112;16399.344026238818;13025.674358141123;13213.207207567577;13280.070395072253;13339.19964802115;13582.117162384413;13111.60665180046;13213;13267.734645307233;13327.466901323838;13558.93220533891 15:29:26 INFO - PID 3745 | __end_tp_report 15:29:26 INFO - PID 3745 | __start_cc_report 15:29:26 INFO - PID 3745 | _x_x_mozilla_cycle_collect,296 15:29:26 INFO - PID 3745 | __end_cc_report 15:29:26 INFO - PID 3745 | __startTimestamp1505600966937__endTimestamp 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | ------- Summary: start ------- 15:29:26 INFO - PID 3745 | Number of tests: 6 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#0] dojo.html Cycles:165 Average:6311.12 Median:6595.94 stddev:743.87 (11.3%) stddev-sans-first:721.20 15:29:26 INFO - PID 3745 | Values: 3875.9 3890.3 3938.5 3947.5 3952.4 6240.3 6315.1 6381.4 6384.3 6412.2 6302.1 6302.9 6318.8 6323.9 6374.5 5618.9 5674.7 5679.6 5691.1 5762.8 5701.2 5712.2 5764.1 5804.9 5843.8 5561.4 5665.1 5751.1 5818.5 5872.2 5316.9 5659.4 5684.4 5758.9 5790.8 5651.5 5689.1 5746.5 5757.7 5781.6 6204.7 6265.0 6294.7 6355.9 6356.1 6783.6 6803.0 6804.0 6850.5 6858.5 6791.9 6816.6 6828.9 6962.3 6970.3 6317.2 6419.8 6474.9 6495.0 6495.1 7089.4 7092.5 7162.6 7172.4 7178.4 6762.7 6791.6 6798.4 6805.6 6809.5 6910.3 6921.8 6923.7 6940.0 6971.9 6762.4 6795.7 6805.8 6847.0 6896.5 6735.5 6792.2 6823.4 6832.7 6907.3 4950.5 4969.0 5005.0 5008.1 5025.7 4465.6 4516.0 4528.8 4538.8 4541.2 6207.3 6211.5 6273.2 6287.1 6299.0 6669.9 6674.6 6756.6 6782.2 6795.1 6278.7 6290.5 6377.4 6400.1 6408.9 5552.2 5608.4 5622.2 5624.3 5624.3 6990.3 7065.9 7109.9 7162.4 7163.4 6629.4 6718.3 6719.2 6722.5 6841.1 6993.8 7000.0 7001.1 7007.5 7032.7 6699.4 6808.1 6846.7 6851.1 6862.9 6878.7 6890.2 6953.6 6965.5 6965.8 6489.6 6595.9 6618.9 6621.6 6713.7 6635.6 6639.0 6690.5 6690.8 6704.5 6587.6 6649.7 6678.5 6678.7 6680.4 6626.9 6695.6 6703.3 6796.4 6798.7 6403.1 6486.5 6491.9 6543.3 6546.7 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#1] ext.html Cycles:180 Average:41533.73 Median:3680.73 stddev:61460.00 (1669.8%) stddev-sans-first:61556.83 15:29:26 INFO - PID 3745 | Values: 940.0 950.3 960.5 989.4 1003.4 43936.8 44525.6 44570.6 44653.0 44680.6 41359.6 41729.6 41824.6 41897.0 42010.0 7397.0 7508.2 7520.7 7523.4 7525.4 7372.3 7449.1 7453.7 7455.6 7459.1 7981.7 8070.4 8080.4 8081.3 8084.9 7903.1 7992.4 8033.5 8062.1 8062.5 7993.0 8026.8 8052.4 8058.3 8072.5 40498.4 41143.0 41295.8 41361.8 41463.0 3669.2 3671.2 3680.2 3681.2 3692.8 32928.7 33195.7 33947.8 33998.8 34249.5 5453.9 5476.9 5477.9 5515.2 5580.4 211108.0 211461.0 211539.0 212892.0 214072.0 53012.5 53117.0 53215.2 53351.0 53457.0 55871.4 56180.7 56213.0 56511.4 56665.0 16866.2 17091.7 17116.4 17135.1 17137.0 13800.6 13804.7 13805.7 13813.4 13820.3 15669.5 15797.4 15828.4 15846.0 15929.9 5886.8 5907.8 5939.3 5954.6 6197.7 1086.3 1094.9 1098.7 1103.6 1118.3 25243.4 25336.2 25448.5 25485.4 25623.4 1177.6 1186.8 1201.4 1204.4 1224.4 13246.7 13400.8 13483.5 13498.6 13615.2 275718.0 277983.0 278052.0 278250.0 278569.0 51362.5 51652.5 58338.4 58718.7 58739.0 1404.0 1503.5 1505.3 1520.1 1523.6 30267.4 30389.4 30428.4 30626.4 30996.8 39307.4 39548.4 39605.4 39647.2 39730.4 213546.0 214000.0 214014.0 214281.0 215147.0 35164.3 36256.0 36893.4 36971.4 37060.1 44571.6 45368.0 45371.0 45706.0 45757.0 33866.3 34374.3 34553.0 34725.8 34807.0 33940.3 34330.3 34612.7 34707.1 34719.5 39466.2 40012.4 40153.8 40429.8 40476.6 33574.7 33750.7 33868.0 34172.1 34337.8 24624.4 25037.7 25394.4 25690.2 25828.6 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#2] jquery.html Cycles:180 Average:39320.90 Median:2243.78 stddev:97729.56 (4355.6%) stddev-sans-first:97960.45 15:29:26 INFO - PID 3745 | Values: 592.1 593.8 599.0 607.8 621.6 23280.0 23968.3 24044.9 24050.3 24108.5 22584.3 22643.0 22655.8 22761.5 24248.5 6640.8 6851.3 6851.6 6852.9 6853.9 6609.6 6619.1 6716.4 6824.4 6853.7 6807.5 6809.5 6810.7 6811.9 6815.5 6570.5 6760.7 6780.1 6801.5 6810.7 6232.6 6273.2 6288.8 6290.8 6329.9 29505.6 29694.9 29851.6 29941.1 30052.0 2228.2 2241.2 2246.3 2255.1 2256.2 20339.3 20695.3 20717.6 20909.3 20909.8 2482.3 2505.1 2540.0 2573.9 2582.1 138865.0 142990.3 152786.0 159388.0 160404.0 15090.7 15503.5 15902.8 15987.8 16044.2 24771.1 24773.9 24827.3 24879.3 24957.0 10805.2 10867.6 10985.1 11070.3 11126.1 10142.5 10155.7 10203.0 10290.8 10310.4 9504.7 9610.5 9661.5 9764.4 9777.2 2756.9 2786.9 2821.3 2877.5 2926.3 1044.6 1046.9 1054.2 1061.8 1082.1 21407.8 21455.5 21753.5 21757.2 21882.7 1124.8 1131.0 1132.6 1137.1 1139.7 11567.2 11686.5 11746.6 11849.6 11899.4 562404.0 577051.0 582061.0 591101.0 597214.0 128269.0 131113.3 131827.3 134688.0 135469.0 1107.9 1176.0 1233.6 1251.9 1289.9 22116.9 22369.1 22380.9 22390.9 22765.1 60960.7 65460.7 65473.7 65929.0 67474.7 78697.0 79423.0 80312.6 82931.6 83511.0 15285.2 15597.7 15636.5 15727.6 15768.2 24875.0 25012.2 25137.9 25220.9 25389.2 19885.9 19974.0 20026.5 20085.5 20452.9 17676.1 17683.5 17910.4 18700.3 18716.7 20240.7 20248.4 20432.5 20438.3 20789.2 15339.3 15340.2 15391.9 15526.5 15528.8 19813.4 19905.5 20063.3 20072.5 20085.0 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#3] mootools.html Cycles:180 Average:10423.67 Median:2879.41 stddev:7715.45 (268.0%) stddev-sans-first:7707.24 15:29:26 INFO - PID 3745 | Values: 1390.5 1487.4 1512.8 1519.3 1520.1 16405.2 16976.0 17005.3 17055.6 17075.5 16540.4 16624.4 16690.1 16695.9 16715.9 2836.5 2891.1 2932.7 2948.3 2951.8 2921.3 2928.9 2950.1 2952.5 2964.0 2904.8 2918.9 2985.6 2988.5 3008.8 2900.9 2914.3 2917.5 2943.9 2944.1 2833.1 2849.4 2865.3 2867.7 2867.8 16598.8 16747.2 16829.5 16858.3 16945.8 8655.9 8901.8 8923.8 8934.3 8942.0 5691.7 5880.2 5929.2 5940.3 6014.1 2124.4 2166.0 2172.6 2215.9 2216.1 30145.0 30359.8 30413.1 30417.8 30445.5 7362.6 7426.1 7481.9 7491.9 7649.4 16542.3 17068.7 19274.2 19286.4 19505.2 8437.6 8790.1 8790.2 8792.9 8796.6 7796.1 7955.3 7973.8 8044.8 8062.2 5745.5 5819.1 5870.9 5925.9 5936.4 1699.4 1731.5 1731.9 1743.0 1749.8 969.9 970.7 988.4 993.0 993.9 8232.9 8265.8 8266.5 8279.3 8282.7 791.1 793.8 801.0 804.4 812.5 5286.4 5628.7 5632.4 5757.6 5840.2 24618.9 25850.1 25891.0 26090.6 26139.0 24377.0 24982.8 25022.6 25667.4 25681.6 12164.3 12223.6 12367.9 12421.6 12471.4 8854.8 8910.3 8926.1 8979.4 8984.5 20852.9 21050.3 21485.0 21492.0 21925.9 21920.9 22378.0 22473.6 22562.9 22982.5 12418.1 12561.9 12568.4 12574.2 12583.0 15418.8 15471.0 15601.1 15622.8 15627.7 12338.1 12371.8 12490.7 12526.1 12742.9 12315.0 12341.4 12382.2 12382.2 12791.2 10563.4 10567.6 10639.5 10691.1 10696.2 7938.8 7974.6 7987.2 8012.8 8166.0 8036.6 8093.7 8121.8 8164.4 8185.5 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#4] prototype.html Cycles:180 Average:5571.93 Median:6176.05 stddev:1551.53 (25.1%) stddev-sans-first:1509.32 15:29:26 INFO - PID 3745 | Values: 545.5 565.0 570.7 584.1 585.7 6202.4 6205.7 6213.5 6225.2 6317.5 6160.4 6185.8 6192.5 6218.3 6219.2 5127.3 5136.6 5138.4 5150.8 5160.1 5113.6 5129.3 5134.1 5155.3 5168.7 4754.6 4923.7 4925.0 4940.8 4947.8 4915.5 4917.6 4922.0 4933.8 4936.8 4373.7 4448.2 4467.4 4472.8 4479.6 6039.9 6086.3 6088.7 6105.5 6106.6 5811.3 5828.5 5832.6 5836.6 5845.8 6568.9 6576.3 6589.3 6603.0 6607.0 5003.3 5012.5 5015.0 5019.4 5019.9 6571.1 6638.6 6760.4 6796.8 6912.5 5088.3 5103.7 5107.0 5143.0 5149.1 5171.1 5211.2 5212.6 5236.3 5236.5 5759.5 5791.9 5800.4 5803.5 5804.6 6435.6 6545.1 6595.5 6641.6 6704.5 1760.9 1767.3 1769.7 1793.9 1798.2 1235.9 1266.9 1268.5 1274.8 1278.9 6079.2 6088.2 6126.5 6130.7 6144.8 6556.5 6590.3 6598.3 6639.2 6647.3 5849.6 6043.5 6074.5 6117.8 6166.3 3443.6 3462.3 3485.5 3532.3 3537.0 6905.9 6920.4 6927.0 6952.6 6953.0 6695.0 6780.6 6797.4 6837.8 6894.3 6905.3 6954.1 7007.2 7027.7 7051.0 6452.3 6539.0 6684.7 6687.7 6709.9 6572.5 6617.5 6643.9 6657.1 6665.3 6898.2 6957.9 6970.6 7012.2 7023.5 5035.5 5110.2 5141.7 5152.6 5167.5 6511.3 6569.9 6621.5 6690.2 6702.3 6307.3 6426.7 6497.8 6498.8 6499.5 6394.0 6443.7 6444.0 6455.9 6544.8 6305.9 6348.8 6359.2 6383.3 6429.2 6448.0 6502.9 6517.3 6531.5 6580.3 6256.0 6280.0 6302.5 6319.0 6356.8 15:29:26 INFO - PID 3745 | 15:29:26 INFO - PID 3745 | [#5] yui.html Cycles:180 Average:27668.01 Median:17652.34 stddev:41098.61 (232.8%) stddev-sans-first:41164.95 15:29:26 INFO - PID 3745 | Values: 951.4 981.2 982.3 1002.1 1009.9 22446.1 23617.5 24672.4 24818.5 24959.0 19389.3 20845.7 23622.2 23691.4 23735.4 1045.4 1045.5 1046.1 1049.7 1084.1 1067.1 1094.9 1101.0 1118.7 1118.8 1160.3 1163.3 1164.1 1164.4 1164.9 1153.8 1158.1 1159.4 1160.8 1163.2 836.1 842.2 845.2 849.2 849.6 18994.6 19265.5 19339.1 19438.8 20505.0 23259.0 23411.2 23723.9 23831.1 23883.2 18694.4 18744.8 18985.9 19025.2 19044.7 4008.9 4016.3 4056.0 4057.1 4062.1 156739.0 157304.0 158665.0 159845.0 160507.0 17106.7 17130.0 17339.6 17585.7 17602.2 30253.2 30631.1 30837.2 30854.1 31007.7 9060.0 9096.9 9181.8 9187.2 9190.5 4170.4 4215.3 4263.5 4268.6 4307.0 6091.4 6121.3 6166.7 6170.4 6183.3 1102.8 1128.6 1135.4 1142.0 1145.7 715.8 725.0 725.4 737.4 750.1 11828.5 12032.3 12806.4 13386.3 13653.7 726.9 732.0 738.1 741.7 748.4 5718.5 5723.7 5754.3 5838.5 5878.9 142667.0 145332.3 145387.0 146739.0 147600.5 116225.0 120603.0 121412.0 122426.4 127788.0 113667.0 114453.4 114638.0 115767.4 115859.4 10568.3 10867.9 10898.6 10911.9 11087.5 52169.0 54207.2 54814.0 55377.7 55929.7 66146.7 67613.0 68685.3 70162.3 70302.6 16916.7 16943.1 17085.9 17165.6 17177.6 19131.5 19363.5 19454.9 19472.5 19571.4 17288.2 17380.7 17394.1 17501.0 17702.5 16943.6 17060.2 17121.1 17136.5 17157.5 16229.5 16319.5 16326.2 16397.6 16399.3 13025.7 13213.2 13280.1 13339.2 13582.1 13111.6 13213.0 13267.7 13327.5 13558.9 15:29:26 INFO - PID 3745 | -------- Summary: end -------- 15:29:26 INFO - PID 3745 | 15:29:27 INFO - TEST-INFO | 3745: exit 0 15:29:27 INFO - TEST-OK | dromaeo_css | took 1110406ms 15:29:27 INFO - TEST-START | kraken 15:29:27 INFO - Initialising browser for kraken test... 15:29:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33590/getInfo.html -profile /tmp/tmpUKsXWe/profile 15:29:27 INFO - TEST-INFO | started process 4115 (/builds/slave/test/build/application/firefox/firefox http://localhost:33590/getInfo.html) 15:29:32 INFO - TEST-INFO | 4115: exit 0 15:29:32 INFO - Browser initialized. 15:29:32 INFO - Running cycle 1/1 for kraken test... 15:29:32 INFO - Using env: {'DISPLAY': ':0', 15:29:32 INFO - 'HOME': '/home/cltbld', 15:29:32 INFO - 'JSGC_DISABLE_POISONING': '1', 15:29:32 INFO - 'LANG': 'en_US.UTF-8', 15:29:32 INFO - 'LANGUAGE': 'en_US:en', 15:29:32 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 15:29:32 INFO - 'LOGNAME': 'cltbld', 15:29:32 INFO - 'MAIL': '/var/mail/cltbld', 15:29:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:29:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:29:32 INFO - 'MOZ_CRASHREPORTER': '1', 15:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:29:32 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 15:29:32 INFO - 'MOZ_NO_REMOTE': '1', 15:29:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:29:32 INFO - 'NO_EM_RESTART': '1', 15:29:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:29:32 INFO - 'PWD': '/builds/slave/test', 15:29:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:29:32 INFO - 'RUST_BACKTRACE': 'full', 15:29:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:29:32 INFO - 'SHELL': '/bin/bash', 15:29:32 INFO - 'SHLVL': '1', 15:29:32 INFO - 'TERM': 'linux', 15:29:32 INFO - 'TMOUT': '86400', 15:29:32 INFO - 'USER': 'cltbld', 15:29:32 INFO - 'XDG_SESSION_COOKIE': '930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783', 15:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:29:32 INFO - '_': '/tools/buildbot/bin/python'} 15:29:32 INFO - TEST-INFO | started process 4350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKsXWe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:29:33 INFO - PID 4350 | 15:29:33 INFO - PID 4350 | (/builds/slave/test/build/application/firefox/firefox:4402): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:29:33 INFO - PID 4350 | 15:29:43 INFO - PID 4350 | RSS: Main: 147988480 15:29:43 INFO - PID 4350 | 15:29:46 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33590/tests/kraken/driver.html?testName=audio-beat-detection) 15:29:47 INFO - PID 4350 | RSS: Main: 153149440 15:29:47 INFO - PID 4350 | 15:29:50 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33590/tests/kraken/driver.html?testName=audio-dft) 15:29:50 INFO - PID 4350 | RSS: Main: 153333760 15:29:50 INFO - PID 4350 | 15:29:53 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33590/tests/kraken/driver.html?testName=audio-fft) 15:29:54 INFO - PID 4350 | RSS: Main: 150343680 15:29:54 INFO - PID 4350 | 15:29:56 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33590/tests/kraken/driver.html?testName=audio-oscillator) 15:29:56 INFO - PID 4350 | RSS: Main: 150499328 15:29:56 INFO - PID 4350 | 15:29:58 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33590/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:29:59 INFO - PID 4350 | RSS: Main: 150851584 15:29:59 INFO - PID 4350 | 15:30:02 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33590/tests/kraken/driver.html?testName=imaging-darkroom) 15:30:03 INFO - PID 4350 | RSS: Main: 150650880 15:30:03 INFO - PID 4350 | 15:30:06 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33590/tests/kraken/driver.html?testName=imaging-desaturate) 15:30:07 INFO - PID 4350 | RSS: Main: 151740416 15:30:07 INFO - PID 4350 | 15:30:10 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33590/tests/kraken/driver.html?testName=json-parse-financial) 15:30:10 INFO - PID 4350 | RSS: Main: 153227264 15:30:10 INFO - PID 4350 | 15:30:12 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33590/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:30:12 INFO - PID 4350 | RSS: Main: 152903680 15:30:12 INFO - PID 4350 | 15:30:14 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:30:15 INFO - PID 4350 | RSS: Main: 153260032 15:30:15 INFO - PID 4350 | 15:30:17 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:30:17 INFO - PID 4350 | RSS: Main: 150024192 15:30:17 INFO - PID 4350 | 15:30:20 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:30:20 INFO - PID 4350 | RSS: Main: 150220800 15:30:20 INFO - PID 4350 | 15:30:23 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:30:24 INFO - PID 4350 | RSS: Main: 150949888 15:30:24 INFO - PID 4350 | 15:30:25 INFO - PID 4350 | Cycle 1(1): loaded http://localhost:33590/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33590/tests/kraken/driver.html?testName=ai-astar) 15:30:26 INFO - PID 4350 | RSS: Main: 152522752 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | __start_tp_report 15:30:26 INFO - PID 4350 | _x_x_mozilla_page_load 15:30:26 INFO - PID 4350 | _x_x_mozilla_page_load_details 15:30:26 INFO - PID 4350 | |i|pagename|runs| 15:30:26 INFO - PID 4350 | |0;ai-astar;106;106;105;105;109;108;108;108;111;106 15:30:26 INFO - PID 4350 | |1;audio-beat-detection;111;114;112;112;112;111;112;139;114;118 15:30:26 INFO - PID 4350 | |2;audio-dft;161;160;162;162;161;161;162;163;169;166 15:30:26 INFO - PID 4350 | |3;audio-fft;81;72;73;72;73;73;76;76;76;74 15:30:26 INFO - PID 4350 | |4;audio-oscillator;79;78;79;77;77;77;77;79;81;80 15:30:26 INFO - PID 4350 | |5;imaging-gaussian-blur;114;113;114;114;114;114;109;113;114;110 15:30:26 INFO - PID 4350 | |6;imaging-darkroom;148;152;150;151;150;148;149;151;150;148 15:30:26 INFO - PID 4350 | |7;imaging-desaturate;94;94;95;94;94;93;93;94;97;99 15:30:26 INFO - PID 4350 | |8;json-parse-financial;45;48;44;42;44;46;51;46;46;44 15:30:26 INFO - PID 4350 | |9;json-stringify-tinderbox;45;46;46;46;47;46;45;45;47;46 15:30:26 INFO - PID 4350 | |10;stanford-crypto-aes;70;70;70;70;74;72;75;70;72;72 15:30:26 INFO - PID 4350 | |11;stanford-crypto-ccm;106;109;107;106;108;104;104;101;110;118 15:30:26 INFO - PID 4350 | |12;stanford-crypto-pbkdf2;154;158;154;165;154;151;154;151;151;161 15:30:26 INFO - PID 4350 | |13;stanford-crypto-sha256-iterative;60;60;57;58;65;60;62;59;60;64 15:30:26 INFO - PID 4350 | __end_tp_report 15:30:26 INFO - PID 4350 | __start_cc_report 15:30:26 INFO - PID 4350 | _x_x_mozilla_cycle_collect,705 15:30:26 INFO - PID 4350 | __end_cc_report 15:30:26 INFO - PID 4350 | __startTimestamp1505601026174__endTimestamp 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | ------- Summary: start ------- 15:30:26 INFO - PID 4350 | Number of tests: 14 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#0] ai-astar Cycles:10 Average:107.20 Median:108.00 stddev:1.93 (1.8%) stddev-sans-first:2.00 15:30:26 INFO - PID 4350 | Values: 106.0 106.0 105.0 105.0 109.0 108.0 108.0 108.0 111.0 106.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#1] audio-beat-detection Cycles:10 Average:115.50 Median:113.00 stddev:8.51 (7.5%) stddev-sans-first:8.87 15:30:26 INFO - PID 4350 | Values: 111.0 114.0 112.0 112.0 112.0 111.0 112.0 139.0 114.0 118.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:2.75 (1.7%) stddev-sans-first:2.85 15:30:26 INFO - PID 4350 | Values: 161.0 160.0 162.0 162.0 161.0 161.0 162.0 163.0 169.0 166.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#3] audio-fft Cycles:10 Average:74.60 Median:75.00 stddev:2.76 (3.7%) stddev-sans-first:1.69 15:30:26 INFO - PID 4350 | Values: 81.0 72.0 73.0 72.0 73.0 73.0 76.0 76.0 76.0 74.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.50 15:30:26 INFO - PID 4350 | Values: 79.0 78.0 79.0 77.0 77.0 77.0 77.0 79.0 81.0 80.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#5] imaging-gaussian-blur Cycles:10 Average:112.90 Median:114.00 stddev:1.85 (1.6%) stddev-sans-first:1.92 15:30:26 INFO - PID 4350 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 109.0 113.0 114.0 110.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:1.42 (0.9%) stddev-sans-first:1.36 15:30:26 INFO - PID 4350 | Values: 148.0 152.0 150.0 151.0 150.0 148.0 149.0 151.0 150.0 148.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.89 (2.0%) stddev-sans-first:1.99 15:30:26 INFO - PID 4350 | Values: 94.0 94.0 95.0 94.0 94.0 93.0 93.0 94.0 97.0 99.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#8] json-parse-financial Cycles:10 Average:45.60 Median:46.00 stddev:2.50 (5.4%) stddev-sans-first:2.65 15:30:26 INFO - PID 4350 | Values: 45.0 48.0 44.0 42.0 44.0 46.0 51.0 46.0 46.0 44.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#9] json-stringify-tinderbox Cycles:10 Average:45.90 Median:46.00 stddev:0.74 (1.6%) stddev-sans-first:0.71 15:30:26 INFO - PID 4350 | Values: 45.0 46.0 46.0 46.0 47.0 46.0 45.0 45.0 47.0 46.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#10] stanford-crypto-aes Cycles:10 Average:71.50 Median:72.00 stddev:1.84 (2.6%) stddev-sans-first:1.87 15:30:26 INFO - PID 4350 | Values: 70.0 70.0 70.0 70.0 74.0 72.0 75.0 70.0 72.0 72.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#11] stanford-crypto-ccm Cycles:10 Average:107.30 Median:107.50 stddev:4.60 (4.3%) stddev-sans-first:4.85 15:30:26 INFO - PID 4350 | Values: 106.0 109.0 107.0 106.0 108.0 104.0 104.0 101.0 110.0 118.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:154.00 stddev:4.67 (3.0%) stddev-sans-first:4.93 15:30:26 INFO - PID 4350 | Values: 154.0 158.0 154.0 165.0 154.0 151.0 154.0 151.0 151.0 161.0 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.00 stddev:2.51 (4.2%) stddev-sans-first:2.65 15:30:26 INFO - PID 4350 | Values: 60.0 60.0 57.0 58.0 65.0 60.0 62.0 59.0 60.0 64.0 15:30:26 INFO - PID 4350 | -------- Summary: end -------- 15:30:26 INFO - PID 4350 | 15:30:26 INFO - PID 4350 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:30:26 INFO - TEST-INFO | 4350: exit 0 15:30:26 INFO - TEST-OK | kraken | took 59330ms 15:30:26 INFO - SUITE-END | took 1169s 15:30:27 INFO - Completed test suite (00:19:30) 15:30:27 INFO - javascript benchmark 15:30:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9044.527966369242, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3875.8643447479335, 3890.2997460457113, 3938.4879965604487, 3947.526296844377, 3952.446657467953, 6240.282367527736, 6315.115883776275, 6381.361863813617, 6384.297727250005, 6412.166418365612, 6302.1177035215105, 6302.905456418146, 6318.842028949279, 6323.873522529558, 6374.521910856681, 5618.887622247553, 5674.744636491368, 5679.602427830054, 5691.146328050784, 5762.769489220447, 5701.173329867188, 5712.22884910536, 5764.135379693038, 5804.854878628026, 5843.824685259449, 5561.360443549003, 5665.065264231397, 5751.079827227644, 5818.476337129658, 5872.207252020987, 5316.893662126775, 5659.377468478505, 5684.403137670526, 5758.856028599276, 5790.797322093748, 5651.491365777099, 5689.061304884689, 5746.540276777848, 5757.740901659394, 5781.566382521328, 6204.6587437690905, 6264.9686751566405, 6294.685265736694, 6355.872882542323, 6356.14192084072, 6783.6269005204695, 6803.047573339736, 6804.0, 6850.520463567503, 6858.451323894076, 6791.932080679179, 6816.556923799937, 6828.863422731567, 6962.338577835098, 6970.30296970304, 6317.178766760292, 6419.8395040123905, 6474.935250647481, 6495.025746138117, 6495.123158373606, 7089.432845372357, 7092.4680648951535, 7162.641867906584, 7172.426205903515, 7178.353948144588, 6762.661866906635, 6791.626460544619, 6798.388145066968, 6805.591664500146, 6809.5233333666165, 6910.343517365842, 6921.826954326182, 6923.6884340204815, 6939.965300173568, 6971.895421568681, 6762.425193858478, 6795.694193761293, 6805.795826125224, 6847.0, 6896.517243792886, 6735.461163106939, 6792.150981127359, 6823.351781580742, 6832.726690932406, 6907.309269073053, 4950.504949505021, 4968.950310496849, 5004.999000199975, 5008.073506401327, 5025.698458092526, 4465.620422264079, 4516.029053753458, 4528.750918699503, 4538.773061346986, 4541.182587134282, 6207.317195108534, 6211.503079753609, 6273.215848018997, 6287.088372186099, 6298.968505157445, 6669.899951500732, 6674.566153200027, 6756.560823546453, 6782.1861376635115, 6795.116634837439, 6278.717457714414, 6290.496760259169, 6377.394147555975, 6400.135981642512, 6408.903866442007, 5552.194931734876, 5608.439156084441, 5622.184783206412, 5624.268845050199, 5624.29696287964, 6990.335918087773, 7065.89401158983, 7109.92890071103, 7162.391196748231, 7163.42692584592, 6629.403353698191, 6718.294579069127, 6719.227288861844, 6722.462203023844, 6841.076454678555, 6993.8251543709775, 7000.0, 7001.054857594159, 7007.474439417166, 7032.683529241094, 6699.430548403246, 6808.148981377328, 6846.691898864464, 6851.143607049119, 6862.936244882051, 6878.65606719672, 6890.173179218526, 6953.617551034742, 6965.47758918073, 6965.79102626922, 6489.643069631215, 6595.94464885616, 6618.867622647616, 6621.635810030302, 6713.6643167842385, 6635.6350400728425, 6639.03733958583, 6690.531662783558, 6690.765823196165, 6704.463642908653, 6587.571807832475, 6649.734010639714, 6678.532502724957, 6678.666066696548, 6680.3987641112535, 6626.933730662825, 6695.598264104169, 6703.262641109572, 6796.422304104207, 6798.694058767466, 6403.07155462446, 6486.513511486752, 6491.870162596816, 6543.345665433419, 6546.738130474918], "value": 6260.90331550724, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [939.9718008459748, 950.3157726436963, 960.5245403525255, 989.4310771306498, 1003.4079892863209, 43936.78031609841, 44525.554744452544, 44570.554294457084, 44653.0, 44680.55319446805, 41359.58640413595, 41729.58270417295, 41824.58175418245, 41897.0, 42010.0, 7397.0, 7508.249175082503, 7520.661570229353, 7523.360514356286, 7525.397968162534, 7372.299631534996, 7449.143348514936, 7453.739119130832, 7455.589942553157, 7459.067616547932, 7981.680732770682, 8070.394720395964, 8080.353571714249, 8081.313088387494, 8084.919150808475, 7903.130655627876, 7992.400569957247, 8033.517988920654, 8062.113167551594, 8062.475939063942, 7993.0, 8026.759197224034, 8052.43632945694, 8058.274755272054, 8072.475289106189, 40498.39252411216, 41143.0, 41295.7935210325, 41361.79319103385, 41463.0, 3669.2478042001326, 3671.155634204148, 3680.208755117636, 3681.245344704329, 3692.7599706019023, 32928.67071329304, 33195.66804331974, 33947.83026084854, 33998.83000584981, 34249.48625770616, 5453.945460545384, 5476.863078423032, 5477.917831232535, 5515.227868098469, 5580.414056524047, 211108.0, 211460.99999999846, 211539.0, 212892.0, 214072.0, 53012.469875301525, 53117.0, 53215.20177197345, 53351.0, 53457.0, 55871.441285586625, 56180.71909640425, 56213.0, 56511.43488565144, 56665.0, 16866.241019154168, 17091.658166836594, 17116.40092596778, 17135.143242837807, 17137.0, 13800.585982420343, 13804.654883627989, 13805.723885522233, 13813.447462101403, 13820.308984550733, 15669.451569195024, 15797.36810527589, 15828.366865325257, 15846.0, 15929.920350398406, 5886.823395298063, 5907.793227237026, 5939.287285525678, 5954.612950158225, 6197.690115494207, 1086.3047649504324, 1094.9397783121844, 1098.6594155811724, 1103.5971870267294, 1118.278710231896, 25243.368915776886, 25336.239912802645, 25448.49103017929, 25485.3628659285, 25623.359416014748, 1177.611388241878, 1186.7626474705094, 1201.3692811274152, 1204.3978010994504, 1224.412282104577, 13246.668833279053, 13400.798988015187, 13483.52807651747, 13498.595042148554, 13615.18308901469, 275718.0, 277983.0, 278052.0, 278250.0, 278569.0, 51362.48637513652, 51652.48347516552, 58338.416615833296, 58718.706406467696, 58739.0, 1403.9508617198348, 1503.4662694743208, 1505.2699440771216, 1520.148716718641, 1523.5733994481564, 30267.394652107276, 30389.392212156075, 30428.391432171677, 30626.387472250877, 30996.791614356174, 39307.410388844764, 39548.40677389899, 39605.40591891181, 39647.2070558593, 39730.40404393994, 213546.0, 214000.0, 214014.0, 214281.0, 215147.0, 35164.296714066084, 36256.0, 36893.44659830051, 36971.44542831806, 37060.07349816276, 44571.554284458034, 45368.0, 45371.0, 45706.0, 45757.0, 33866.322673546885, 34374.31251375008, 34553.0, 34725.82637086798, 34807.0, 33940.321193575495, 34330.31339373248, 34612.65387346094, 34707.13232169115, 34719.4792078114, 39466.21067578575, 40012.39981400223, 40153.79923100366, 40429.79785101055, 40476.59523404728, 33574.66425335813, 33750.66249337475, 33868.0, 34172.14569635779, 34337.828310858284, 24624.384390390383, 25037.74962250427, 25394.365140870887, 25690.22929312049, 25828.612570811827], "value": 18453.18858141533, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.126613245463, 593.8159170657096, 598.9790357337494, 607.7568972411037, 621.5928566788754, 23280.0, 23968.280951571436, 24044.87977560114, 24050.27849164528, 24108.517829643395, 22584.322470325875, 22643.0, 22655.773442265574, 22761.544769104607, 24248.515029699396, 6640.767573134929, 6851.3491218334175, 6851.623160726158, 6852.931470685304, 6853.897191542131, 6609.570377925419, 6619.106420633225, 6716.395524402803, 6824.4199243064395, 6853.691583878713, 6807.455403567703, 6809.455243580502, 6810.727570897183, 6811.897821532681, 6815.454763618924, 6570.540062195648, 6760.695768690421, 6780.118584583997, 6801.523893327469, 6810.693518791666, 6232.594881332699, 6273.247210334789, 6288.779892703779, 6290.842728931813, 6329.873402531924, 29505.557416638552, 29694.851525742233, 29851.552226716398, 29941.101766947027, 30052.0, 2228.19784877444, 2241.2267767620147, 2246.3261021693424, 2255.0754190781863, 2256.187772401934, 20339.288124915558, 20695.27566535179, 20717.585648287102, 20909.26817561393, 20909.790902090936, 2482.3173627252468, 2505.1232068775967, 2540.0347867810297, 2573.8713064346707, 2582.109172335541, 138865.0, 142990.2850485741, 152786.0, 159388.0, 160404.0, 15090.74210873073, 15503.457378991681, 15902.840971590136, 15987.840121598867, 16044.197790110447, 24771.13301034455, 24773.876130619592, 24827.255182344557, 24879.253622391356, 24957.0, 10805.189610779224, 10867.619633312954, 10985.121190304757, 11070.335779853234, 11126.054285385833, 10142.492875356204, 10155.746106347253, 10203.0, 10290.794184116425, 10310.381377117397, 9504.667336643322, 9610.51947402627, 9661.488013116641, 9764.414135151772, 9777.168940640126, 2756.9385786472353, 2786.9442611147665, 2821.2523681224493, 2877.510823160068, 2926.2976885547314, 1044.5978298355035, 1046.9057784799404, 1054.1566746602687, 1061.8141825180717, 1082.1342925659442, 21407.78592214089, 21455.463613409476, 21753.45616359572, 21757.23849665286, 21882.671759923614, 1124.8481455003634, 1130.971725706864, 1132.592266783957, 1137.1016896651552, 1139.7264656482384, 11567.248128871597, 11686.532538698357, 11746.647600571996, 11849.644510664693, 11899.405029748477, 562404.0, 577051.0, 582061.0, 591101.0, 597214.0, 128269.0, 131113.34443327723, 131827.340863297, 134688.0, 135469.0, 1107.9058280046286, 1176.0297754352694, 1233.5929143382662, 1251.9186252893533, 1289.9161554498928, 22116.889415552818, 22369.105235791038, 22380.888095559418, 22390.850104476387, 22765.08939642462, 60960.69519652373, 65460.67269663621, 65473.67263163654, 65929.0, 67474.66262668655, 78697.0, 79423.0, 80312.59843700744, 82931.5853420729, 83511.0, 15285.235738213267, 15597.688046238785, 15636.530904072895, 15727.606809829846, 15768.211589420713, 24875.0, 25012.249632511055, 25137.87431062833, 25220.873895630404, 25389.238322850342, 19885.900570497055, 19974.0, 20026.499337516096, 20085.49786255355, 20452.897735511226, 17676.116194190497, 17683.469495915142, 17910.373136940143, 18700.345487908402, 18716.719249211, 20240.69638955446, 20248.392548223575, 20432.489187770425, 20438.28466003683, 20789.168433263105, 15339.309731061905, 15340.156291403633, 15391.923040384727, 15526.534203973899, 15528.844711553193, 19813.405597831512, 19905.502362441053, 20063.29778457747, 20072.49818754543, 20085.0], "value": 12854.785265064935, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.4855203574677, 1487.4347747855813, 1512.8033355663765, 1519.263157368676, 1520.125927591635, 16405.179741012947, 16976.0, 17005.31978720851, 17055.573610659707, 17075.48773536793, 16540.42108526202, 16624.418145364914, 16690.082045487525, 16695.91652041741, 16715.91642041791, 2836.489431902267, 2891.074856046066, 2932.66274378446, 2948.3218859662293, 2951.8228906265585, 2921.2988882668114, 2928.9414211715753, 2950.100219433072, 2952.4833154198036, 2963.955540666892, 2904.7966642335045, 2918.9124326270244, 2985.567092771547, 2988.5218365061596, 3008.7743419243534, 2900.8549572521288, 2914.28599993002, 2917.460269850074, 2943.8528073596235, 2944.1461976026926, 2833.065088520804, 2849.4443583501225, 2865.3409715765283, 2867.7275658812378, 2867.752527650479, 16598.83401165985, 16747.246373913204, 16829.495115146565, 16858.325666973305, 16945.830541694548, 8655.913440865637, 8901.821963560757, 8923.821523569492, 8934.28525717941, 8942.0, 5691.743871525791, 5880.235569375954, 5929.229200203989, 5940.316863560703, 6014.12795144706, 2124.447643612672, 2165.967510487344, 2172.6089303925446, 2215.8670479771104, 2216.116301144015, 30145.0, 30359.848200758854, 30413.087607371814, 30417.847910760527, 30445.543316850264, 7362.558246505227, 7426.14599321085, 7481.8877716834295, 7491.925080749123, 7649.38804895607, 16542.255598498097, 17068.743968840477, 19274.22903083889, 19286.4214073578, 19505.219791208478, 8437.578121094044, 8790.120987901286, 8790.208881200722, 8792.912070879209, 8796.648134074694, 7796.142424333319, 7955.2840244378285, 7973.800654983555, 8044.83910321802, 8062.153473885275, 5745.482906538432, 5819.127130930395, 5870.911936320958, 5925.9407405925385, 5936.436038576328, 1699.3967141664778, 1731.4978656189564, 1731.9393821216197, 1742.9564260893326, 1749.8162692917315, 969.9078587534173, 970.7087873638021, 988.41189492252, 993.036754348281, 993.8906720260766, 8232.917670823215, 8265.83468330642, 8266.462679925786, 8279.337652987746, 8282.668693252203, 791.0625908298684, 793.8094857234222, 800.9627532345627, 804.3967024731452, 812.544974814106, 5286.3920649125075, 5628.690422026828, 5632.408597097327, 5757.596968212269, 5840.182374467578, 24618.876905615714, 25850.095246666653, 25891.0, 26090.608640870403, 26139.0, 24377.0, 24982.750172498407, 25022.624660630107, 25667.35831604225, 25681.614775778376, 12164.2701437914, 12223.633291001284, 12367.93816030932, 12421.627351179299, 12471.438785254686, 8854.822903541764, 8910.287177025952, 8926.06276340975, 8979.416337938013, 8984.505852177932, 20852.895735521226, 21050.263240787113, 21485.0, 21492.0, 21925.890370548044, 21920.89039554792, 22378.0, 22473.550528989657, 22562.887185563966, 22982.540349192586, 12418.130730848754, 12561.874381256435, 12568.371581421075, 12574.245545267313, 12583.0, 15418.768718469008, 15471.0, 15601.141937193563, 15622.765658515358, 15627.687446250784, 12338.074644401526, 12371.814422783846, 12490.687732806753, 12526.060545458944, 12742.872571274169, 12315.0, 12341.420374958094, 12382.195157314745, 12382.195157314745, 12791.232526048467, 10563.366198028143, 10567.577296908037, 10639.468026598484, 10691.09125724322, 10696.197785165989, 7938.801529961797, 7974.641141148546, 7987.241212084843, 8012.799680008046, 8165.959170204111, 8036.598170091589, 8093.676252949816, 8121.8375632488205, 8164.428490005643, 8185.5497947611075], "value": 7317.801106785215, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5172172627224, 564.9604527683061, 570.7289037707093, 584.0742423259136, 585.7364186116246, 6202.410770976756, 6205.658688772116, 6213.502919766419, 6225.159603453532, 6317.494600431966, 6160.383961603838, 6185.783497577586, 6192.451887028243, 6218.25380954285, 6219.19150510433, 5127.282180494733, 5136.5890728741615, 5138.434772175057, 5150.768215430296, 5160.096983027974, 5113.565346945496, 5129.281900533928, 5134.074721979257, 5155.2524883892, 5168.7415629218385, 4754.572088512034, 4923.655344125913, 4924.950750492503, 4940.777665005084, 4947.802087916497, 4915.5330243626795, 4917.582005529534, 4921.966387058722, 4933.80264789408, 4936.815164360528, 4373.715708478939, 4448.243798554254, 4467.419235499397, 4472.843450479218, 4479.552044795527, 6039.912815693174, 6086.269647642267, 6088.726007329681, 6105.542084343692, 6106.633601983851, 5811.3316968548315, 5828.504577110951, 5832.562557808139, 5836.64980101191, 5845.795397161079, 6568.901466478007, 6576.276609572943, 6589.308122647149, 6603.009548567753, 6607.0, 5003.274525193827, 5012.523810238022, 5014.971930754186, 5019.372578427697, 5019.874503137451, 6571.141553424276, 6638.634875081869, 6760.391564759196, 6796.757070166833, 6912.516123871331, 5088.287639730441, 5103.668261562986, 5107.00413419387, 5142.965650266286, 5149.124648809711, 5171.120909445403, 5211.166213405837, 5212.55693266069, 5236.345456817898, 5236.528712415901, 5759.510441612426, 5791.88416231673, 5800.4489573490455, 5803.506701930383, 5804.622699524517, 6435.584171482266, 6545.05096760967, 6595.505337099737, 6641.634710090895, 6704.463642908556, 1760.8943463392238, 1767.3284152022406, 1769.672610567049, 1793.9282428702966, 1798.190814133619, 1235.873077323969, 1266.8859802617808, 1268.5475130975167, 1274.7698470975554, 1278.878506541877, 6079.209702738615, 6088.178095956989, 6126.479249263863, 6130.693465326716, 6144.754209831557, 6556.541042127101, 6590.340965903371, 6598.31742905556, 6639.236487803868, 6647.335266473314, 5849.561282903799, 6043.516518678495, 6074.54440916933, 6117.847053823601, 6166.321704612489, 3443.6384179661277, 3462.342154990544, 3485.4771784232566, 3532.315440265417, 3536.982315088408, 6905.89505679089, 6920.411765000032, 6927.0, 6952.617606031616, 6952.965235173791, 6694.9580377985185, 6780.627065511346, 6797.354251346114, 6837.829054273683, 6894.345037221456, 6905.309469053155, 6954.130733658293, 7007.229204787572, 7027.683754231072, 7051.048108505492, 6452.257990331172, 6539.0, 6684.685674888573, 6687.699053542505, 6709.865802683821, 6572.521182734038, 6617.536772425884, 6643.900341494785, 6657.101291325609, 6665.3001434850585, 6898.172219333712, 6957.851954427463, 6970.581765094111, 7012.211885969045, 7023.508354415142, 5035.546800787946, 5110.1568241239775, 5141.71720555373, 5152.5620322271525, 5167.509086636764, 6511.2512061113575, 6569.9014514783275, 6621.470282377494, 6690.230623478362, 6702.329767023259, 6307.306196318493, 6426.742930282736, 6497.805065848032, 6498.837529061622, 6499.4800415965665, 6394.0, 6443.74590831627, 6443.96778016107, 6455.870882582228, 6544.8363790905605, 6305.856008956976, 6348.777792777415, 6359.17330747, 6383.2978372378075, 6429.22849258092, 6448.032795080775, 6502.934970650233, 6517.315681853527, 6531.477481801539, 6580.276169621434, 6255.96872015637, 6280.026595877646, 6302.502111328074, 6318.968405157945, 6356.806901618934], "value": 5126.87702571364, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [951.3768481644526, 981.1905178227961, 982.3418309732479, 1002.0880998291556, 1009.8889122196559, 22446.102155913763, 23617.527649447, 24672.38319042025, 24818.50362992739, 24958.999999999978, 19389.32137375192, 20845.68731469029, 23622.173223937167, 23691.407714807137, 23735.40661483464, 1045.4459136657583, 1045.5295117197254, 1046.089901785444, 1049.7113293844216, 1084.105612869382, 1067.0503252105632, 1094.9069329107035, 1100.9889901100967, 1118.7370967822596, 1118.7818375416798, 1160.3386069940095, 1163.2671417007273, 1164.1385374822655, 1164.4177911044478, 1164.930104193747, 1153.81538953767, 1158.108256642389, 1159.3739380734394, 1160.7620437810272, 1163.2206421697483, 836.0844874862016, 842.2083241752733, 845.1970627903517, 849.1678155407674, 849.5582297205418, 18994.620107597908, 19265.518362040923, 19339.12973916163, 19438.80561194384, 20505.0, 23259.0, 23411.180608678784, 23723.881380592986, 23831.09351251913, 23883.164089256967, 18694.439166824883, 18744.812551874442, 18985.90507047456, 19025.238990440364, 19044.714329284932, 4008.939865902014, 4016.2770701273757, 4056.0, 4057.0871553900433, 4062.0860306431114, 156739.0, 157304.0, 158665.0, 159845.0, 160507.0, 17106.657866842594, 17130.0, 17339.56651083733, 17585.7362139568, 17602.207900644247, 30253.243668908453, 30631.081067568008, 30837.229069273446, 30854.074377768702, 31007.68992310048, 9060.0, 9096.8635470468, 9181.816363672822, 9187.2190863776, 9190.540472976458, 4170.416141740159, 4215.304474761691, 4263.531011588722, 4268.615824575803, 4306.956930430718, 6091.360407157274, 6121.265448146251, 6166.660833654102, 6170.382961703794, 6183.258009038944, 1102.8345748137683, 1128.6049882541208, 1135.4209353229912, 1141.9543218271342, 1145.6505765741529, 715.8138883890226, 725.0, 725.4015437264278, 737.4395459450856, 750.1410884537174, 11828.52685892572, 12032.338221397908, 12806.447108575592, 13386.330683465787, 13653.726925461633, 726.8509955459118, 731.9963400183071, 738.0663460722191, 741.6921977379327, 748.3975399803102, 5718.485336319751, 5723.6851973141875, 5754.252741488289, 5838.503727183237, 5878.911816322759, 142667.0, 145332.27333863263, 145387.0, 146739.0, 147600.52399476082, 116225.0, 120603.0, 121412.0, 122426.38786806187, 127788.0, 113667.0, 114453.4277328608, 114638.0, 115767.42116289365, 115859.42070289595, 10568.313059651406, 10867.945660271647, 10898.618548350769, 10911.890881091087, 11087.501062452047, 52169.0, 54207.18689219586, 54814.0, 55377.723111384184, 55929.720351397984, 66146.66926665336, 67613.0, 68685.31314686789, 70162.29837701557, 70302.64848675724, 16916.74624880603, 16943.068131252898, 17085.914570427067, 17165.57086072858, 17177.57056073558, 19131.521711957314, 19363.515912101746, 19454.90272548628, 19472.513187170433, 19571.412857614294, 17288.222030008932, 17380.652386952443, 17394.117998447146, 17501.03744294076, 17702.468925932244, 16943.576410589834, 17060.23228954725, 17121.143942802562, 17136.48590542286, 17157.485275441755, 16229.513114606581, 16319.510414687578, 16326.18369081565, 16397.590060248112, 16399.344026238818, 13025.674358141123, 13213.207207567577, 13280.070395072253, 13339.19964802115, 13582.117162384413, 13111.60665180046, 13213.0, 13267.734645307233, 13327.466901323838, 13558.93220533891], "value": 9823.852877780026, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1381.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 106.0, 105.0, 105.0, 109.0, 108.0, 108.0, 108.0, 111.0, 106.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 112.0, 112.0, 111.0, 112.0, 139.0, 114.0, 118.0], "value": 115.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 169.0, 166.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 72.0, 73.0, 72.0, 73.0, 73.0, 76.0, 76.0, 76.0, 74.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 79.0, 77.0, 77.0, 77.0, 77.0, 79.0, 81.0, 80.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 109.0, 113.0, 114.0, 110.0], "value": 112.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 152.0, 150.0, 151.0, 150.0, 148.0, 149.0, 151.0, 150.0, 148.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 93.0, 94.0, 97.0, 99.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 48.0, 44.0, 42.0, 44.0, 46.0, 51.0, 46.0, 46.0, 44.0], "value": 45.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 46.0, 47.0, 46.0, 45.0, 45.0, 47.0, 46.0], "value": 45.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 74.0, 72.0, 75.0, 70.0, 72.0, 72.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 109.0, 107.0, 106.0, 108.0, 104.0, 104.0, 101.0, 110.0, 118.0], "value": 107.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 158.0, 154.0, 165.0, 154.0, 151.0, 154.0, 151.0, 151.0, 161.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 57.0, 58.0, 65.0, 60.0, 62.0, 59.0, 60.0, 64.0], "value": 60.5, "unit": "score"}]}]} 15:30:27 INFO - Return code: 0 15:30:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:30:27 INFO - # TBPL SUCCESS # 15:30:27 INFO - Running post-action listener: _package_coverage_data 15:30:27 INFO - Running post-action listener: _resource_record_post_action 15:30:27 INFO - [mozharness: 2017-09-16 22:30:27.490438Z] Finished run-tests step (success) 15:30:27 INFO - Running post-run listener: _resource_record_post_run 15:30:27 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 8818688; Write bytes: 445239296; Read time: 2032; Write time: 495856 15:30:27 INFO - TinderboxPrint: CPU usage
13.1% 15:30:27 INFO - TinderboxPrint: I/O read bytes / time
8,818,688 / 2,032 15:30:27 INFO - TinderboxPrint: I/O write bytes / time
445,239,296 / 495,856 15:30:27 INFO - TinderboxPrint: CPU idle
8,231.8 (86.9%) 15:30:27 INFO - TinderboxPrint: CPU user
1,188.2 (12.5%) 15:30:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:30:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 151552; Read time: 0; Write time: 44 15:30:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:30:27 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8818688; Write bytes: 397791232; Read time: 2032; Write time: 472764 15:30:28 INFO - Running post-run listener: _upload_blobber_files 15:30:28 INFO - Blob upload gear active. 15:30:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:30:28 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 15:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:30:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:30:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:29 INFO - (blobuploader) - INFO - Done attempting. 15:30:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:30:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:36 INFO - (blobuploader) - INFO - Done attempting. 15:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:37 INFO - (blobuploader) - INFO - Done attempting. 15:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:30:38 INFO - (blobuploader) - INFO - Done attempting. 15:30:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:30:38 INFO - Return code: 0 15:30:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:30:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:30:38 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d6b98f2cfa3d1b283eed9e9456d358612e927a88ba444f1ed4ec002f9fd4435536c239d97df028f9a67676596b7537f63f19fdb2f33c0ddeacb80336dbb3d62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd8e9db41e40bdc285542f8b3fb16f7f25e748f7450e47cd033b488f6b3df681a7d243711c5c63c04adf53a1380eabd45bb6e7cf7676c8e927ef82aad5ae8bf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3b78e7e5d4f742171f702e9c5296ee19863a1acfb2dee38b1fb48cf130b4b5ba82c6c9eceaea73af69fd2f58045074de727a779c81688c800aae550db3e32", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55bd7be0d9dc56b8ec9466aa3025021160682bbd840991ffae8c25ecd05701a37ac6d4d170774545dd11475a1c5272d17d8c39245f79c639b43ef982dca7f91"} 15:30:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:30:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:30:38 INFO - Contents: 15:30:38 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d6b98f2cfa3d1b283eed9e9456d358612e927a88ba444f1ed4ec002f9fd4435536c239d97df028f9a67676596b7537f63f19fdb2f33c0ddeacb80336dbb3d62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd8e9db41e40bdc285542f8b3fb16f7f25e748f7450e47cd033b488f6b3df681a7d243711c5c63c04adf53a1380eabd45bb6e7cf7676c8e927ef82aad5ae8bf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3b78e7e5d4f742171f702e9c5296ee19863a1acfb2dee38b1fb48cf130b4b5ba82c6c9eceaea73af69fd2f58045074de727a779c81688c800aae550db3e32", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55bd7be0d9dc56b8ec9466aa3025021160682bbd840991ffae8c25ecd05701a37ac6d4d170774545dd11475a1c5272d17d8c39245f79c639b43ef982dca7f91"} 15:30:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:30:38 INFO - Copying logs to upload dir... 15:30:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:30:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.329717 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2017-09-16 15:30:38.515664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:30:38.523050) ========= 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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d6b98f2cfa3d1b283eed9e9456d358612e927a88ba444f1ed4ec002f9fd4435536c239d97df028f9a67676596b7537f63f19fdb2f33c0ddeacb80336dbb3d62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd8e9db41e40bdc285542f8b3fb16f7f25e748f7450e47cd033b488f6b3df681a7d243711c5c63c04adf53a1380eabd45bb6e7cf7676c8e927ef82aad5ae8bf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3b78e7e5d4f742171f702e9c5296ee19863a1acfb2dee38b1fb48cf130b4b5ba82c6c9eceaea73af69fd2f58045074de727a779c81688c800aae550db3e32", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55bd7be0d9dc56b8ec9466aa3025021160682bbd840991ffae8c25ecd05701a37ac6d4d170774545dd11475a1c5272d17d8c39245f79c639b43ef982dca7f91"} build_url:https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011654 build_url: 'https://queue.taskcluster.net/v1/task/TunYm-W5SkGt7UspvBxWuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d6b98f2cfa3d1b283eed9e9456d358612e927a88ba444f1ed4ec002f9fd4435536c239d97df028f9a67676596b7537f63f19fdb2f33c0ddeacb80336dbb3d62", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3dd8e9db41e40bdc285542f8b3fb16f7f25e748f7450e47cd033b488f6b3df681a7d243711c5c63c04adf53a1380eabd45bb6e7cf7676c8e927ef82aad5ae8bf", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecc3b78e7e5d4f742171f702e9c5296ee19863a1acfb2dee38b1fb48cf130b4b5ba82c6c9eceaea73af69fd2f58045074de727a779c81688c800aae550db3e32", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a55bd7be0d9dc56b8ec9466aa3025021160682bbd840991ffae8c25ecd05701a37ac6d4d170774545dd11475a1c5272d17d8c39245f79c639b43ef982dca7f91"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-16 15:30:38.550902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:30:38.551187) ========= 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=930c87414c89fc706ee2024c000001c6-1505599521.858182-73317783 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004362 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-16 15:30:38.635595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:30:38.635913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-16 15:30:38.636234) ========= ========= Total master_lag: 0.22 =========