builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1506956784.97 results: success (0) revision: b7b894f5fad8b4fb79e60b6bbdcce52da1281714 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:24.973038) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:24.973483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:24.973761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:24.992436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:24.992768) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-02 08:06:25-- 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% 26.1M=0s 2017-10-02 08:06:25 (26.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:25.153982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:25.157305) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020775 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:25.206923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 08:06:25.210273) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7b894f5fad8b4fb79e60b6bbdcce52da1281714 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b7b894f5fad8b4fb79e60b6bbdcce52da1281714 --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=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-02 08:06:25,441 truncating revision to first 12 chars 2017-10-02 08:06:25,441 Setting DEBUG logging. 2017-10-02 08:06:25,441 attempt 1/10 2017-10-02 08:06:25,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b7b894f5fad8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-02 08:06:26,515 unpacking tar archive at: mozilla-beta-b7b894f5fad8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405454 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-10-02 08:06:26.635408) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:26.635713) ========= script_repo_revision: b7b894f5fad8b4fb79e60b6bbdcce52da1281714 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:26.636104) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:26.636412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-02 08:06:26.650351) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 08:06:26.650730) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:06:27 INFO - MultiFileLogger online at 20171002 08:06:27 in /builds/slave/test 08:06:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 08:06:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:06:27 INFO - {'append_to_log': False, 08:06:27 INFO - 'base_work_dir': '/builds/slave/test', 08:06:27 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 08:06:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:06:27 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 08:06:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:06:27 INFO - 'code_coverage': False, 08:06:27 INFO - 'config_files': ('talos/linux_config.py',), 08:06:27 INFO - 'default_actions': ('clobber', 08:06:27 INFO - 'read-buildbot-config', 08:06:27 INFO - 'download-and-extract', 08:06:27 INFO - 'populate-webroot', 08:06:27 INFO - 'create-virtualenv', 08:06:27 INFO - 'install', 08:06:27 INFO - 'setup-mitmproxy', 08:06:27 INFO - 'run-tests'), 08:06:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:06:27 INFO - 'disable_ccov_upload': False, 08:06:27 INFO - 'disable_stylo': False, 08:06:27 INFO - 'download_minidump_stackwalk': True, 08:06:27 INFO - 'download_symbols': 'ondemand', 08:06:27 INFO - 'enable_stylo': False, 08:06:27 INFO - 'enable_webrender': False, 08:06:27 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 08:06:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:06:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:06:27 INFO - 'gecko_profile': False, 08:06:27 INFO - 'gecko_profile_interval': 0, 08:06:27 INFO - 'installer_path': 'installer.exe', 08:06:27 INFO - 'log_level': 'info', 08:06:27 INFO - 'log_name': 'talos', 08:06:27 INFO - 'log_to_console': True, 08:06:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:06:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:06:27 INFO - 'opt_config_files': (), 08:06:27 INFO - 'pip_index': False, 08:06:27 INFO - 'suite': 'dromaeojs-e10s', 08:06:27 INFO - 'system_bits': '32', 08:06:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:06:27 INFO - 'title': 'talos-linux64-ix-023', 08:06:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:06:27 INFO - 'use_talos_json': True, 08:06:27 INFO - 'verify': 'False', 08:06:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:06:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:06:27 INFO - 'work_dir': 'build'} 08:06:27 INFO - [mozharness: 2017-10-02 15:06:27.023958Z] Running clobber step. 08:06:27 INFO - Running pre-action listener: _resource_record_pre_action 08:06:27 INFO - Running main action method: clobber 08:06:27 INFO - rmtree: /builds/slave/test/build 08:06:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:06:28 INFO - Running post-action listener: _resource_record_post_action 08:06:28 INFO - [mozharness: 2017-10-02 15:06:28.544598Z] Finished clobber step (success) 08:06:28 INFO - [mozharness: 2017-10-02 15:06:28.544695Z] Running read-buildbot-config step. 08:06:28 INFO - Running pre-action listener: _resource_record_pre_action 08:06:28 INFO - Running main action method: read_buildbot_config 08:06:28 INFO - Using buildbot properties: 08:06:28 INFO - { 08:06:28 INFO - "project": "", 08:06:28 INFO - "product": "firefox", 08:06:28 INFO - "who": "ryanvm@gmail.com", 08:06:28 INFO - "installer_path": "public/build/target.tar.bz2", 08:06:28 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 08:06:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 08:06:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 08:06:28 INFO - "stage_platform": "linux64", 08:06:28 INFO - "basedir": "/builds/slave/test", 08:06:28 INFO - "buildnumber": 144, 08:06:28 INFO - "platform": "ubuntu64_hw", 08:06:28 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:06:28 INFO - "slavebuilddir": "test", 08:06:28 INFO - "taskId": "ePbz1M_jSSuKB7H7Mjn49Q", 08:06:28 INFO - "branch": "mozilla-beta", 08:06:28 INFO - "script_repo_revision": "production", 08:06:28 INFO - "revision": "b7b894f5fad8b4fb79e60b6bbdcce52da1281714", 08:06:28 INFO - "slavename": "talos-linux64-ix-023", 08:06:28 INFO - "repo_path": "releases/mozilla-beta" 08:06:28 INFO - } 08:06:28 INFO - Finding installer, test and symbols from parent task. 08:06:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePbz1M_jSSuKB7H7Mjn49Q'}, attempt #1 08:06:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ePbz1M_jSSuKB7H7Mjn49Q'}, attempt #1 08:06:32 INFO - Task dependencies: AjYC5gc0Qi-FnrVya_yOhg 08:06:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg'}, attempt #1 08:06:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 08:06:32 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.test_packages.json 08:06:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.crashreporter-symbols.zip 08:06:32 INFO - Running post-action listener: _resource_record_post_action 08:06:32 INFO - [mozharness: 2017-10-02 15:06:32.985622Z] Finished read-buildbot-config step (success) 08:06:32 INFO - [mozharness: 2017-10-02 15:06:32.985844Z] Running download-and-extract step. 08:06:32 INFO - Running pre-action listener: _resource_record_pre_action 08:06:32 INFO - Running main action method: download_and_extract 08:06:32 INFO - mkdir: /builds/slave/test/build/tests 08:06: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')]} 08:06:32 INFO - trying https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.test_packages.json 08:06:32 INFO - Downloading https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:06:33 INFO - Downloaded 989 bytes. 08:06:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:06:33 INFO - Using the following test package requirements: 08:06:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:06:33 INFO - u'common': [u'target.common.tests.zip'], 08:06:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:06:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:06:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:06:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:06:33 INFO - u'mozbase': [u'target.common.tests.zip'], 08:06:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:06:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:06:33 INFO - u'web-platform': [u'target.common.tests.zip', 08:06:33 INFO - u'target.web-platform.tests.tar.gz'], 08:06:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:06:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 08:06:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.common.tests.zip 08:06:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:06:33 INFO - Fetch https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.common.tests.zip into memory 08:06:34 INFO - Content-Length response header: 55180027 08:06:34 INFO - Bytes received: 55180027 08:06:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.talos.tests.zip 08:06:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:06:45 INFO - Fetch https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.talos.tests.zip into memory 08:06:46 INFO - Content-Length response header: 14509184 08:06:46 INFO - Bytes received: 14509184 08:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:46 INFO - trying https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 08:06:46 INFO - Downloading https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:06:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:06:47 INFO - Downloaded 53482618 bytes. 08:06:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 08:06:47 INFO - mkdir: /builds/slave/test/properties 08:06:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:06:47 INFO - Writing to file /builds/slave/test/properties/build_url 08:06:47 INFO - Contents: 08:06:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 08:06:47 INFO - Running post-action listener: _resource_record_post_action 08:06:47 INFO - Running post-action listener: find_tests_for_verification 08:06:47 INFO - Running post-action listener: set_extra_try_arguments 08:06:47 INFO - [mozharness: 2017-10-02 15:06:47.348831Z] Finished download-and-extract step (success) 08:06:47 INFO - [mozharness: 2017-10-02 15:06:47.348929Z] Running populate-webroot step. 08:06:47 INFO - Running pre-action listener: _resource_record_pre_action 08:06:47 INFO - Running main action method: populate_webroot 08:06:47 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:06:47 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['tresize', 08:06:47 INFO - 'tcanvasmark']}, 08:06:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:06:47 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['dromaeo_css', 08:06:47 INFO - 'kraken']}, 08:06:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:47 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:06:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'tests': ['damp', 'tps']}, 08:06:47 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['damp', 'tps']}, 08:06:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:06:47 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['dromaeo_dom']}, 08:06:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:06:47 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['basic_compositor_video', 08:06:47 INFO - 'glvideo']}, 08:06:47 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:06:47 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['ts_paint_webext', 08:06:47 INFO - 'tp5o_webext']}, 08:06:47 INFO - 'other-e10s': {'tests': ['a11yr', 08:06:47 INFO - 'ts_paint', 08:06:47 INFO - 'tpaint', 08:06:47 INFO - 'sessionrestore', 08:06:47 INFO - 'sessionrestore_many_windows', 08:06:47 INFO - 'sessionrestore_no_auto_restore', 08:06:47 INFO - 'tabpaint']}, 08:06:47 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['a11yr', 08:06:47 INFO - 'ts_paint', 08:06:47 INFO - 'tpaint', 08:06:47 INFO - 'sessionrestore', 08:06:47 INFO - 'sessionrestore_many_windows', 08:06:47 INFO - 'sessionrestore_no_auto_restore', 08:06:47 INFO - 'tabpaint']}, 08:06:47 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 08:06:47 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 08:06:47 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['perf_reftest_singletons']}, 08:06:47 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['bloom_basic']}, 08:06:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:06:47 INFO - 'tsvgr_opacity', 08:06:47 INFO - 'tart', 08:06:47 INFO - 'tscrollx', 08:06:47 INFO - 'tsvg_static']}, 08:06:47 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['tsvgx', 08:06:47 INFO - 'tsvgr_opacity', 08:06:47 INFO - 'tart', 08:06:47 INFO - 'tscrollx', 08:06:47 INFO - 'tsvg_static']}, 08:06:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:06:47 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo'], 08:06:47 INFO - 'tests': ['tp5o']}, 08:06:47 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:06:47 INFO - 'talos_options': ['--mitmproxy', 08:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:06:47 INFO - '--firstNonBlankPaint'], 08:06:47 INFO - 'tests': ['tp6_google', 08:06:47 INFO - 'tp6_youtube', 08:06:47 INFO - 'tp6_amazon', 08:06:47 INFO - 'tp6_facebook']}, 08:06:47 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo', 08:06:47 INFO - '--mitmproxy', 08:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:06:47 INFO - '--firstNonBlankPaint'], 08:06:47 INFO - 'tests': ['tp6_google', 08:06:47 INFO - 'tp6_youtube', 08:06:47 INFO - 'tp6_amazon', 08:06:47 INFO - 'tp6_facebook']}, 08:06:47 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 08:06:47 INFO - 'talos_options': ['--stylo-threads=1', 08:06:47 INFO - '--mitmproxy', 08:06:47 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 08:06:47 INFO - '--firstNonBlankPaint'], 08:06:47 INFO - 'tests': ['tp6_google', 08:06:47 INFO - 'tp6_youtube', 08:06:47 INFO - 'tp6_amazon', 08:06:47 INFO - 'tp6_facebook']}, 08:06:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--xperf_path', 08:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:47 INFO - 'tests': ['tp5n']}, 08:06:47 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 08:06:47 INFO - 'talos_options': ['--disable-stylo', 08:06:47 INFO - '--xperf_path', 08:06:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:06:47 INFO - 'tests': ['tp5n']}}} 08:06:47 INFO - Running post-action listener: _resource_record_post_action 08:06:47 INFO - [mozharness: 2017-10-02 15:06:47.363754Z] Finished populate-webroot step (success) 08:06:47 INFO - [mozharness: 2017-10-02 15:06:47.363843Z] Running create-virtualenv step. 08:06:47 INFO - Running pre-action listener: _resource_record_pre_action 08:06:47 INFO - Running main action method: create_virtualenv 08:06:47 INFO - Creating virtualenv /builds/slave/test/build/venv 08:06:47 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:06:47 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 08:06:47 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:06:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:06:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:06:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:06:48 INFO - Installing pip...............done. 08:06:48 INFO - Return code: 0 08:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:06:48 INFO - Reading from file tmpfile_stdout 08:06:48 INFO - Output received: 08:06:48 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 08:06:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:06:48 INFO - Using env: {'DISPLAY': ':0', 08:06:48 INFO - 'HOME': '/home/cltbld', 08:06:48 INFO - 'LANG': 'en_US.UTF-8', 08:06:48 INFO - 'LANGUAGE': 'en_US:en', 08:06:48 INFO - 'LOGNAME': 'cltbld', 08:06:48 INFO - 'MAIL': '/var/mail/cltbld', 08:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:48 INFO - 'MOZ_NO_REMOTE': '1', 08:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:48 INFO - 'NO_EM_RESTART': '1', 08:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:48 INFO - 'PWD': '/builds/slave/test', 08:06:48 INFO - 'SHELL': '/bin/bash', 08:06:48 INFO - 'SHLVL': '1', 08:06:48 INFO - 'TERM': 'linux', 08:06:48 INFO - 'TMOUT': '86400', 08:06:48 INFO - 'USER': 'cltbld', 08:06:48 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:48 INFO - '_': '/tools/buildbot/bin/python'} 08:06:49 INFO - Ignoring indexes: http://pypi.python.org/simple/ 08:06:49 INFO - Downloading/unpacking pip>=1.5 08:06:49 INFO - Running setup.py egg_info for package pip 08:06:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:06:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:06:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:06:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:06:49 INFO - Installing collected packages: pip 08:06:49 INFO - Found existing installation: pip 1.1 08:06:49 INFO - Uninstalling pip: 08:06:49 INFO - Successfully uninstalled pip 08:06:49 INFO - Running setup.py install for pip 08:06:49 INFO - warning: no files found matching 'pip/cacert.pem' 08:06:49 INFO - warning: no files found matching '*.html' under directory 'docs' 08:06:49 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 08:06:49 INFO - no previously-included directories found matching 'docs/_build/_sources' 08:06:49 INFO - Installing pip script to /builds/slave/test/build/venv/bin 08:06:49 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 08:06:49 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 08:06:49 INFO - Successfully installed pip 08:06:49 INFO - Cleaning up... 08:06:49 INFO - Return code: 0 08:06:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:06:49 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')]} 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:49 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')]} 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:49 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:49 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 08:06:49 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 08:06:49 INFO - Using env: {'DISPLAY': ':0', 08:06:49 INFO - 'HOME': '/home/cltbld', 08:06:49 INFO - 'LANG': 'en_US.UTF-8', 08:06:49 INFO - 'LANGUAGE': 'en_US:en', 08:06:49 INFO - 'LOGNAME': 'cltbld', 08:06:49 INFO - 'MAIL': '/var/mail/cltbld', 08:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:49 INFO - 'MOZ_NO_REMOTE': '1', 08:06:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:49 INFO - 'NO_EM_RESTART': '1', 08:06:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:49 INFO - 'PWD': '/builds/slave/test', 08:06:49 INFO - 'SHELL': '/bin/bash', 08:06:49 INFO - 'SHLVL': '1', 08:06:49 INFO - 'TERM': 'linux', 08:06:49 INFO - 'TMOUT': '86400', 08:06:49 INFO - 'USER': 'cltbld', 08:06:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:49 INFO - '_': '/tools/buildbot/bin/python'} 08:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:49 INFO - Downloading/unpacking psutil>=3.1.1 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:51 INFO - Installing collected packages: psutil 08:06:51 INFO - Running setup.py install for psutil 08:06:51 INFO - building 'psutil._psutil_linux' extension 08:06:51 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 08:06:51 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 08:06:51 INFO - building 'psutil._psutil_posix' extension 08:06:51 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 08:06:51 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 08:06:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:06:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:06:51 INFO - Successfully installed psutil 08:06:51 INFO - Cleaning up... 08:06:51 INFO - Return code: 0 08:06:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:51 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:51 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 08:06:51 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 08:06:51 INFO - Using env: {'DISPLAY': ':0', 08:06:51 INFO - 'HOME': '/home/cltbld', 08:06:51 INFO - 'LANG': 'en_US.UTF-8', 08:06:51 INFO - 'LANGUAGE': 'en_US:en', 08:06:51 INFO - 'LOGNAME': 'cltbld', 08:06:51 INFO - 'MAIL': '/var/mail/cltbld', 08:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:51 INFO - 'MOZ_NO_REMOTE': '1', 08:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:51 INFO - 'NO_EM_RESTART': '1', 08:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:51 INFO - 'PWD': '/builds/slave/test', 08:06:51 INFO - 'SHELL': '/bin/bash', 08:06:51 INFO - 'SHLVL': '1', 08:06:51 INFO - 'TERM': 'linux', 08:06:51 INFO - 'TMOUT': '86400', 08:06:51 INFO - 'USER': 'cltbld', 08:06:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:51 INFO - '_': '/tools/buildbot/bin/python'} 08:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:06:52 INFO - Installing collected packages: mozsystemmonitor 08:06:52 INFO - Running setup.py install for mozsystemmonitor 08:06:53 INFO - Successfully installed mozsystemmonitor 08:06:53 INFO - Cleaning up... 08:06:53 INFO - Return code: 0 08:06:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:06:53 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')]} 08:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:53 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')]} 08:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:53 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:53 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 08:06:53 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 08:06:53 INFO - Using env: {'DISPLAY': ':0', 08:06:53 INFO - 'HOME': '/home/cltbld', 08:06:53 INFO - 'LANG': 'en_US.UTF-8', 08:06:53 INFO - 'LANGUAGE': 'en_US:en', 08:06:53 INFO - 'LOGNAME': 'cltbld', 08:06:53 INFO - 'MAIL': '/var/mail/cltbld', 08:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:53 INFO - 'MOZ_NO_REMOTE': '1', 08:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:53 INFO - 'NO_EM_RESTART': '1', 08:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:53 INFO - 'PWD': '/builds/slave/test', 08:06:53 INFO - 'SHELL': '/bin/bash', 08:06:53 INFO - 'SHLVL': '1', 08:06:53 INFO - 'TERM': 'linux', 08:06:53 INFO - 'TMOUT': '86400', 08:06:53 INFO - 'USER': 'cltbld', 08:06:53 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:53 INFO - '_': '/tools/buildbot/bin/python'} 08:06:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:54 INFO - Downloading/unpacking jsonschema==2.5.1 08:06:54 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 08:06:54 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 08:06:54 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 08:06:54 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 08:06:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:06:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:56 INFO - Downloading functools32-3.2.3-2.tar.gz 08:06:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:06:56 INFO - warning: no files found matching '*.txt' 08:06:56 INFO - no previously-included directories found matching 'build' 08:06:56 INFO - no previously-included directories found matching 'dist' 08:06:56 INFO - no previously-included directories found matching '.git*' 08:06:56 INFO - Installing collected packages: jsonschema, functools32 08:06:56 INFO - Running setup.py install for functools32 08:06:56 INFO - warning: no files found matching '*.txt' 08:06:56 INFO - no previously-included directories found matching 'build' 08:06:56 INFO - no previously-included directories found matching 'dist' 08:06:56 INFO - no previously-included directories found matching '.git*' 08:06:56 INFO - Successfully installed jsonschema functools32 08:06:56 INFO - Cleaning up... 08:06:56 INFO - Return code: 0 08:06:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06: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')]} 08:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:56 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:56 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 08:06:56 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 08:06:56 INFO - Using env: {'DISPLAY': ':0', 08:06:56 INFO - 'HOME': '/home/cltbld', 08:06:56 INFO - 'LANG': 'en_US.UTF-8', 08:06:56 INFO - 'LANGUAGE': 'en_US:en', 08:06:56 INFO - 'LOGNAME': 'cltbld', 08:06:56 INFO - 'MAIL': '/var/mail/cltbld', 08:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:56 INFO - 'MOZ_NO_REMOTE': '1', 08:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:56 INFO - 'NO_EM_RESTART': '1', 08:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:56 INFO - 'PWD': '/builds/slave/test', 08:06:56 INFO - 'SHELL': '/bin/bash', 08:06:56 INFO - 'SHLVL': '1', 08:06:56 INFO - 'TERM': 'linux', 08:06:56 INFO - 'TMOUT': '86400', 08:06:56 INFO - 'USER': 'cltbld', 08:06:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:56 INFO - '_': '/tools/buildbot/bin/python'} 08:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:06:56 INFO - Cleaning up... 08:06:56 INFO - Return code: 0 08:06:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:06: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')]} 08:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06: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')]} 08:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:56 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:56 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 08:06:56 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 08:06:56 INFO - Using env: {'DISPLAY': ':0', 08:06:56 INFO - 'HOME': '/home/cltbld', 08:06:56 INFO - 'LANG': 'en_US.UTF-8', 08:06:56 INFO - 'LANGUAGE': 'en_US:en', 08:06:56 INFO - 'LOGNAME': 'cltbld', 08:06:56 INFO - 'MAIL': '/var/mail/cltbld', 08:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:56 INFO - 'MOZ_NO_REMOTE': '1', 08:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:56 INFO - 'NO_EM_RESTART': '1', 08:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:56 INFO - 'PWD': '/builds/slave/test', 08:06:56 INFO - 'SHELL': '/bin/bash', 08:06:56 INFO - 'SHLVL': '1', 08:06:56 INFO - 'TERM': 'linux', 08:06:56 INFO - 'TMOUT': '86400', 08:06:56 INFO - 'USER': 'cltbld', 08:06:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:56 INFO - '_': '/tools/buildbot/bin/python'} 08:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:06:56 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 08:06:56 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 08:06:56 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 08:06:56 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 08:06:57 INFO - Downloading blobuploader-1.2.4.tar.gz 08:06:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:06:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:06:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:06:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:06:58 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 08:06:58 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 08:06:58 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 08:06:58 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 08:06:58 INFO - Downloading docopt-0.6.1.tar.gz 08:06:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:06:58 INFO - Installing collected packages: blobuploader, requests, docopt 08:06:58 INFO - Running setup.py install for blobuploader 08:06:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:06:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:06:58 INFO - Running setup.py install for requests 08:06:58 INFO - Running setup.py install for docopt 08:06:59 INFO - Successfully installed blobuploader requests docopt 08:06:59 INFO - Cleaning up... 08:06:59 INFO - Return code: 0 08:06:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:06:59 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:06:59 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 08:06:59 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 08:06:59 INFO - Using env: {'DISPLAY': ':0', 08:06:59 INFO - 'HOME': '/home/cltbld', 08:06:59 INFO - 'LANG': 'en_US.UTF-8', 08:06:59 INFO - 'LANGUAGE': 'en_US:en', 08:06:59 INFO - 'LOGNAME': 'cltbld', 08:06:59 INFO - 'MAIL': '/var/mail/cltbld', 08:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:06:59 INFO - 'MOZ_NO_REMOTE': '1', 08:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:06:59 INFO - 'NO_EM_RESTART': '1', 08:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:06:59 INFO - 'PWD': '/builds/slave/test', 08:06:59 INFO - 'SHELL': '/bin/bash', 08:06:59 INFO - 'SHLVL': '1', 08:06:59 INFO - 'TERM': 'linux', 08:06:59 INFO - 'TMOUT': '86400', 08:06:59 INFO - 'USER': 'cltbld', 08:06:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:06:59 INFO - '_': '/tools/buildbot/bin/python'} 08:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:06:59 INFO - Running setup.py (path:/tmp/pip-7zdBVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:06:59 INFO - Running setup.py (path:/tmp/pip-21fwNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:06:59 INFO - Running setup.py (path:/tmp/pip-wl1ahq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:06:59 INFO - Running setup.py (path:/tmp/pip-DhnO1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:06:59 INFO - Running setup.py (path:/tmp/pip-7xQihx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:06:59 INFO - Running setup.py (path:/tmp/pip-6Eo41z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:06:59 INFO - Running setup.py (path:/tmp/pip-rPBobO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:06:59 INFO - Running setup.py (path:/tmp/pip-rAzOvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:06:59 INFO - Running setup.py (path:/tmp/pip-nccOy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:06:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:06:59 INFO - Running setup.py (path:/tmp/pip-Rgg3uV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:00 INFO - Running setup.py (path:/tmp/pip-4CcRXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:00 INFO - Running setup.py (path:/tmp/pip-L6wTRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:00 INFO - Running setup.py (path:/tmp/pip-5H0PsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:00 INFO - Running setup.py (path:/tmp/pip-YEduVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:00 INFO - Running setup.py (path:/tmp/pip-uQ3GSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:00 INFO - Running setup.py (path:/tmp/pip-RfeZVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:00 INFO - Running setup.py (path:/tmp/pip-qyhX20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:07:00 INFO - Running setup.py install for manifestparser 08:07:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:07:00 INFO - Running setup.py install for mozcrash 08:07:00 INFO - Running setup.py install for mozdebug 08:07:00 INFO - Running setup.py install for mozdevice 08:07:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:07:00 INFO - Running setup.py install for mozfile 08:07:01 INFO - Running setup.py install for mozhttpd 08:07:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozinfo 08:07:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozInstall 08:07:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozleak 08:07:01 INFO - Running setup.py install for mozlog 08:07:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for moznetwork 08:07:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozprocess 08:07:01 INFO - Running setup.py install for mozprofile 08:07:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozrunner 08:07:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:07:01 INFO - Running setup.py install for mozscreenshot 08:07:02 INFO - Running setup.py install for moztest 08:07:02 INFO - Running setup.py install for mozversion 08:07:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:07:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:07:02 INFO - Cleaning up... 08:07:02 INFO - Return code: 0 08:07:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07: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')]} 08:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07: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')]} 08:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:02 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:07:02 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 08:07:02 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 08:07:02 INFO - Using env: {'DISPLAY': ':0', 08:07:02 INFO - 'HOME': '/home/cltbld', 08:07:02 INFO - 'LANG': 'en_US.UTF-8', 08:07:02 INFO - 'LANGUAGE': 'en_US:en', 08:07:02 INFO - 'LOGNAME': 'cltbld', 08:07:02 INFO - 'MAIL': '/var/mail/cltbld', 08:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:02 INFO - 'MOZ_NO_REMOTE': '1', 08:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:02 INFO - 'NO_EM_RESTART': '1', 08:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:02 INFO - 'PWD': '/builds/slave/test', 08:07:02 INFO - 'SHELL': '/bin/bash', 08:07:02 INFO - 'SHLVL': '1', 08:07:02 INFO - 'TERM': 'linux', 08:07:02 INFO - 'TMOUT': '86400', 08:07:02 INFO - 'USER': 'cltbld', 08:07:02 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:02 INFO - '_': '/tools/buildbot/bin/python'} 08:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:07:02 INFO - Running setup.py (path:/tmp/pip-CzJIF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:07:02 INFO - Running setup.py (path:/tmp/pip-k_uwrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:07:02 INFO - Running setup.py (path:/tmp/pip-mImpGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:07:02 INFO - Running setup.py (path:/tmp/pip-8ary5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:07:02 INFO - Running setup.py (path:/tmp/pip-TaOUVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:07:02 INFO - Running setup.py (path:/tmp/pip-KKT0cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:07:02 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)) 08:07:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:07:02 INFO - Running setup.py (path:/tmp/pip-ouWrAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:07:03 INFO - Running setup.py (path:/tmp/pip-N_j3IX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:07:03 INFO - Running setup.py (path:/tmp/pip-YXmvwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:07:03 INFO - Running setup.py (path:/tmp/pip-IyEzKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:07:03 INFO - Running setup.py (path:/tmp/pip-RfLkyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:07:03 INFO - Running setup.py (path:/tmp/pip-eBImFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:07:03 INFO - Running setup.py (path:/tmp/pip-Nj8o65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:07:03 INFO - Running setup.py (path:/tmp/pip-YQcFI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:03 INFO - Running setup.py (path:/tmp/pip-iebXM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:07:03 INFO - Running setup.py (path:/tmp/pip-P0RM96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:07:03 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)) 08:07:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:07:03 INFO - Running setup.py (path:/tmp/pip-scSVPT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:07:03 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)) 08:07:03 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)) 08:07:03 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)) 08:07:03 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)) 08:07:03 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)) 08:07:03 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)) 08:07:03 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)) 08:07:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:07:03 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 08:07:03 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 08:07:03 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 08:07:03 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 08:07:04 INFO - Downloading blessings-1.6.tar.gz 08:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:07:04 INFO - Installing collected packages: blessings 08:07:04 INFO - Running setup.py install for blessings 08:07:05 INFO - Successfully installed blessings 08:07:05 INFO - Cleaning up... 08:07:05 INFO - Return code: 0 08:07:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:07:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:05 INFO - Reading from file tmpfile_stdout 08:07:05 INFO - Current package versions: 08:07:05 INFO - argparse == 1.2.1 08:07:05 INFO - blessings == 1.6 08:07:05 INFO - blobuploader == 1.2.4 08:07:05 INFO - docopt == 0.6.1 08:07:05 INFO - functools32 == 3.2.3-2 08:07:05 INFO - jsonschema == 2.5.1 08:07:05 INFO - manifestparser == 1.1 08:07:05 INFO - mozInstall == 1.13 08:07:05 INFO - mozcrash == 1.0 08:07:05 INFO - mozdebug == 0.1 08:07:05 INFO - mozdevice == 0.51 08:07:05 INFO - mozfile == 1.2 08:07:05 INFO - mozhttpd == 0.7 08:07:05 INFO - mozinfo == 0.10 08:07:05 INFO - mozleak == 0.1 08:07:05 INFO - mozlog == 3.5 08:07:05 INFO - moznetwork == 0.27 08:07:05 INFO - mozprocess == 0.25 08:07:05 INFO - mozprofile == 0.28 08:07:05 INFO - mozrunner == 6.13 08:07:05 INFO - mozscreenshot == 0.1 08:07:05 INFO - mozsystemmonitor == 0.3 08:07:05 INFO - moztest == 0.8 08:07:05 INFO - mozversion == 1.4 08:07:05 INFO - psutil == 3.1.1 08:07:05 INFO - requests == 1.2.3 08:07:05 INFO - wsgiref == 0.1.2 08:07:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:05 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:07:05 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 08:07:05 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 08:07:05 INFO - Using env: {'DISPLAY': ':0', 08:07:05 INFO - 'HOME': '/home/cltbld', 08:07:05 INFO - 'LANG': 'en_US.UTF-8', 08:07:05 INFO - 'LANGUAGE': 'en_US:en', 08:07:05 INFO - 'LOGNAME': 'cltbld', 08:07:05 INFO - 'MAIL': '/var/mail/cltbld', 08:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:05 INFO - 'MOZ_NO_REMOTE': '1', 08:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:05 INFO - 'NO_EM_RESTART': '1', 08:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:05 INFO - 'PWD': '/builds/slave/test', 08:07:05 INFO - 'SHELL': '/bin/bash', 08:07:05 INFO - 'SHLVL': '1', 08:07:05 INFO - 'TERM': 'linux', 08:07:05 INFO - 'TMOUT': '86400', 08:07:05 INFO - 'USER': 'cltbld', 08:07:05 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:05 INFO - '_': '/tools/buildbot/bin/python'} 08:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 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)) 08:07:05 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:07:05 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 08:07:05 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 08:07:05 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 08:07:05 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 08:07:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 08:07:06 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)) 08:07:06 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)) 08:07:06 INFO - Installing collected packages: simplejson 08:07:06 INFO - Running setup.py install for simplejson 08:07:06 INFO - building 'simplejson._speedups' extension 08:07:06 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 08:07:07 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 08:07:07 INFO - Successfully installed simplejson 08:07:07 INFO - Cleaning up... 08:07:07 INFO - Return code: 0 08:07:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:07:07 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')]} 08:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:07:07 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')]} 08:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:07:07 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 0x230a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2675a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, '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': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', '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 08:07:07 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 08:07:07 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 08:07:07 INFO - Using env: {'DISPLAY': ':0', 08:07:07 INFO - 'HOME': '/home/cltbld', 08:07:07 INFO - 'LANG': 'en_US.UTF-8', 08:07:07 INFO - 'LANGUAGE': 'en_US:en', 08:07:07 INFO - 'LOGNAME': 'cltbld', 08:07:07 INFO - 'MAIL': '/var/mail/cltbld', 08:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:07 INFO - 'MOZ_NO_REMOTE': '1', 08:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:07 INFO - 'NO_EM_RESTART': '1', 08:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:07 INFO - 'PWD': '/builds/slave/test', 08:07:07 INFO - 'SHELL': '/bin/bash', 08:07:07 INFO - 'SHLVL': '1', 08:07:07 INFO - 'TERM': 'linux', 08:07:07 INFO - 'TMOUT': '86400', 08:07:07 INFO - 'USER': 'cltbld', 08:07:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:07 INFO - '_': '/tools/buildbot/bin/python'} 08:07:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:07:07 INFO - Cleaning up... 08:07:07 INFO - Return code: 0 08:07:07 INFO - Running post-action listener: _resource_record_post_action 08:07:07 INFO - Running post-action listener: _start_resource_monitoring 08:07:07 INFO - Starting resource monitoring. 08:07:07 INFO - [mozharness: 2017-10-02 15:07:07.998294Z] Finished create-virtualenv step (success) 08:07:07 INFO - [mozharness: 2017-10-02 15:07:07.998760Z] Running install step. 08:07:07 INFO - Running pre-action listener: _resource_record_pre_action 08:07:07 INFO - Running main action method: install 08:07:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:07:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:07:08 INFO - Reading from file tmpfile_stdout 08:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 08:07:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:07:08 INFO - Reading from file tmpfile_stdout 08:07:08 INFO - Output received: 08:07:08 INFO - Usage: mozinstall [options] installer 08:07:08 INFO - Options: 08:07:08 INFO - -h, --help show this help message and exit 08:07:08 INFO - -d DEST, --destination=DEST 08:07:08 INFO - Directory to install application into. [default: 08:07:08 INFO - "/builds/slave/test"] 08:07:08 INFO - --app=APP Application being installed. [default: firefox] 08:07:08 INFO - mkdir: /builds/slave/test/build/application 08:07:08 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'] 08:07:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:07:22 INFO - Reading from file tmpfile_stdout 08:07:22 INFO - Output received: 08:07:22 INFO - /builds/slave/test/build/application/firefox/firefox 08:07:22 INFO - Running post-action listener: _resource_record_post_action 08:07:22 INFO - [mozharness: 2017-10-02 15:07:22.865939Z] Finished install step (success) 08:07:22 INFO - [mozharness: 2017-10-02 15:07:22.866189Z] Running setup-mitmproxy step. 08:07:22 INFO - Running pre-action listener: _resource_record_pre_action 08:07:22 INFO - Running main action method: setup_mitmproxy 08:07:22 INFO - Skipping: mitmproxy is not required 08:07:22 INFO - Running post-action listener: _resource_record_post_action 08:07:22 INFO - [mozharness: 2017-10-02 15:07:22.867310Z] Finished setup-mitmproxy step (success) 08:07:22 INFO - [mozharness: 2017-10-02 15:07:22.867530Z] Running run-tests step. 08:07:22 INFO - Running pre-action listener: _resource_record_pre_action 08:07:22 INFO - Running pre-action listener: _set_gcov_prefix 08:07:22 INFO - Running main action method: run_tests 08:07:22 WARNING - Try message not found. 08:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:07:22 INFO - Python 2.7.3 08:07:22 INFO - Return code: 0 08:07:22 INFO - grabbing minidump binary from tooltool 08:07: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')]} 08:07:22 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 0x2679090>, '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 0x2679d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2673f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:07:22 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 08:07:22 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 08:07:22 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 08:07:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:07:22 INFO - Return code: 0 08:07:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:07:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:07:23 INFO - ENV: RUST_BACKTRACE is now full 08:07:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:07:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 08:07:23 INFO - Using env: {'DISPLAY': ':0', 08:07:23 INFO - 'HOME': '/home/cltbld', 08:07:23 INFO - 'LANG': 'en_US.UTF-8', 08:07:23 INFO - 'LANGUAGE': 'en_US:en', 08:07:23 INFO - 'LOGNAME': 'cltbld', 08:07:23 INFO - 'MAIL': '/var/mail/cltbld', 08:07:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:23 INFO - 'MOZ_NO_REMOTE': '1', 08:07:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:23 INFO - 'NO_EM_RESTART': '1', 08:07:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:23 INFO - 'PWD': '/builds/slave/test', 08:07:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:23 INFO - 'RUST_BACKTRACE': 'full', 08:07:23 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:07:23 INFO - 'SHELL': '/bin/bash', 08:07:23 INFO - 'SHLVL': '1', 08:07:23 INFO - 'TERM': 'linux', 08:07:23 INFO - 'TMOUT': '86400', 08:07:23 INFO - 'USER': 'cltbld', 08:07:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:07:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:23 INFO - '_': '/tools/buildbot/bin/python'} 08:07:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 08:07:23 INFO - mozversion application_buildid: 20171002134752 08:07:23 INFO - mozversion application_changeset: b7b894f5fad8b4fb79e60b6bbdcce52da1281714 08:07:23 INFO - mozversion application_display_name: Firefox 08:07:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:07:23 INFO - mozversion application_name: Firefox 08:07:23 INFO - mozversion application_remotingname: firefox 08:07:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:07:23 INFO - mozversion application_vendor: Mozilla 08:07:23 INFO - mozversion application_version: 57.0 08:07:23 INFO - mozversion platform_buildid: 20171002134752 08:07:23 INFO - mozversion platform_changeset: b7b894f5fad8b4fb79e60b6bbdcce52da1281714 08:07:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:07:23 INFO - mozversion platform_version: 57.0 08:07:23 INFO - using testdate: 1506956843 08:07:23 INFO - actual date: 1506956843 08:07:23 INFO - starting webserver on 'localhost:53551' 08:07:23 INFO - SUITE-START | Running 2 tests 08:07:23 INFO - TEST-START | dromaeo_css 08:07:23 INFO - Initialising browser for dromaeo_css test... 08:07:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53551/getInfo.html -profile /tmp/tmpex2AJt/profile 08:07:23 INFO - TEST-INFO | started process 26638 (/builds/slave/test/build/application/firefox/firefox http://localhost:53551/getInfo.html) 08:07:28 INFO - TEST-INFO | 26638: exit 0 08:07:28 INFO - Browser initialized. 08:07:28 INFO - Running cycle 1/1 for dromaeo_css test... 08:07:28 INFO - Using env: {'DISPLAY': ':0', 08:07:28 INFO - 'HOME': '/home/cltbld', 08:07:28 INFO - 'JSGC_DISABLE_POISONING': '1', 08:07:28 INFO - 'LANG': 'en_US.UTF-8', 08:07:28 INFO - 'LANGUAGE': 'en_US:en', 08:07:28 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:07:28 INFO - 'LOGNAME': 'cltbld', 08:07:28 INFO - 'MAIL': '/var/mail/cltbld', 08:07:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:07:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:07:28 INFO - 'MOZ_CRASHREPORTER': '1', 08:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:07:28 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:07:28 INFO - 'MOZ_NO_REMOTE': '1', 08:07:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:07:28 INFO - 'NO_EM_RESTART': '1', 08:07:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:07:28 INFO - 'PWD': '/builds/slave/test', 08:07:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:07:28 INFO - 'RUST_BACKTRACE': 'full', 08:07:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:07:28 INFO - 'SHELL': '/bin/bash', 08:07:28 INFO - 'SHLVL': '1', 08:07:28 INFO - 'TERM': 'linux', 08:07:28 INFO - 'TMOUT': '86400', 08:07:28 INFO - 'USER': 'cltbld', 08:07:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:07:28 INFO - '_': '/tools/buildbot/bin/python'} 08:07:28 INFO - TEST-INFO | started process 26832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpex2AJt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:29 INFO - PID 26832 | 08:07:29 INFO - PID 26832 | (/builds/slave/test/build/application/firefox/firefox:26881): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:07:29 INFO - PID 26832 | 08:07:39 INFO - PID 26832 | RSS: Main: 141488128 08:07:39 INFO - PID 26832 | 08:10:37 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53551/tests/dromaeo/cssquery-ext.html) 08:10:38 INFO - PID 26832 | RSS: Main: 147558400 08:10:38 INFO - PID 26832 | 08:13:39 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-ext.html (next: http://localhost:53551/tests/dromaeo/cssquery-jquery.html) 08:13:40 INFO - PID 26832 | RSS: Main: 143818752 08:13:40 INFO - PID 26832 | 08:16:42 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53551/tests/dromaeo/cssquery-mootools.html) 08:16:42 INFO - PID 26832 | RSS: Main: 144850944 08:16:42 INFO - PID 26832 | 08:19:44 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53551/tests/dromaeo/cssquery-prototype.html) 08:19:44 INFO - PID 26832 | RSS: Main: 144654336 08:19:44 INFO - PID 26832 | 08:22:47 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53551/tests/dromaeo/cssquery-yui.html) 08:22:48 INFO - PID 26832 | RSS: Main: 146231296 08:22:48 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | Cycle 1(1): loaded http://localhost:53551/tests/dromaeo/cssquery-yui.html (next: http://localhost:53551/tests/dromaeo/cssquery-dojo.html) 08:25:49 INFO - PID 26832 | RSS: Main: 148221952 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | __start_tp_report 08:25:49 INFO - PID 26832 | _x_x_mozilla_page_load 08:25:49 INFO - PID 26832 | _x_x_mozilla_page_load_details 08:25:49 INFO - PID 26832 | |i|pagename|runs| 08:25:49 INFO - PID 26832 | |0;dojo.html;4000.299947509186;4026.536948250951;4048.089179934513;4056.9391459128137;4077.08265640231;6540.378664026922;6549.181352330958;6564.80305590833;6610.570312929663;6649.867002659944;6642.202935647717;6642.535022548412;6646.700898459581;6649.168853893263;6725.5628384155;5903.911441328362;5972.701364931758;5993.670348130851;6018.638881667092;6030.09548567714;5930.169776231331;5987.34139244685;6027.849303767419;6037.154798328237;6106.786262480814;6021.066734656135;6114.052321890092;6114.908276375858;6144.539159563051;6158.137860699506;6049.092636104576;6080.361562036011;6082.087686847009;6115.4190351916495;6161.075838624198;5788.073908174714;5936.7328470218945;5999.700014999233;6023.849403764897;6056.242969628796;6458.644774537399;6524.706388212542;6561.671916404209;6581.670916454158;6653.135092438;7193.100862392201;7210.459215558802;7302.1967583565765;7313.232110628361;7319.194888562254;7092.5389849659605;7259.382952449048;7263.455240856904;7316.561006339637;7350.816229594249;6654.401103900624;6716.664166791641;6749.8650026999185;6798.762043328509;6807.761728339583;7390.9260907390235;7405.518641288299;7493;7514.511556748903;7518.548887066793;7112.324329188822;7128.501004929709;7135.5361901476235;7198.892016619755;7231.963840180765;7040.295970402919;7157.069580954442;7195.676194571257;7272.563646181246;7328.047353844073;7188.317109874553;7221.711131554784;7260.491765576359;7270.272972702794;7279.52683075609;7169.784906452711;7193.89209161863;7200.315969982843;7271.309225623558;7295.854082918312;5259.15853463444;5386.407495175527;5439;5439.238506609078;5454.509094181463;4870.488598697086;4904;4919.754012299442;4982.202847544448;4991.825286114969;6669.09967154428;6761.72953081881;6772.762953296611;6776.72893084281;6778.356056174655;7233.0597022386755;7238.638068096574;7247.130344358605;7325.340719335285;7343.853122937511;6551.868962620721;6658.167729033871;6660.200775906922;6663.666816659148;6665.633390163587;6080.361562035922;6114.11345354921;6132.2947860996555;6144.938550614436;6150.538709596798;7373.225811289844;7457.216992215847;7479.962600186965;7487.588182649898;7568.735094271674;7154.356107950205;7172.139343278735;7297.525660832029;7298.087739032621;7315.963420182865;7511.62441877893;7535.171131175676;7609.315161635479;7619.885701714368;7628.275313845176;7117.572945623279;7156.570605763671;7163.641817909188;7194.640267986684;7248.383887369632;7282.271772822675;7306.342429181399;7336.119665639944;7343.1555371133;7344.816379590339;6977.581345119106;6984.546004509691;6990.091288132714;7071.71713131469;7075.433965282868;6805.89791153143;6944.305569443015;6963.373296403348;7044.330788575077;7056.964715176391;6816.727330906907;6911.170659520689;6934.202566704894;6934.7864123779145;7015.754448594479;6972.860542789217;7010.509264351446;7031.859362812613;7046.189688185924;7093.964530177316;6636.070950067091;6744.69648865812;6760.661966901537;6777.186737591521;6866.038754574263 08:25:49 INFO - PID 26832 | |1;ext.html;940.8024314893872;990.8910019897814;997.5909876950451;1004.9447280399575;1026.4252018869433;46632.533674663246;47489;47547.28679069813;47616.52383476164;47637;43511.78244108783;43583;43657.34513982293;43685.34471982915;43853;8155.755327340189;8243.83512329756;8261.958690206571;8264.173582641717;8282.958585207065;7985.321247693953;8060.798480037987;8128.55292958887;8139.348852091818;8144.022717273906;8142.959285203566;8805.427647202943;9141.817163656722;9158.49628270445;9159.038300978402;9047.050059743764;9056.728298151033;9109.681161159328;9126.771830704252;9150.771230719252;8821.426607270507;8994.190522852909;9020;9028.593713282853;9029.41308814925;42329.365059524134;42547.57452425467;42588.78705606483;42594.57405425937;42738.57261427377;3752.1745216052423;3778.622137786227;3796.6772824309965;3811.6569508744346;3821.293060783764;34877;35409;35504.28991420183;35595.82202088999;35624.64375356239;5585.8603534911545;5593.916091258634;5677.772889084432;5679;5714.628549144292;233000;234078;234706;236220.81889590615;237304;55973;56306.71846640822;56435.43564564302;56542.717286414125;59706.40293597095;62277.68861155756;62877;62879.37120628827;62934;62961.37038629647;18563.628727425377;18683.15925783343;18770.24919003252;18797.624047518973;18798.812011879705;15434.768478472832;15439;15527.301271442811;15546.9222653886;15576.766348504781;16811;16835.74746378805;16879.15604219784;16880;16927.153642317833;6258.530610204162;6284.905726414107;6462.386073323027;6488.253850807123;6490.1238332825405;1090.996283419256;1102.5534658463334;1111.5776005118003;1128.8927551882557;1152.262551966742;26029.609555856678;26423.47153056928;26773.598396023684;26956.113072085158;27108.604650005243;1234.8950339221267;1244.209926696536;1244.5270797097046;1251.5682089679228;1258.930758808256;13974;14234.572962811133;14235.78646320306;14266.3580138894;14307.57077287683;303936;306761;306997;309422;309473;62504.68747656233;68410.65794670995;68484.31515684779;68519.65740171267;68628.65685671639;1513.2660659580094;1537.8615924566843;1538.6538028943621;1558.758392449172;1571.8663913567475;31621;31984;32047.35905281928;32199.839000804845;32970.835145824116;40019.199616008096;41551.37672934848;43971.12057758891;44138.33792493051;44210.55789442193;275320;275869;276977;277212;277259;39382.803085985535;39509.80245098756;39586.40620390639;39616.60383396244;39992.4001139989;47877;49142.262866057754;50224;50234.748826255636;50682.74658626831;37096.629033709316;37281.62718372782;37315.25369492649;37522.624773751915;37659;34834.65165348314;36744.265114697024;37036.25927481381;37226;37248.62751372452;42071;42516.787416062725;42997;43850.78074609734;43860.34209486796;34538;34993.30013399768;35044.12389690278;35640.82179589086;36104.458433123;25841.095561655253;26395.736042639328;26580.8670956644;27274.318142046606;27317.590236146872 08:25:49 INFO - PID 26832 | |2;jquery.html;627.7520379450115;632.4506754648842;639.7632875835939;651.1372431528225;655.2333769489696;23862.76137238627;24301.63547546786;24721.25836224914;24939.501209975788;24973.125940592083;24923.252302430956;25873.48253034938;25885.22344329673;25916.222513324632;25924;6712.765053223138;6811.421029212523;6819.35216154467;6825.69284382204;6835.453163746888;6473.643949582794;6737.764178253762;6759.425448836855;6783.660816959157;6789.796306110825;6733.764318248862;6765.560238584476;6769.458443324547;6776.457883369319;6798.660066996655;6745.662716864137;6754.257031726506;6763.59418434893;6778;6780.796576102724;6301.6534090625;6321.715522801485;6325.936740632581;6328.240611126648;6343.429091381798;28966.565501517493;29997.850010750026;30555;30760.692393076006;30835;2270.591293567157;2276.4877902471812;2277.533105713325;2286.565552545011;2297.8506397084134;20912.163513459443;21422.892885535628;21455.570888582297;21460.24889128873;21500.677489837664;2500.0249902538026;2550.732173121814;2552.1322750265;2556.821022528424;2593.351662084479;150469.2476537621;156168.5341013059;163964;172401;175088;23914.40213994664;23938.563686178884;24582.631260531107;24633.137840175867;24692.629610555858;49956;50304.496955030714;50411;50463.49536504661;50479;12909.225446473241;13066.934665326802;13118.861096751043;13350.866491334962;13397.66505837362;10900.890991089987;10940.4529773511;10993.395363254938;11004.22970392081;11040.171987100839;11877.168598198043;12564.685882853002;12583.559575415;12722.745545089047;13031.696830316892;4095.5154106253603;4136.772477513706;4332.718373305725;4340.717853339523;4735.573798358096;1038.3458421194598;1058.444316733721;1060.2737125069352;1071.2340676416243;1071.36081794854;20918.58162836735;20957.161713531288;21062;21321.25375611846;21570.137194512357;1126.5775334249656;1137.9317240965568;1142.9428528573703;1154.7575009247985;1157.4502111496972;11487.138464615187;11699.88300117005;11749.941250293694;11833.230839995373;11878.109141814226;588786;589163;591677;609818;621350;139387;140894;144001.27999359937;144386;144644.27677861543;1152.757920836617;1191.53530123252;1251.9687007824878;1258.8992880569533;1286.845578530601;21518.569628607653;22205.333839984825;22278.220262290743;22326.320841498473;22355.105795767988;65633;66833;67252;68451.63096738137;69331;80702.59648701719;80916.19083809321;81390.59304703676;81709;82364.58817705873;20962.84704341276;21537.784622153576;21675.783242167377;21685.132594696035;21753.347399578037;23875.283741487783;23876.641850372605;23984.52030959406;24097.156599518934;24210.75789242085;19527.60944781068;19780.30768923081;19855.106520206336;19933.60132797365;19949.301774437827;17655.470335889942;17658.735118973484;18038.278468861623;18071.27714891442;18256;20167.596648066665;20266.695999559724;20350;20396.490087747927;20411;20716.482087947923;20778.688319674915;20831.166753330304;20859.687104693137;20972.53192276587;19544.31594894172;19645.50886227856;19742.111604977523;19886.602267954848;19960.90019549893 08:25:49 INFO - PID 26832 | |3;mootools.html;1443.2134486704745;1511.9319630616621;1520.4146403634597;1522.2540954932074;1524.1312451902413;17487.213075411604;18158;18197.18112684929;18205.817941820576;18211.271549138037;17600.29598816049;17725.911370443162;17754;17778.733319000225;17792.11039448029;3052.008097368353;3071.4932036214;3095.0560079175843;3110.6578276389578;3113.455145349566;2980.463516567017;2989.760819134475;3002.24943764059;3004.0387076135535;3011.2471882029495;3018.154916623349;3132.3891841090995;3178.5708929294597;3180.6978337057944;3194.856231469578;3111.206642306209;3147.4334619768433;3168.445522033635;3180.9681903181017;3183.1405520509334;3023.6220472440946;3070.815751054944;3072.6312842458824;3078.7998780079224;3081.6302043754667;17128;17384.739228911578;17425.215865286093;17500.299988000465;17534.473965781046;8791.164839340252;9148;9152.8627070594;9177.770555736093;9185.67850125249;5816.796412125555;6045.153678485016;6090.512758979316;6113.602615829956;6128.754849806002;2090.4878304815265;2115.598036373084;2156.4393257753095;2179.498715295491;2213.756486786452;31079.689203107904;31146.688533114604;31396;31413.842930785428;31549;7741.496802707806;7846.5292082475235;7975.122736498981;8036.83926321482;8051.194880512019;20192.59614807725;20460.079296431697;20494;20534.281300154722;20577.588448230952;8874.778130546789;9066.682666106786;9079.364444488823;9123.224525915239;9144.085591440802;8193.303569196685;8236;8240.752777416687;8339.360083792564;8448.23965843077;5767.04843700793;5776.653400795965;5794.681292528867;5798.188253644493;5860.589758716934;1718.802337731177;1762.9471115866545;1796.9281228750965;1816.4459839749004;1821.7813862336604;1028.7428142964259;1036.740814796301;1046.529061922138;1049.2130901823632;1068.9732756681144;9832.213422926148;9856.915739268674;9938.503074846229;10035.498225088717;10397.688069357931;1044.6918159143072;1062.5218651606808;1101.4492753623188;1107.0755918807724;1116.3357802107732;5416.431274716098;5442.129259318569;5453.182022696548;5478.479544443271;5497.312835895513;26073.73926260751;26346.97009843854;26784.866075669495;26811.195664130108;26989;26390.208293751217;26477.867610661822;26638.334041649116;26655.46689066208;26733;12897;13211.73576528464;13234.139780914402;13310;13324.866751332556;9691.224702023963;10014.3490673106;10057.547410366697;10098;10165.695029149138;22440.10239590398;22462.213822516132;22764.317070487912;22869.656955145354;22923.770762292163;23547.175848845207;23633.763662363155;23833.404164896016;23937.52124957526;23982.76017239875;13085.280309582684;13148.802767958297;13178.077534572489;13252.668683282995;13308.800367994294;16247.106409147611;16305.347786088898;16470.67058658844;16474.917625411796;16488.010719356877;12814.423350949042;13394.598162054765;13467.12463689857;13478;13626.659333516742;12973.481060757464;13011.414486348327;13072;13141.080124391201;13530.120542164728;11858.940705296418;11877.406129693654;11883.940580297043;12010.459529321026;12014.75970480568;8633.8704919425;8654.956725216334;8734.432261902955;8795.736127916172;8865.734027979172;8768.386212965032;8884.466931984101;8935.776605584912;8995.685151019945;9103.499307537884 08:25:49 INFO - PID 26832 | |4;prototype.html;570.8658465260661;571.5256337240091;577.35336423206;614.3917521653563;622.6419808610048;6381.872362552746;6417.775377861776;6490.253620833606;6498.870022599545;6586.538942274043;6429.742810287595;6449.484041276698;6499.790071375732;6561.573497722645;6588;5377.784888604451;5394.730263486829;5403.0819059234;5446.101393270125;5449.482299181591;5343.278657381262;5385.272988146608;5462.825492519108;5485.286912701344;5514.944850551483;5462.644928079682;5469.917951230735;5485.875395543924;5492.148716948859;5495.587830912677;5433.8369848904595;5455.754491047913;5473.233747275345;5503.752331145088;5509.338879334466;5185;5189.792408303663;5220.955808838247;5224.111900976805;5229.267902493654;6547.410733034049;6563.442107420875;6606.009098635195;6608.669566521655;6651.700673469705;6436.93563064368;6450.903236451457;6488.545801793829;6562.278149403562;6564.245111812155;7131.144262688459;7148.714051437936;7186.1376634804155;7200.855982880313;7218.45861560385;5515.834524964257;5841.007028805071;5866.73599688015;5881.3530511643685;5881.882362352729;7137.714491420337;7154.427645788324;7246.13046434426;7311.561306321584;7341.3392794648735;5932.7033648318275;5943.940560594425;5958.553108516879;5987.982043052692;6003.969980150071;6004.309504406961;6030.3115127764295;6066.514678825683;6083.482903953125;6115.724792384353;6406.935930640634;6414.262359828679;6464.41820236181;6514.185726784152;6534.346565343522;7066.6819993100435;7074.398676112485;7076.823079422953;7084.291570842977;7134.143902731706;2089.7387826521685;2094.0786054136133;2126.670366093258;2132.562824620949;2143.431990522513;1504.857038581355;1552.448880647354;1589.6343840916422;1592.6416556274746;1601.479519156279;6410.807675769641;6441.677916104176;6535.869282614416;6574.80275591733;6582.473402127818;6896;6945.687444065029;6967.581945083311;7063.682134303968;7127.53671011393;6350;6355.650439225795;6360.236771587439;6399.9040014399825;6461.61230326182;3707.4253490708984;3734.0769503705615;3761.3793724035227;3774;3789.2989796887114;7200.747973820891;7365.263473652699;7394.186639469654;7421.962890185515;7477.439192060618;7234.276572342829;7241.565506069547;7247.876579130243;7273.709051637981;7278.053852999076;7247.347738703542;7249.855002900018;7282.927170728331;7298.160711518137;7344.632768361667;6968.930310696828;6994.61529615876;7010.404115650227;7095.8935615964765;7113.8577228454105;6865.485088618274;6905.37851593359;6966.721331146698;7057.2237053923;7150.964245178949;7207.603581803051;7291.781246562611;7348.485606007528;7367.189609142883;7384.630768461448;5934.287885453773;5967;5986.6707331097205;6024.849378765566;6039.849003774941;6653.767118150841;6801.421879140328;7079.433645308466;7094.680739366638;7264.745733899288;6808.217055038734;6825.488088393291;6843.144606924135;6849.760258390932;6906.474820143764;6900.758473453405;6936.445084393135;6963.373296403348;7001.264867189076;7004.3696067354185;6829.214640316427;6878.931210687829;6908.930910690829;6919.654017299215;6963.1644202696;6850.177978642595;6912.965435172792;6916.654167291515;6962.547434416747;7034.261402552863;6733.124693789972;6753.864922701617;6769.796906092825;6779.2375231746855;6791.524593278423 08:25:49 INFO - PID 26832 | |5;yui.html;998.1565577087359;1016.5628779624758;1020.5815615597606;1025.7179275699177;1042.384992854216;18360.540986475313;22097.226597069104;22353.77646223537;22548.210812621543;22549.098036078558;20790.376288711363;21218.04518796654;21304.4673883153;21342;21343.35969920901;1066.6373433032768;1094.3762055628295;1097.3635291530934;1102.795982743191;1107.5514416661265;1108.9667309980714;1145.1811954452564;1147.9368634725088;1148.328227986629;1149.5286932357735;1182.7516221593476;1190.4642910690225;1190.4821402689859;1191.3388069621358;1192.5825960913699;1173.0381087508247;1178.2930241854904;1182.337890781161;1183.0476466444509;1183.201339096111;860.3762272352557;861.1216559109736;863.8617821148586;865.2299453486402;869.0440515433037;20984.790152098438;21215;21433.57132857334;21500.892495537577;21766.564668706695;23717;23762.643560346434;24009.879950600134;24084.397890052715;24177.03291868323;18792.718109228237;18865.811341886543;18914.243430262773;18933.62132757351;18953.810461895482;3989.3816458448987;4034.152827906143;4037.4751282333405;4038.818253178614;4042.6765858731233;169658;172799.13600432043;173519.13240433717;175188.12405938015;176047;18728.81271187298;18902.621947560972;18966.146523406478;18992.05039748007;18993.81006189948;36177;36298.8185059073;36347;36517.26965460729;36777.63222367795;9815.018498150128;9849.60601575929;9912.653057142965;9930.900690992998;9970;5085.364329458817;5172.7155006475;5175.560077393464;5244.921326180111;5249.186376111708;6135.9079613805825;6320.525960552977;6386.042093685985;6393.968030159819;6410.230772307353;1100.741325788439;1125.0886781706681;1126.0822429719751;1134.0983917785381;1139.3448766959032;768.7386288661882;768.9730859419893;783.115079959642;788.8777239527882;793.4723408933111;12070.456829442695;12218.572349967886;12369.505219791108;12451.439685214187;12754.553590624284;749.1609397474754;758.9544627322379;763.149088766033;764.4572353628874;769.3806485779002;5905.114232865105;5994.6403215807195;6028.156058151862;6050.092486127028;6166.568340216142;143761;146283.26858365853;148170;149026.25486872497;149703;133121.33439332742;133553;133854.42939980706;135205.3239733795;138254;118763.40618296854;120758.3962080184;122235;123249;123503.38248308701;11282.774344513227;11332.206745527734;11343.716407089889;11403.600873969372;11420.48607812667;57064.14403783863;57158.7142064287;57720.422795773185;58298.708506457195;59273.11090333735;74903;75383;75523.62238188773;75888.24111759033;77019.61490192513;15831.445899393466;16190.91904540517;16214.35142594283;16263.349466021227;16276.186190690654;17662.823371766117;17838.643227135643;17882.105894704953;17971.191296391957;18122.72815907736;16099.839001609835;16339.673206535565;16428.342866285213;16435.753463697816;16505.504834854975;14231.430742770173;14581.270936453348;14582.343794529059;14590.708185836436;14595.781063284272;17368.305267789652;17607.20767565488;17753.289868405118;17766.555836104202;17787.822121778616;11683.123765717775;11735.765284694087;11797.587084452003;11902.940485297519;12004.459799309227;12525.56160534377;12680;12889.291088990196;12953.54662586805;13000.349982501026 08:25:49 INFO - PID 26832 | __end_tp_report 08:25:49 INFO - PID 26832 | __start_cc_report 08:25:49 INFO - PID 26832 | _x_x_mozilla_cycle_collect,258 08:25:49 INFO - PID 26832 | __end_cc_report 08:25:49 INFO - PID 26832 | __startTimestamp1506957949954__endTimestamp 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | ------- Summary: start ------- 08:25:49 INFO - PID 26832 | Number of tests: 6 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#0] dojo.html Cycles:165 Average:6672.55 Median:6911.17 stddev:776.68 (11.2%) stddev-sans-first:750.24 08:25:49 INFO - PID 26832 | Values: 4000.3 4026.5 4048.1 4056.9 4077.1 6540.4 6549.2 6564.8 6610.6 6649.9 6642.2 6642.5 6646.7 6649.2 6725.6 5903.9 5972.7 5993.7 6018.6 6030.1 5930.2 5987.3 6027.8 6037.2 6106.8 6021.1 6114.1 6114.9 6144.5 6158.1 6049.1 6080.4 6082.1 6115.4 6161.1 5788.1 5936.7 5999.7 6023.8 6056.2 6458.6 6524.7 6561.7 6581.7 6653.1 7193.1 7210.5 7302.2 7313.2 7319.2 7092.5 7259.4 7263.5 7316.6 7350.8 6654.4 6716.7 6749.9 6798.8 6807.8 7390.9 7405.5 7493.0 7514.5 7518.5 7112.3 7128.5 7135.5 7198.9 7232.0 7040.3 7157.1 7195.7 7272.6 7328.0 7188.3 7221.7 7260.5 7270.3 7279.5 7169.8 7193.9 7200.3 7271.3 7295.9 5259.2 5386.4 5439.0 5439.2 5454.5 4870.5 4904.0 4919.8 4982.2 4991.8 6669.1 6761.7 6772.8 6776.7 6778.4 7233.1 7238.6 7247.1 7325.3 7343.9 6551.9 6658.2 6660.2 6663.7 6665.6 6080.4 6114.1 6132.3 6144.9 6150.5 7373.2 7457.2 7480.0 7487.6 7568.7 7154.4 7172.1 7297.5 7298.1 7316.0 7511.6 7535.2 7609.3 7619.9 7628.3 7117.6 7156.6 7163.6 7194.6 7248.4 7282.3 7306.3 7336.1 7343.2 7344.8 6977.6 6984.5 6990.1 7071.7 7075.4 6805.9 6944.3 6963.4 7044.3 7057.0 6816.7 6911.2 6934.2 6934.8 7015.8 6972.9 7010.5 7031.9 7046.2 7094.0 6636.1 6744.7 6760.7 6777.2 6866.0 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#1] ext.html Cycles:180 Average:46504.94 Median:3816.48 stddev:71490.17 (1873.2%) stddev-sans-first:71608.85 08:25:49 INFO - PID 26832 | Values: 940.8 990.9 997.6 1004.9 1026.4 46632.5 47489.0 47547.3 47616.5 47637.0 43511.8 43583.0 43657.3 43685.3 43853.0 8155.8 8243.8 8262.0 8264.2 8283.0 7985.3 8060.8 8128.6 8139.3 8144.0 8143.0 8805.4 9141.8 9158.5 9159.0 9047.1 9056.7 9109.7 9126.8 9150.8 8821.4 8994.2 9020.0 9028.6 9029.4 42329.4 42547.6 42588.8 42594.6 42738.6 3752.2 3778.6 3796.7 3811.7 3821.3 34877.0 35409.0 35504.3 35595.8 35624.6 5585.9 5593.9 5677.8 5679.0 5714.6 233000.0 234078.0 234706.0 236220.8 237304.0 55973.0 56306.7 56435.4 56542.7 59706.4 62277.7 62877.0 62879.4 62934.0 62961.4 18563.6 18683.2 18770.2 18797.6 18798.8 15434.8 15439.0 15527.3 15546.9 15576.8 16811.0 16835.7 16879.2 16880.0 16927.2 6258.5 6284.9 6462.4 6488.3 6490.1 1091.0 1102.6 1111.6 1128.9 1152.3 26029.6 26423.5 26773.6 26956.1 27108.6 1234.9 1244.2 1244.5 1251.6 1258.9 13974.0 14234.6 14235.8 14266.4 14307.6 303936.0 306761.0 306997.0 309422.0 309473.0 62504.7 68410.7 68484.3 68519.7 68628.7 1513.3 1537.9 1538.7 1558.8 1571.9 31621.0 31984.0 32047.4 32199.8 32970.8 40019.2 41551.4 43971.1 44138.3 44210.6 275320.0 275869.0 276977.0 277212.0 277259.0 39382.8 39509.8 39586.4 39616.6 39992.4 47877.0 49142.3 50224.0 50234.7 50682.7 37096.6 37281.6 37315.3 37522.6 37659.0 34834.7 36744.3 37036.3 37226.0 37248.6 42071.0 42516.8 42997.0 43850.8 43860.3 34538.0 34993.3 35044.1 35640.8 36104.5 25841.1 26395.7 26580.9 27274.3 27317.6 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#2] jquery.html Cycles:180 Average:42066.27 Median:2273.54 stddev:101055.49 (4444.9%) stddev-sans-first:101291.08 08:25:49 INFO - PID 26832 | Values: 627.8 632.5 639.8 651.1 655.2 23862.8 24301.6 24721.3 24939.5 24973.1 24923.3 25873.5 25885.2 25916.2 25924.0 6712.8 6811.4 6819.4 6825.7 6835.5 6473.6 6737.8 6759.4 6783.7 6789.8 6733.8 6765.6 6769.5 6776.5 6798.7 6745.7 6754.3 6763.6 6778.0 6780.8 6301.7 6321.7 6325.9 6328.2 6343.4 28966.6 29997.9 30555.0 30760.7 30835.0 2270.6 2276.5 2277.5 2286.6 2297.9 20912.2 21422.9 21455.6 21460.2 21500.7 2500.0 2550.7 2552.1 2556.8 2593.4 150469.2 156168.5 163964.0 172401.0 175088.0 23914.4 23938.6 24582.6 24633.1 24692.6 49956.0 50304.5 50411.0 50463.5 50479.0 12909.2 13066.9 13118.9 13350.9 13397.7 10900.9 10940.5 10993.4 11004.2 11040.2 11877.2 12564.7 12583.6 12722.7 13031.7 4095.5 4136.8 4332.7 4340.7 4735.6 1038.3 1058.4 1060.3 1071.2 1071.4 20918.6 20957.2 21062.0 21321.3 21570.1 1126.6 1137.9 1142.9 1154.8 1157.5 11487.1 11699.9 11749.9 11833.2 11878.1 588786.0 589163.0 591677.0 609818.0 621350.0 139387.0 140894.0 144001.3 144386.0 144644.3 1152.8 1191.5 1252.0 1258.9 1286.8 21518.6 22205.3 22278.2 22326.3 22355.1 65633.0 66833.0 67252.0 68451.6 69331.0 80702.6 80916.2 81390.6 81709.0 82364.6 20962.8 21537.8 21675.8 21685.1 21753.3 23875.3 23876.6 23984.5 24097.2 24210.8 19527.6 19780.3 19855.1 19933.6 19949.3 17655.5 17658.7 18038.3 18071.3 18256.0 20167.6 20266.7 20350.0 20396.5 20411.0 20716.5 20778.7 20831.2 20859.7 20972.5 19544.3 19645.5 19742.1 19886.6 19960.9 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#3] mootools.html Cycles:180 Average:11061.21 Median:25028.25 stddev:8112.67 (32.4%) stddev-sans-first:8103.25 08:25:49 INFO - PID 26832 | Values: 1443.2 1511.9 1520.4 1522.3 1524.1 17487.2 18158.0 18197.2 18205.8 18211.3 17600.3 17725.9 17754.0 17778.7 17792.1 3052.0 3071.5 3095.1 3110.7 3113.5 2980.5 2989.8 3002.2 3004.0 3011.2 3018.2 3132.4 3178.6 3180.7 3194.9 3111.2 3147.4 3168.4 3181.0 3183.1 3023.6 3070.8 3072.6 3078.8 3081.6 17128.0 17384.7 17425.2 17500.3 17534.5 8791.2 9148.0 9152.9 9177.8 9185.7 5816.8 6045.2 6090.5 6113.6 6128.8 2090.5 2115.6 2156.4 2179.5 2213.8 31079.7 31146.7 31396.0 31413.8 31549.0 7741.5 7846.5 7975.1 8036.8 8051.2 20192.6 20460.1 20494.0 20534.3 20577.6 8874.8 9066.7 9079.4 9123.2 9144.1 8193.3 8236.0 8240.8 8339.4 8448.2 5767.0 5776.7 5794.7 5798.2 5860.6 1718.8 1762.9 1796.9 1816.4 1821.8 1028.7 1036.7 1046.5 1049.2 1069.0 9832.2 9856.9 9938.5 10035.5 10397.7 1044.7 1062.5 1101.4 1107.1 1116.3 5416.4 5442.1 5453.2 5478.5 5497.3 26073.7 26347.0 26784.9 26811.2 26989.0 26390.2 26477.9 26638.3 26655.5 26733.0 12897.0 13211.7 13234.1 13310.0 13324.9 9691.2 10014.3 10057.5 10098.0 10165.7 22440.1 22462.2 22764.3 22869.7 22923.8 23547.2 23633.8 23833.4 23937.5 23982.8 13085.3 13148.8 13178.1 13252.7 13308.8 16247.1 16305.3 16470.7 16474.9 16488.0 12814.4 13394.6 13467.1 13478.0 13626.7 12973.5 13011.4 13072.0 13141.1 13530.1 11858.9 11877.4 11883.9 12010.5 12014.8 8633.9 8655.0 8734.4 8795.7 8865.7 8768.4 8884.5 8935.8 8995.7 9103.5 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#4] prototype.html Cycles:180 Average:6040.23 Median:6562.86 stddev:1599.37 (24.4%) stddev-sans-first:1550.27 08:25:49 INFO - PID 26832 | Values: 570.9 571.5 577.4 614.4 622.6 6381.9 6417.8 6490.3 6498.9 6586.5 6429.7 6449.5 6499.8 6561.6 6588.0 5377.8 5394.7 5403.1 5446.1 5449.5 5343.3 5385.3 5462.8 5485.3 5514.9 5462.6 5469.9 5485.9 5492.1 5495.6 5433.8 5455.8 5473.2 5503.8 5509.3 5185.0 5189.8 5221.0 5224.1 5229.3 6547.4 6563.4 6606.0 6608.7 6651.7 6436.9 6450.9 6488.5 6562.3 6564.2 7131.1 7148.7 7186.1 7200.9 7218.5 5515.8 5841.0 5866.7 5881.4 5881.9 7137.7 7154.4 7246.1 7311.6 7341.3 5932.7 5943.9 5958.6 5988.0 6004.0 6004.3 6030.3 6066.5 6083.5 6115.7 6406.9 6414.3 6464.4 6514.2 6534.3 7066.7 7074.4 7076.8 7084.3 7134.1 2089.7 2094.1 2126.7 2132.6 2143.4 1504.9 1552.4 1589.6 1592.6 1601.5 6410.8 6441.7 6535.9 6574.8 6582.5 6896.0 6945.7 6967.6 7063.7 7127.5 6350.0 6355.7 6360.2 6399.9 6461.6 3707.4 3734.1 3761.4 3774.0 3789.3 7200.7 7365.3 7394.2 7422.0 7477.4 7234.3 7241.6 7247.9 7273.7 7278.1 7247.3 7249.9 7282.9 7298.2 7344.6 6968.9 6994.6 7010.4 7095.9 7113.9 6865.5 6905.4 6966.7 7057.2 7151.0 7207.6 7291.8 7348.5 7367.2 7384.6 5934.3 5967.0 5986.7 6024.8 6039.8 6653.8 6801.4 7079.4 7094.7 7264.7 6808.2 6825.5 6843.1 6849.8 6906.5 6900.8 6936.4 6963.4 7001.3 7004.4 6829.2 6878.9 6908.9 6919.7 6963.2 6850.2 6913.0 6916.7 6962.5 7034.3 6733.1 6753.9 6769.8 6779.2 6791.5 08:25:49 INFO - PID 26832 | 08:25:49 INFO - PID 26832 | [#5] yui.html Cycles:180 Average:29024.81 Median:17860.37 stddev:44137.13 (247.1%) stddev-sans-first:44210.78 08:25:49 INFO - PID 26832 | Values: 998.2 1016.6 1020.6 1025.7 1042.4 18360.5 22097.2 22353.8 22548.2 22549.1 20790.4 21218.0 21304.5 21342.0 21343.4 1066.6 1094.4 1097.4 1102.8 1107.6 1109.0 1145.2 1147.9 1148.3 1149.5 1182.8 1190.5 1190.5 1191.3 1192.6 1173.0 1178.3 1182.3 1183.0 1183.2 860.4 861.1 863.9 865.2 869.0 20984.8 21215.0 21433.6 21500.9 21766.6 23717.0 23762.6 24009.9 24084.4 24177.0 18792.7 18865.8 18914.2 18933.6 18953.8 3989.4 4034.2 4037.5 4038.8 4042.7 169658.0 172799.1 173519.1 175188.1 176047.0 18728.8 18902.6 18966.1 18992.1 18993.8 36177.0 36298.8 36347.0 36517.3 36777.6 9815.0 9849.6 9912.7 9930.9 9970.0 5085.4 5172.7 5175.6 5244.9 5249.2 6135.9 6320.5 6386.0 6394.0 6410.2 1100.7 1125.1 1126.1 1134.1 1139.3 768.7 769.0 783.1 788.9 793.5 12070.5 12218.6 12369.5 12451.4 12754.6 749.2 759.0 763.1 764.5 769.4 5905.1 5994.6 6028.2 6050.1 6166.6 143761.0 146283.3 148170.0 149026.3 149703.0 133121.3 133553.0 133854.4 135205.3 138254.0 118763.4 120758.4 122235.0 123249.0 123503.4 11282.8 11332.2 11343.7 11403.6 11420.5 57064.1 57158.7 57720.4 58298.7 59273.1 74903.0 75383.0 75523.6 75888.2 77019.6 15831.4 16190.9 16214.4 16263.3 16276.2 17662.8 17838.6 17882.1 17971.2 18122.7 16099.8 16339.7 16428.3 16435.8 16505.5 14231.4 14581.3 14582.3 14590.7 14595.8 17368.3 17607.2 17753.3 17766.6 17787.8 11683.1 11735.8 11797.6 11902.9 12004.5 12525.6 12680.0 12889.3 12953.5 13000.3 08:25:49 INFO - PID 26832 | -------- Summary: end -------- 08:25:49 INFO - PID 26832 | 08:25:50 INFO - TEST-INFO | 26832: exit 0 08:25:50 INFO - TEST-OK | dromaeo_css | took 1107303ms 08:25:50 INFO - TEST-START | kraken 08:25:50 INFO - Initialising browser for kraken test... 08:25:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53551/getInfo.html -profile /tmp/tmpMTXGrQ/profile 08:25:50 INFO - TEST-INFO | started process 27197 (/builds/slave/test/build/application/firefox/firefox http://localhost:53551/getInfo.html) 08:25:55 INFO - TEST-INFO | 27197: exit 0 08:25:55 INFO - Browser initialized. 08:25:55 INFO - Running cycle 1/1 for kraken test... 08:25:55 INFO - Using env: {'DISPLAY': ':0', 08:25:55 INFO - 'HOME': '/home/cltbld', 08:25:55 INFO - 'JSGC_DISABLE_POISONING': '1', 08:25:55 INFO - 'LANG': 'en_US.UTF-8', 08:25:55 INFO - 'LANGUAGE': 'en_US:en', 08:25:55 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 08:25:55 INFO - 'LOGNAME': 'cltbld', 08:25:55 INFO - 'MAIL': '/var/mail/cltbld', 08:25:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:25:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:25:55 INFO - 'MOZ_CRASHREPORTER': '1', 08:25:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:25:55 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 08:25:55 INFO - 'MOZ_NO_REMOTE': '1', 08:25:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:25:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:25:55 INFO - 'NO_EM_RESTART': '1', 08:25:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:25:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:25:55 INFO - 'PWD': '/builds/slave/test', 08:25:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:25:55 INFO - 'RUST_BACKTRACE': 'full', 08:25:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:25:55 INFO - 'SHELL': '/bin/bash', 08:25:55 INFO - 'SHLVL': '1', 08:25:55 INFO - 'TERM': 'linux', 08:25:55 INFO - 'TMOUT': '86400', 08:25:55 INFO - 'USER': 'cltbld', 08:25:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287', 08:25:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:25:55 INFO - '_': '/tools/buildbot/bin/python'} 08:25:55 INFO - TEST-INFO | started process 27384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMTXGrQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:55 INFO - PID 27384 | 08:25:55 INFO - PID 27384 | (/builds/slave/test/build/application/firefox/firefox:27433): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 08:25:55 INFO - PID 27384 | 08:26:06 INFO - PID 27384 | RSS: Main: 143691776 08:26:06 INFO - PID 27384 | 08:26:08 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53551/tests/kraken/driver.html?testName=audio-beat-detection) 08:26:09 INFO - PID 27384 | RSS: Main: 149409792 08:26:09 INFO - PID 27384 | 08:26:12 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53551/tests/kraken/driver.html?testName=audio-dft) 08:26:12 INFO - PID 27384 | RSS: Main: 149250048 08:26:12 INFO - PID 27384 | 08:26:15 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53551/tests/kraken/driver.html?testName=audio-fft) 08:26:16 INFO - PID 27384 | RSS: Main: 151347200 08:26:16 INFO - PID 27384 | 08:26:18 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53551/tests/kraken/driver.html?testName=audio-oscillator) 08:26:18 INFO - PID 27384 | RSS: Main: 151367680 08:26:18 INFO - PID 27384 | 08:26:20 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53551/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:26:21 INFO - PID 27384 | RSS: Main: 151080960 08:26:21 INFO - PID 27384 | 08:26:24 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53551/tests/kraken/driver.html?testName=imaging-darkroom) 08:26:25 INFO - PID 27384 | RSS: Main: 151867392 08:26:25 INFO - PID 27384 | 08:26:28 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53551/tests/kraken/driver.html?testName=imaging-desaturate) 08:26:29 INFO - PID 27384 | RSS: Main: 152211456 08:26:29 INFO - PID 27384 | 08:26:32 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53551/tests/kraken/driver.html?testName=json-parse-financial) 08:26:32 INFO - PID 27384 | RSS: Main: 153591808 08:26:32 INFO - PID 27384 | 08:26:34 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53551/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:26:34 INFO - PID 27384 | RSS: Main: 154079232 08:26:34 INFO - PID 27384 | 08:26:36 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:26:36 INFO - PID 27384 | RSS: Main: 153513984 08:26:36 INFO - PID 27384 | 08:26:38 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:26:39 INFO - PID 27384 | RSS: Main: 150212608 08:26:39 INFO - PID 27384 | 08:26:41 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:26:42 INFO - PID 27384 | RSS: Main: 150462464 08:26:42 INFO - PID 27384 | 08:26:45 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:26:45 INFO - PID 27384 | RSS: Main: 150532096 08:26:45 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | Cycle 1(1): loaded http://localhost:53551/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53551/tests/kraken/driver.html?testName=ai-astar) 08:26:47 INFO - PID 27384 | RSS: Main: 152363008 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | __start_tp_report 08:26:47 INFO - PID 27384 | _x_x_mozilla_page_load 08:26:47 INFO - PID 27384 | _x_x_mozilla_page_load_details 08:26:47 INFO - PID 27384 | |i|pagename|runs| 08:26:47 INFO - PID 27384 | |0;ai-astar;105;105;105;105;105;104;107;106;104;104 08:26:47 INFO - PID 27384 | |1;audio-beat-detection;112;113;112;113;111;113;111;112;111;139 08:26:47 INFO - PID 27384 | |2;audio-dft;162;164;164;162;164;164;162;162;163;162 08:26:47 INFO - PID 27384 | |3;audio-fft;76;73;73;74;74;74;73;73;73;73 08:26:47 INFO - PID 27384 | |4;audio-oscillator;77;78;77;78;78;77;81;78;77;77 08:26:47 INFO - PID 27384 | |5;imaging-gaussian-blur;114;113;110;113;114;113;115;115;114;114 08:26:47 INFO - PID 27384 | |6;imaging-darkroom;148;150;148;153;149;149;148;149;149;150 08:26:47 INFO - PID 27384 | |7;imaging-desaturate;94;94;94;94;94;99;95;94;94;94 08:26:47 INFO - PID 27384 | |8;json-parse-financial;43;43;43;44;44;45;48;41;43;43 08:26:47 INFO - PID 27384 | |9;json-stringify-tinderbox;39;39;38;38;38;38;38;38;38;38 08:26:47 INFO - PID 27384 | |10;stanford-crypto-aes;71;69;69;72;70;72;69;68;70;68 08:26:47 INFO - PID 27384 | |11;stanford-crypto-ccm;103;103;100;100;105;104;101;107;99;101 08:26:47 INFO - PID 27384 | |12;stanford-crypto-pbkdf2;146;148;143;144;143;143;153;151;151;148 08:26:47 INFO - PID 27384 | |13;stanford-crypto-sha256-iterative;62;60;57;57;58;57;58;59;60;57 08:26:47 INFO - PID 27384 | __end_tp_report 08:26:47 INFO - PID 27384 | __start_cc_report 08:26:47 INFO - PID 27384 | _x_x_mozilla_cycle_collect,671 08:26:47 INFO - PID 27384 | __end_cc_report 08:26:47 INFO - PID 27384 | __startTimestamp1506958007673__endTimestamp 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | ------- Summary: start ------- 08:26:47 INFO - PID 27384 | Number of tests: 14 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#0] ai-astar Cycles:10 Average:105.00 Median:105.00 stddev:0.94 (0.9%) stddev-sans-first:1.00 08:26:47 INFO - PID 27384 | Values: 105.0 105.0 105.0 105.0 105.0 104.0 107.0 106.0 104.0 104.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#1] audio-beat-detection Cycles:10 Average:114.70 Median:112.50 stddev:8.58 (7.6%) stddev-sans-first:9.04 08:26:47 INFO - PID 27384 | Values: 112.0 113.0 112.0 113.0 111.0 113.0 111.0 112.0 111.0 139.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:0.99 (0.6%) stddev-sans-first:1.00 08:26:47 INFO - PID 27384 | Values: 162.0 164.0 164.0 162.0 164.0 164.0 162.0 162.0 163.0 162.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#3] audio-fft Cycles:10 Average:73.60 Median:73.50 stddev:0.97 (1.3%) stddev-sans-first:0.50 08:26:47 INFO - PID 27384 | Values: 76.0 73.0 73.0 74.0 74.0 74.0 73.0 73.0 73.0 73.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:78.00 stddev:1.23 (1.6%) stddev-sans-first:1.27 08:26:47 INFO - PID 27384 | Values: 77.0 78.0 77.0 78.0 78.0 77.0 81.0 78.0 77.0 77.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:1.43 (1.3%) stddev-sans-first:1.51 08:26:47 INFO - PID 27384 | Values: 114.0 113.0 110.0 113.0 114.0 113.0 115.0 115.0 114.0 114.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:149.00 stddev:1.49 (1.0%) stddev-sans-first:1.51 08:26:47 INFO - PID 27384 | Values: 148.0 150.0 148.0 153.0 149.0 149.0 148.0 149.0 149.0 150.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.00 stddev:1.58 (1.7%) stddev-sans-first:1.66 08:26:47 INFO - PID 27384 | Values: 94.0 94.0 94.0 94.0 94.0 99.0 95.0 94.0 94.0 94.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#8] json-parse-financial Cycles:10 Average:43.70 Median:43.50 stddev:1.83 (4.2%) stddev-sans-first:1.92 08:26:47 INFO - PID 27384 | Values: 43.0 43.0 43.0 44.0 44.0 45.0 48.0 41.0 43.0 43.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#9] json-stringify-tinderbox Cycles:10 Average:38.20 Median:38.00 stddev:0.42 (1.1%) stddev-sans-first:0.33 08:26:47 INFO - PID 27384 | Values: 39.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#10] stanford-crypto-aes Cycles:10 Average:69.80 Median:70.00 stddev:1.48 (2.1%) stddev-sans-first:1.50 08:26:47 INFO - PID 27384 | Values: 71.0 69.0 69.0 72.0 70.0 72.0 69.0 68.0 70.0 68.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#11] stanford-crypto-ccm Cycles:10 Average:102.30 Median:103.50 stddev:2.54 (2.5%) stddev-sans-first:2.68 08:26:47 INFO - PID 27384 | Values: 103.0 103.0 100.0 100.0 105.0 104.0 101.0 107.0 99.0 101.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:148.00 stddev:3.77 (2.5%) stddev-sans-first:3.98 08:26:47 INFO - PID 27384 | Values: 146.0 148.0 143.0 144.0 143.0 143.0 153.0 151.0 151.0 148.0 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.50 Median:58.50 stddev:1.72 (2.9%) stddev-sans-first:1.27 08:26:47 INFO - PID 27384 | Values: 62.0 60.0 57.0 57.0 58.0 57.0 58.0 59.0 60.0 57.0 08:26:47 INFO - PID 27384 | -------- Summary: end -------- 08:26:47 INFO - PID 27384 | 08:26:47 INFO - PID 27384 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 08:26:48 INFO - TEST-INFO | 27384: exit 0 08:26:48 INFO - TEST-OK | kraken | took 57718ms 08:26:48 INFO - SUITE-END | took 1165s 08:26:48 INFO - Completed test suite (00:19:25) 08:26:48 INFO - javascript benchmark 08:26:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9650.881865624631, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4000.299947509186, 4026.536948250951, 4048.089179934513, 4056.9391459128137, 4077.08265640231, 6540.378664026922, 6549.181352330958, 6564.80305590833, 6610.570312929663, 6649.867002659944, 6642.202935647717, 6642.535022548412, 6646.700898459581, 6649.168853893263, 6725.5628384155, 5903.911441328362, 5972.701364931758, 5993.670348130851, 6018.638881667092, 6030.09548567714, 5930.169776231331, 5987.34139244685, 6027.849303767419, 6037.154798328237, 6106.786262480814, 6021.066734656135, 6114.052321890092, 6114.908276375858, 6144.539159563051, 6158.137860699506, 6049.092636104576, 6080.361562036011, 6082.087686847009, 6115.4190351916495, 6161.075838624198, 5788.073908174714, 5936.7328470218945, 5999.700014999233, 6023.849403764897, 6056.242969628796, 6458.644774537399, 6524.706388212542, 6561.671916404209, 6581.670916454158, 6653.135092438, 7193.100862392201, 7210.459215558802, 7302.1967583565765, 7313.232110628361, 7319.194888562254, 7092.5389849659605, 7259.382952449048, 7263.455240856904, 7316.561006339637, 7350.816229594249, 6654.401103900624, 6716.664166791641, 6749.8650026999185, 6798.762043328509, 6807.761728339583, 7390.9260907390235, 7405.518641288299, 7493.0, 7514.511556748903, 7518.548887066793, 7112.324329188822, 7128.501004929709, 7135.5361901476235, 7198.892016619755, 7231.963840180765, 7040.295970402919, 7157.069580954442, 7195.676194571257, 7272.563646181246, 7328.047353844073, 7188.317109874553, 7221.711131554784, 7260.491765576359, 7270.272972702794, 7279.52683075609, 7169.784906452711, 7193.89209161863, 7200.315969982843, 7271.309225623558, 7295.854082918312, 5259.15853463444, 5386.407495175527, 5439.0, 5439.238506609078, 5454.509094181463, 4870.488598697086, 4904.0, 4919.754012299442, 4982.202847544448, 4991.825286114969, 6669.09967154428, 6761.72953081881, 6772.762953296611, 6776.72893084281, 6778.356056174655, 7233.0597022386755, 7238.638068096574, 7247.130344358605, 7325.340719335285, 7343.853122937511, 6551.868962620721, 6658.167729033871, 6660.200775906922, 6663.666816659148, 6665.633390163587, 6080.361562035922, 6114.11345354921, 6132.2947860996555, 6144.938550614436, 6150.538709596798, 7373.225811289844, 7457.216992215847, 7479.962600186965, 7487.588182649898, 7568.735094271674, 7154.356107950205, 7172.139343278735, 7297.525660832029, 7298.087739032621, 7315.963420182865, 7511.62441877893, 7535.171131175676, 7609.315161635479, 7619.885701714368, 7628.275313845176, 7117.572945623279, 7156.570605763671, 7163.641817909188, 7194.640267986684, 7248.383887369632, 7282.271772822675, 7306.342429181399, 7336.119665639944, 7343.1555371133, 7344.816379590339, 6977.581345119106, 6984.546004509691, 6990.091288132714, 7071.71713131469, 7075.433965282868, 6805.89791153143, 6944.305569443015, 6963.373296403348, 7044.330788575077, 7056.964715176391, 6816.727330906907, 6911.170659520689, 6934.202566704894, 6934.7864123779145, 7015.754448594479, 6972.860542789217, 7010.509264351446, 7031.859362812613, 7046.189688185924, 7093.964530177316, 6636.070950067091, 6744.69648865812, 6760.661966901537, 6777.186737591521, 6866.038754574263], "value": 6620.52755335018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [940.8024314893872, 990.8910019897814, 997.5909876950451, 1004.9447280399575, 1026.4252018869433, 46632.533674663246, 47489.0, 47547.28679069813, 47616.52383476164, 47637.0, 43511.78244108783, 43583.0, 43657.34513982293, 43685.34471982915, 43853.0, 8155.755327340189, 8243.83512329756, 8261.958690206571, 8264.173582641717, 8282.958585207065, 7985.321247693953, 8060.798480037987, 8128.55292958887, 8139.348852091818, 8144.022717273906, 8142.959285203566, 8805.427647202943, 9141.817163656722, 9158.49628270445, 9159.038300978402, 9047.050059743764, 9056.728298151033, 9109.681161159328, 9126.771830704252, 9150.771230719252, 8821.426607270507, 8994.190522852909, 9020.0, 9028.593713282853, 9029.41308814925, 42329.365059524134, 42547.57452425467, 42588.78705606483, 42594.57405425937, 42738.57261427377, 3752.1745216052423, 3778.622137786227, 3796.6772824309965, 3811.6569508744346, 3821.293060783764, 34877.0, 35409.0, 35504.28991420183, 35595.82202088999, 35624.64375356239, 5585.8603534911545, 5593.916091258634, 5677.772889084432, 5679.0, 5714.628549144292, 233000.0, 234078.0, 234706.0, 236220.81889590615, 237304.0, 55973.0, 56306.71846640822, 56435.43564564302, 56542.717286414125, 59706.40293597095, 62277.68861155756, 62877.0, 62879.37120628827, 62934.0, 62961.37038629647, 18563.628727425377, 18683.15925783343, 18770.24919003252, 18797.624047518973, 18798.812011879705, 15434.768478472832, 15439.0, 15527.301271442811, 15546.9222653886, 15576.766348504781, 16811.0, 16835.74746378805, 16879.15604219784, 16880.0, 16927.153642317833, 6258.530610204162, 6284.905726414107, 6462.386073323027, 6488.253850807123, 6490.1238332825405, 1090.996283419256, 1102.5534658463334, 1111.5776005118003, 1128.8927551882557, 1152.262551966742, 26029.609555856678, 26423.47153056928, 26773.598396023684, 26956.113072085158, 27108.604650005243, 1234.8950339221267, 1244.209926696536, 1244.5270797097046, 1251.5682089679228, 1258.930758808256, 13974.0, 14234.572962811133, 14235.78646320306, 14266.3580138894, 14307.57077287683, 303936.0, 306761.0, 306997.0, 309422.0, 309473.0, 62504.68747656233, 68410.65794670995, 68484.31515684779, 68519.65740171267, 68628.65685671639, 1513.2660659580094, 1537.8615924566843, 1538.6538028943621, 1558.758392449172, 1571.8663913567475, 31621.0, 31984.0, 32047.35905281928, 32199.839000804845, 32970.835145824116, 40019.199616008096, 41551.37672934848, 43971.12057758891, 44138.33792493051, 44210.55789442193, 275320.0, 275869.0, 276977.0, 277212.0, 277259.0, 39382.803085985535, 39509.80245098756, 39586.40620390639, 39616.60383396244, 39992.4001139989, 47877.0, 49142.262866057754, 50224.0, 50234.748826255636, 50682.74658626831, 37096.629033709316, 37281.62718372782, 37315.25369492649, 37522.624773751915, 37659.0, 34834.65165348314, 36744.265114697024, 37036.25927481381, 37226.0, 37248.62751372452, 42071.0, 42516.787416062725, 42997.0, 43850.78074609734, 43860.34209486796, 34538.0, 34993.30013399768, 35044.12389690278, 35640.82179589086, 36104.458433123, 25841.095561655253, 26395.736042639328, 26580.8670956644, 27274.318142046606, 27317.590236146872], "value": 19917.60647985123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.7520379450115, 632.4506754648842, 639.7632875835939, 651.1372431528225, 655.2333769489696, 23862.76137238627, 24301.63547546786, 24721.25836224914, 24939.501209975788, 24973.125940592083, 24923.252302430956, 25873.48253034938, 25885.22344329673, 25916.222513324632, 25924.0, 6712.765053223138, 6811.421029212523, 6819.35216154467, 6825.69284382204, 6835.453163746888, 6473.643949582794, 6737.764178253762, 6759.425448836855, 6783.660816959157, 6789.796306110825, 6733.764318248862, 6765.560238584476, 6769.458443324547, 6776.457883369319, 6798.660066996655, 6745.662716864137, 6754.257031726506, 6763.59418434893, 6778.0, 6780.796576102724, 6301.6534090625, 6321.715522801485, 6325.936740632581, 6328.240611126648, 6343.429091381798, 28966.565501517493, 29997.850010750026, 30555.0, 30760.692393076006, 30835.0, 2270.591293567157, 2276.4877902471812, 2277.533105713325, 2286.565552545011, 2297.8506397084134, 20912.163513459443, 21422.892885535628, 21455.570888582297, 21460.24889128873, 21500.677489837664, 2500.0249902538026, 2550.732173121814, 2552.1322750265, 2556.821022528424, 2593.351662084479, 150469.2476537621, 156168.5341013059, 163964.0, 172401.0, 175088.0, 23914.40213994664, 23938.563686178884, 24582.631260531107, 24633.137840175867, 24692.629610555858, 49956.0, 50304.496955030714, 50411.0, 50463.49536504661, 50479.0, 12909.225446473241, 13066.934665326802, 13118.861096751043, 13350.866491334962, 13397.66505837362, 10900.890991089987, 10940.4529773511, 10993.395363254938, 11004.22970392081, 11040.171987100839, 11877.168598198043, 12564.685882853002, 12583.559575415, 12722.745545089047, 13031.696830316892, 4095.5154106253603, 4136.772477513706, 4332.718373305725, 4340.717853339523, 4735.573798358096, 1038.3458421194598, 1058.444316733721, 1060.2737125069352, 1071.2340676416243, 1071.36081794854, 20918.58162836735, 20957.161713531288, 21062.0, 21321.25375611846, 21570.137194512357, 1126.5775334249656, 1137.9317240965568, 1142.9428528573703, 1154.7575009247985, 1157.4502111496972, 11487.138464615187, 11699.88300117005, 11749.941250293694, 11833.230839995373, 11878.109141814226, 588786.0, 589163.0, 591677.0, 609818.0, 621350.0, 139387.0, 140894.0, 144001.27999359937, 144386.0, 144644.27677861543, 1152.757920836617, 1191.53530123252, 1251.9687007824878, 1258.8992880569533, 1286.845578530601, 21518.569628607653, 22205.333839984825, 22278.220262290743, 22326.320841498473, 22355.105795767988, 65633.0, 66833.0, 67252.0, 68451.63096738137, 69331.0, 80702.59648701719, 80916.19083809321, 81390.59304703676, 81709.0, 82364.58817705873, 20962.84704341276, 21537.784622153576, 21675.783242167377, 21685.132594696035, 21753.347399578037, 23875.283741487783, 23876.641850372605, 23984.52030959406, 24097.156599518934, 24210.75789242085, 19527.60944781068, 19780.30768923081, 19855.106520206336, 19933.60132797365, 19949.301774437827, 17655.470335889942, 17658.735118973484, 18038.278468861623, 18071.27714891442, 18256.0, 20167.596648066665, 20266.695999559724, 20350.0, 20396.490087747927, 20411.0, 20716.482087947923, 20778.688319674915, 20831.166753330304, 20859.687104693137, 20972.53192276587, 19544.31594894172, 19645.50886227856, 19742.111604977523, 19886.602267954848, 19960.90019549893], "value": 14011.940796119545, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.2134486704745, 1511.9319630616621, 1520.4146403634597, 1522.2540954932074, 1524.1312451902413, 17487.213075411604, 18158.0, 18197.18112684929, 18205.817941820576, 18211.271549138037, 17600.29598816049, 17725.911370443162, 17754.0, 17778.733319000225, 17792.11039448029, 3052.008097368353, 3071.4932036214, 3095.0560079175843, 3110.6578276389578, 3113.455145349566, 2980.463516567017, 2989.760819134475, 3002.24943764059, 3004.0387076135535, 3011.2471882029495, 3018.154916623349, 3132.3891841090995, 3178.5708929294597, 3180.6978337057944, 3194.856231469578, 3111.206642306209, 3147.4334619768433, 3168.445522033635, 3180.9681903181017, 3183.1405520509334, 3023.6220472440946, 3070.815751054944, 3072.6312842458824, 3078.7998780079224, 3081.6302043754667, 17128.0, 17384.739228911578, 17425.215865286093, 17500.299988000465, 17534.473965781046, 8791.164839340252, 9148.0, 9152.8627070594, 9177.770555736093, 9185.67850125249, 5816.796412125555, 6045.153678485016, 6090.512758979316, 6113.602615829956, 6128.754849806002, 2090.4878304815265, 2115.598036373084, 2156.4393257753095, 2179.498715295491, 2213.756486786452, 31079.689203107904, 31146.688533114604, 31396.0, 31413.842930785428, 31549.0, 7741.496802707806, 7846.5292082475235, 7975.122736498981, 8036.83926321482, 8051.194880512019, 20192.59614807725, 20460.079296431697, 20494.0, 20534.281300154722, 20577.588448230952, 8874.778130546789, 9066.682666106786, 9079.364444488823, 9123.224525915239, 9144.085591440802, 8193.303569196685, 8236.0, 8240.752777416687, 8339.360083792564, 8448.23965843077, 5767.04843700793, 5776.653400795965, 5794.681292528867, 5798.188253644493, 5860.589758716934, 1718.802337731177, 1762.9471115866545, 1796.9281228750965, 1816.4459839749004, 1821.7813862336604, 1028.7428142964259, 1036.740814796301, 1046.529061922138, 1049.2130901823632, 1068.9732756681144, 9832.213422926148, 9856.915739268674, 9938.503074846229, 10035.498225088717, 10397.688069357931, 1044.6918159143072, 1062.5218651606808, 1101.4492753623188, 1107.0755918807724, 1116.3357802107732, 5416.431274716098, 5442.129259318569, 5453.182022696548, 5478.479544443271, 5497.312835895513, 26073.73926260751, 26346.97009843854, 26784.866075669495, 26811.195664130108, 26989.0, 26390.208293751217, 26477.867610661822, 26638.334041649116, 26655.46689066208, 26733.0, 12897.0, 13211.73576528464, 13234.139780914402, 13310.0, 13324.866751332556, 9691.224702023963, 10014.3490673106, 10057.547410366697, 10098.0, 10165.695029149138, 22440.10239590398, 22462.213822516132, 22764.317070487912, 22869.656955145354, 22923.770762292163, 23547.175848845207, 23633.763662363155, 23833.404164896016, 23937.52124957526, 23982.76017239875, 13085.280309582684, 13148.802767958297, 13178.077534572489, 13252.668683282995, 13308.800367994294, 16247.106409147611, 16305.347786088898, 16470.67058658844, 16474.917625411796, 16488.010719356877, 12814.423350949042, 13394.598162054765, 13467.12463689857, 13478.0, 13626.659333516742, 12973.481060757464, 13011.414486348327, 13072.0, 13141.080124391201, 13530.120542164728, 11858.940705296418, 11877.406129693654, 11883.940580297043, 12010.459529321026, 12014.75970480568, 8633.8704919425, 8654.956725216334, 8734.432261902955, 8795.736127916172, 8865.734027979172, 8768.386212965032, 8884.466931984101, 8935.776605584912, 8995.685151019945, 9103.499307537884], "value": 7785.486148895361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.8658465260661, 571.5256337240091, 577.35336423206, 614.3917521653563, 622.6419808610048, 6381.872362552746, 6417.775377861776, 6490.253620833606, 6498.870022599545, 6586.538942274043, 6429.742810287595, 6449.484041276698, 6499.790071375732, 6561.573497722645, 6588.0, 5377.784888604451, 5394.730263486829, 5403.0819059234, 5446.101393270125, 5449.482299181591, 5343.278657381262, 5385.272988146608, 5462.825492519108, 5485.286912701344, 5514.944850551483, 5462.644928079682, 5469.917951230735, 5485.875395543924, 5492.148716948859, 5495.587830912677, 5433.8369848904595, 5455.754491047913, 5473.233747275345, 5503.752331145088, 5509.338879334466, 5185.0, 5189.792408303663, 5220.955808838247, 5224.111900976805, 5229.267902493654, 6547.410733034049, 6563.442107420875, 6606.009098635195, 6608.669566521655, 6651.700673469705, 6436.93563064368, 6450.903236451457, 6488.545801793829, 6562.278149403562, 6564.245111812155, 7131.144262688459, 7148.714051437936, 7186.1376634804155, 7200.855982880313, 7218.45861560385, 5515.834524964257, 5841.007028805071, 5866.73599688015, 5881.3530511643685, 5881.882362352729, 7137.714491420337, 7154.427645788324, 7246.13046434426, 7311.561306321584, 7341.3392794648735, 5932.7033648318275, 5943.940560594425, 5958.553108516879, 5987.982043052692, 6003.969980150071, 6004.309504406961, 6030.3115127764295, 6066.514678825683, 6083.482903953125, 6115.724792384353, 6406.935930640634, 6414.262359828679, 6464.41820236181, 6514.185726784152, 6534.346565343522, 7066.6819993100435, 7074.398676112485, 7076.823079422953, 7084.291570842977, 7134.143902731706, 2089.7387826521685, 2094.0786054136133, 2126.670366093258, 2132.562824620949, 2143.431990522513, 1504.857038581355, 1552.448880647354, 1589.6343840916422, 1592.6416556274746, 1601.479519156279, 6410.807675769641, 6441.677916104176, 6535.869282614416, 6574.80275591733, 6582.473402127818, 6896.0, 6945.687444065029, 6967.581945083311, 7063.682134303968, 7127.53671011393, 6350.0, 6355.650439225795, 6360.236771587439, 6399.9040014399825, 6461.61230326182, 3707.4253490708984, 3734.0769503705615, 3761.3793724035227, 3774.0, 3789.2989796887114, 7200.747973820891, 7365.263473652699, 7394.186639469654, 7421.962890185515, 7477.439192060618, 7234.276572342829, 7241.565506069547, 7247.876579130243, 7273.709051637981, 7278.053852999076, 7247.347738703542, 7249.855002900018, 7282.927170728331, 7298.160711518137, 7344.632768361667, 6968.930310696828, 6994.61529615876, 7010.404115650227, 7095.8935615964765, 7113.8577228454105, 6865.485088618274, 6905.37851593359, 6966.721331146698, 7057.2237053923, 7150.964245178949, 7207.603581803051, 7291.781246562611, 7348.485606007528, 7367.189609142883, 7384.630768461448, 5934.287885453773, 5967.0, 5986.6707331097205, 6024.849378765566, 6039.849003774941, 6653.767118150841, 6801.421879140328, 7079.433645308466, 7094.680739366638, 7264.745733899288, 6808.217055038734, 6825.488088393291, 6843.144606924135, 6849.760258390932, 6906.474820143764, 6900.758473453405, 6936.445084393135, 6963.373296403348, 7001.264867189076, 7004.3696067354185, 6829.214640316427, 6878.931210687829, 6908.930910690829, 6919.654017299215, 6963.1644202696, 6850.177978642595, 6912.965435172792, 6916.654167291515, 6962.547434416747, 7034.261402552863, 6733.124693789972, 6753.864922701617, 6769.796906092825, 6779.2375231746855, 6791.524593278423], "value": 5589.860695712137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [998.1565577087359, 1016.5628779624758, 1020.5815615597606, 1025.7179275699177, 1042.384992854216, 18360.540986475313, 22097.226597069104, 22353.77646223537, 22548.210812621543, 22549.098036078558, 20790.376288711363, 21218.04518796654, 21304.4673883153, 21342.0, 21343.35969920901, 1066.6373433032768, 1094.3762055628295, 1097.3635291530934, 1102.795982743191, 1107.5514416661265, 1108.9667309980714, 1145.1811954452564, 1147.9368634725088, 1148.328227986629, 1149.5286932357735, 1182.7516221593476, 1190.4642910690225, 1190.4821402689859, 1191.3388069621358, 1192.5825960913699, 1173.0381087508247, 1178.2930241854904, 1182.337890781161, 1183.0476466444509, 1183.201339096111, 860.3762272352557, 861.1216559109736, 863.8617821148586, 865.2299453486402, 869.0440515433037, 20984.790152098438, 21215.0, 21433.57132857334, 21500.892495537577, 21766.564668706695, 23717.0, 23762.643560346434, 24009.879950600134, 24084.397890052715, 24177.03291868323, 18792.718109228237, 18865.811341886543, 18914.243430262773, 18933.62132757351, 18953.810461895482, 3989.3816458448987, 4034.152827906143, 4037.4751282333405, 4038.818253178614, 4042.6765858731233, 169658.0, 172799.13600432043, 173519.13240433717, 175188.12405938015, 176047.0, 18728.81271187298, 18902.621947560972, 18966.146523406478, 18992.05039748007, 18993.81006189948, 36177.0, 36298.8185059073, 36347.0, 36517.26965460729, 36777.63222367795, 9815.018498150128, 9849.60601575929, 9912.653057142965, 9930.900690992998, 9970.0, 5085.364329458817, 5172.7155006475, 5175.560077393464, 5244.921326180111, 5249.186376111708, 6135.9079613805825, 6320.525960552977, 6386.042093685985, 6393.968030159819, 6410.230772307353, 1100.741325788439, 1125.0886781706681, 1126.0822429719751, 1134.0983917785381, 1139.3448766959032, 768.7386288661882, 768.9730859419893, 783.115079959642, 788.8777239527882, 793.4723408933111, 12070.456829442695, 12218.572349967886, 12369.505219791108, 12451.439685214187, 12754.553590624284, 749.1609397474754, 758.9544627322379, 763.149088766033, 764.4572353628874, 769.3806485779002, 5905.114232865105, 5994.6403215807195, 6028.156058151862, 6050.092486127028, 6166.568340216142, 143761.0, 146283.26858365853, 148170.0, 149026.25486872497, 149703.0, 133121.33439332742, 133553.0, 133854.42939980706, 135205.3239733795, 138254.0, 118763.40618296854, 120758.3962080184, 122235.0, 123249.0, 123503.38248308701, 11282.774344513227, 11332.206745527734, 11343.716407089889, 11403.600873969372, 11420.48607812667, 57064.14403783863, 57158.7142064287, 57720.422795773185, 58298.708506457195, 59273.11090333735, 74903.0, 75383.0, 75523.62238188773, 75888.24111759033, 77019.61490192513, 15831.445899393466, 16190.91904540517, 16214.35142594283, 16263.349466021227, 16276.186190690654, 17662.823371766117, 17838.643227135643, 17882.105894704953, 17971.191296391957, 18122.72815907736, 16099.839001609835, 16339.673206535565, 16428.342866285213, 16435.753463697816, 16505.504834854975, 14231.430742770173, 14581.270936453348, 14582.343794529059, 14590.708185836436, 14595.781063284272, 17368.305267789652, 17607.20767565488, 17753.289868405118, 17766.555836104202, 17787.822121778616, 11683.123765717775, 11735.765284694087, 11797.587084452003, 11902.940485297519, 12004.459799309227, 12525.56160534377, 12680.0, 12889.291088990196, 12953.54662586805, 13000.349982501026], "value": 10047.595637749724, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1350.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 105.0, 105.0, 105.0, 105.0, 104.0, 107.0, 106.0, 104.0, 104.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 112.0, 113.0, 111.0, 113.0, 111.0, 112.0, 111.0, 139.0], "value": 114.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 162.0, 164.0, 164.0, 162.0, 162.0, 163.0, 162.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 73.0, 74.0, 74.0, 74.0, 73.0, 73.0, 73.0, 73.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 78.0, 78.0, 77.0, 81.0, 78.0, 77.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 110.0, 113.0, 114.0, 113.0, 115.0, 115.0, 114.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 148.0, 153.0, 149.0, 149.0, 148.0, 149.0, 149.0, 150.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [43.0, 43.0, 43.0, 44.0, 44.0, 45.0, 48.0, 41.0, 43.0, 43.0], "value": 43.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 72.0, 70.0, 72.0, 69.0, 68.0, 70.0, 68.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 103.0, 100.0, 100.0, 105.0, 104.0, 101.0, 107.0, 99.0, 101.0], "value": 102.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 143.0, 144.0, 143.0, 143.0, 153.0, 151.0, 151.0, 148.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 57.0, 57.0, 58.0, 57.0, 58.0, 59.0, 60.0, 57.0], "value": 58.5, "unit": "score"}]}]} 08:26:48 INFO - Return code: 0 08:26:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:26:48 INFO - # TBPL SUCCESS # 08:26:48 INFO - Running post-action listener: _package_coverage_data 08:26:48 INFO - Running post-action listener: _resource_record_post_action 08:26:48 INFO - [mozharness: 2017-10-02 15:26:48.449966Z] Finished run-tests step (success) 08:26:48 INFO - Running post-run listener: _resource_record_post_run 08:26:48 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292802560; Read time: 8; Write time: 144316 08:26:48 INFO - TinderboxPrint: CPU usage
13.0% 08:26:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:26:48 INFO - TinderboxPrint: I/O write bytes / time
292,802,560 / 144,316 08:26:48 INFO - TinderboxPrint: CPU idle
8,179.1 (86.9%) 08:26:48 INFO - TinderboxPrint: CPU user
1,180.1 (12.5%) 08:26:48 INFO - TinderboxPrint: Swap in / out
0 / 0 08:26:48 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 8974336; Read time: 0; Write time: 1740 08:26:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:26:48 INFO - run-tests - Wall time: 1166s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283828224; Read time: 8; Write time: 142576 08:26:49 INFO - Running post-run listener: _upload_blobber_files 08:26:49 INFO - Blob upload gear active. 08:26:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:26:49 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:26:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:26:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:26:49 INFO - (blobuploader) - INFO - Open directory for files ... 08:26:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:26:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:26:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:50 INFO - (blobuploader) - INFO - Done attempting. 08:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:26:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:51 INFO - (blobuploader) - INFO - Done attempting. 08:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:52 INFO - (blobuploader) - INFO - Done attempting. 08:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:26:55 INFO - (blobuploader) - INFO - Done attempting. 08:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:26:55 INFO - Return code: 0 08:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:26:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a165ae6676d2e5ea39d1070ce816525e28e4e44947cc2c355e5ca6da4f04bcb33628b112a8f401bc326c7f5ee96ac3d5443902833d8307b238eaac0d27c6e31a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aad58c1786397cc651ed25d7c4abcae753a9efab30c0d76db4dc0b431d1e2a485791db6e9e386bda67bcf076fd5f43e1007ff14438f4748ea3771aa9e6cad4a4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0fe029f21415aeac0fac6b5212ee282dbdb7a6a9aadcba46f19829b1555a8745f7fb3d18a346aee09ece54e6ee235799242b750f8a9abe26def2613b75441765", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94b43089662365b5d65c771c09d648f6d7432721e2ae81ffc117d58acbd2225f3d696295a4753b6deb3fd888f29cc1208c0ef77c6c97ca12faa0d9b7cd569216"} 08:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:26:55 INFO - Contents: 08:26:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a165ae6676d2e5ea39d1070ce816525e28e4e44947cc2c355e5ca6da4f04bcb33628b112a8f401bc326c7f5ee96ac3d5443902833d8307b238eaac0d27c6e31a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aad58c1786397cc651ed25d7c4abcae753a9efab30c0d76db4dc0b431d1e2a485791db6e9e386bda67bcf076fd5f43e1007ff14438f4748ea3771aa9e6cad4a4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0fe029f21415aeac0fac6b5212ee282dbdb7a6a9aadcba46f19829b1555a8745f7fb3d18a346aee09ece54e6ee235799242b750f8a9abe26def2613b75441765", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94b43089662365b5d65c771c09d648f6d7432721e2ae81ffc117d58acbd2225f3d696295a4753b6deb3fd888f29cc1208c0ef77c6c97ca12faa0d9b7cd569216"} 08:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 08:26:55 INFO - Copying logs to upload dir... 08:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 08:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.026982 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-02 08:26:55.880437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 08:26:55.888207) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a165ae6676d2e5ea39d1070ce816525e28e4e44947cc2c355e5ca6da4f04bcb33628b112a8f401bc326c7f5ee96ac3d5443902833d8307b238eaac0d27c6e31a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aad58c1786397cc651ed25d7c4abcae753a9efab30c0d76db4dc0b431d1e2a485791db6e9e386bda67bcf076fd5f43e1007ff14438f4748ea3771aa9e6cad4a4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0fe029f21415aeac0fac6b5212ee282dbdb7a6a9aadcba46f19829b1555a8745f7fb3d18a346aee09ece54e6ee235799242b750f8a9abe26def2613b75441765", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94b43089662365b5d65c771c09d648f6d7432721e2ae81ffc117d58acbd2225f3d696295a4753b6deb3fd888f29cc1208c0ef77c6c97ca12faa0d9b7cd569216"} build_url:https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/AjYC5gc0Qi-FnrVya_yOhg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/a165ae6676d2e5ea39d1070ce816525e28e4e44947cc2c355e5ca6da4f04bcb33628b112a8f401bc326c7f5ee96ac3d5443902833d8307b238eaac0d27c6e31a", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/aad58c1786397cc651ed25d7c4abcae753a9efab30c0d76db4dc0b431d1e2a485791db6e9e386bda67bcf076fd5f43e1007ff14438f4748ea3771aa9e6cad4a4", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/0fe029f21415aeac0fac6b5212ee282dbdb7a6a9aadcba46f19829b1555a8745f7fb3d18a346aee09ece54e6ee235799242b750f8a9abe26def2613b75441765", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/94b43089662365b5d65c771c09d648f6d7432721e2ae81ffc117d58acbd2225f3d696295a4753b6deb3fd888f29cc1208c0ef77c6c97ca12faa0d9b7cd569216"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-02 08:26:55.919886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:26:55.920229) ========= 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=6d15e502d8e29d5d2676d664000001c3-1506956414.549234-1450381287 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-02 08:26:56.000892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 08:26:56.001269) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-02 08:26:56.004752) ========= ========= Total master_lag: 0.36 =========