builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-079 starttime: 1501724384.79 results: success (0) revision: 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.789196) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.789700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.790040) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.807303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.807915) ========= 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=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 18:39:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.2M=0s 2017-08-02 18:39:45 (54.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.912668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.913397) ========= 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=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014781 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.964830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:44.965188) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 --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=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 18:39:45,591 truncating revision to first 12 chars 2017-08-02 18:39:45,592 Setting DEBUG logging. 2017-08-02 18:39:45,592 attempt 1/10 2017-08-02 18:39:45,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/792d0a2e04d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 18:39:46,050 unpacking tar archive at: mozilla-central-792d0a2e04d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.793104 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:45.771406) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:45.771794) ========= script_repo_revision: 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:45.772234) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:45.772539) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 18:39:45.781307) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-02 18:39:45.781617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:46 INFO - MultiFileLogger online at 20170802 18:39:46 in /builds/slave/test 18:39:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:39:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:46 INFO - {'append_to_log': False, 18:39:46 INFO - 'base_work_dir': '/builds/slave/test', 18:39:46 INFO - 'blob_upload_branch': 'Firefox', 18:39:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:46 INFO - 'branch': 'Firefox', 18:39:46 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:46 INFO - 'code_coverage': False, 18:39:46 INFO - 'config_files': ('talos/linux_config.py',), 18:39:46 INFO - 'default_actions': ('clobber', 18:39:46 INFO - 'read-buildbot-config', 18:39:46 INFO - 'download-and-extract', 18:39:46 INFO - 'populate-webroot', 18:39:46 INFO - 'create-virtualenv', 18:39:46 INFO - 'install', 18:39:46 INFO - 'setup-mitmproxy', 18:39:46 INFO - 'run-tests'), 18:39:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:46 INFO - 'disable_ccov_upload': False, 18:39:46 INFO - 'download_minidump_stackwalk': True, 18:39:46 INFO - 'download_symbols': 'ondemand', 18:39:46 INFO - 'enable_stylo': False, 18:39:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:46 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:46 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:46 INFO - 'gecko_profile': False, 18:39:46 INFO - 'gecko_profile_interval': 0, 18:39:46 INFO - 'installer_path': 'installer.exe', 18:39:46 INFO - 'log_level': 'info', 18:39:46 INFO - 'log_name': 'talos', 18:39:46 INFO - 'log_to_console': True, 18:39:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:46 INFO - 'opt_config_files': (), 18:39:46 INFO - 'pip_index': False, 18:39:46 INFO - 'suite': 'dromaeojs-e10s', 18:39:46 INFO - 'system_bits': '32', 18:39:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:46 INFO - 'title': 'talos-linux64-ix-079', 18:39:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:46 INFO - 'use_talos_json': True, 18:39:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:46 INFO - 'work_dir': 'build'} 18:39:46 INFO - [mozharness: 2017-08-03 01:39:46.513289Z] Running clobber step. 18:39:46 INFO - Running pre-action listener: _resource_record_pre_action 18:39:46 INFO - Running main action method: clobber 18:39:46 INFO - rmtree: /builds/slave/test/build 18:39:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:48 INFO - Running post-action listener: _resource_record_post_action 18:39:48 INFO - [mozharness: 2017-08-03 01:39:48.206313Z] Finished clobber step (success) 18:39:48 INFO - [mozharness: 2017-08-03 01:39:48.206414Z] Running read-buildbot-config step. 18:39:48 INFO - Running pre-action listener: _resource_record_pre_action 18:39:48 INFO - Running main action method: read_buildbot_config 18:39:48 INFO - Using buildbot properties: 18:39:48 INFO - { 18:39:48 INFO - "project": "", 18:39:48 INFO - "product": "firefox", 18:39:48 INFO - "who": "mh@glandium.org", 18:39:48 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:39:48 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:39:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:39:48 INFO - "stage_platform": "linux64-pgo", 18:39:48 INFO - "basedir": "/builds/slave/test", 18:39:48 INFO - "buildnumber": 107, 18:39:48 INFO - "platform": "ubuntu64_hw", 18:39:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:39:48 INFO - "slavebuilddir": "test", 18:39:48 INFO - "taskId": "YvMkFwEbRlqxI6zyLdvuJA", 18:39:48 INFO - "branch": "mozilla-central", 18:39:48 INFO - "script_repo_revision": "production", 18:39:48 INFO - "revision": "792d0a2e04d7bc337c77f4777848337ac6ba6dd6", 18:39:48 INFO - "slavename": "talos-linux64-ix-079", 18:39:48 INFO - "repo_path": "mozilla-central" 18:39:48 INFO - } 18:39:48 INFO - Finding installer, test and symbols from parent task. 18:39:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvMkFwEbRlqxI6zyLdvuJA'}, attempt #1 18:39:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YvMkFwEbRlqxI6zyLdvuJA'}, attempt #1 18:39:49 INFO - Task dependencies: HVGRaDqqSYePSzrqi_huVg 18:39:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg'}, attempt #1 18:39:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 18:39:49 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.test_packages.json 18:39:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.crashreporter-symbols.zip 18:39:49 INFO - Running post-action listener: _resource_record_post_action 18:39:49 INFO - [mozharness: 2017-08-03 01:39:49.572858Z] Finished read-buildbot-config step (success) 18:39:49 INFO - [mozharness: 2017-08-03 01:39:49.573078Z] Running download-and-extract step. 18:39:49 INFO - Running pre-action listener: _resource_record_pre_action 18:39:49 INFO - Running main action method: download_and_extract 18:39:49 INFO - mkdir: /builds/slave/test/build/tests 18:39: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')]} 18:39:49 INFO - trying https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.test_packages.json 18:39:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:39:50 INFO - Downloaded 989 bytes. 18:39:50 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:39:50 INFO - Using the following test package requirements: 18:39:50 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:39:50 INFO - u'common': [u'target.common.tests.zip'], 18:39:50 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:39:50 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:39:50 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:39:50 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:39:50 INFO - u'mozbase': [u'target.common.tests.zip'], 18:39:50 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:39:50 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:39:50 INFO - u'web-platform': [u'target.common.tests.zip', 18:39:50 INFO - u'target.web-platform.tests.tar.gz'], 18:39:50 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:39:50 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:39:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip 18:39:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:50 INFO - Fetch https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip into memory 18:39:51 INFO - Content-Length response header: 72959196 18:39:51 INFO - Bytes received: 72959196 18:40:02 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:40:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip 18:40:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:40:02 INFO - Fetch https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.common.tests.zip into memory 18:40:03 INFO - Content-Length response header: 72959196 18:40:03 INFO - Bytes received: 72959196 18:40:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.talos.tests.zip 18:40:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:40:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.talos.tests.zip into memory 18:40:16 INFO - Content-Length response header: 14496464 18:40:16 INFO - Bytes received: 14496464 18:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:16 INFO - trying https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 18:40:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:40:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:40:17 INFO - Downloaded 63024603 bytes. 18:40:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 18:40:17 INFO - mkdir: /builds/slave/test/properties 18:40:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:17 INFO - Contents: 18:40:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 18:40:17 INFO - Running post-action listener: _resource_record_post_action 18:40:17 INFO - Running post-action listener: set_extra_try_arguments 18:40:17 INFO - [mozharness: 2017-08-03 01:40:17.940440Z] Finished download-and-extract step (success) 18:40:17 INFO - [mozharness: 2017-08-03 01:40:17.940538Z] Running populate-webroot step. 18:40:17 INFO - Running pre-action listener: _resource_record_pre_action 18:40:17 INFO - Running main action method: populate_webroot 18:40:17 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:40:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:40:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:40:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:40:17 INFO - 'tests': ['damp', 'tps']}, 18:40:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:40:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:40:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:40:17 INFO - 'other-e10s': {'tests': ['a11yr', 18:40:17 INFO - 'ts_paint', 18:40:17 INFO - 'tpaint', 18:40:17 INFO - 'sessionrestore', 18:40:17 INFO - 'sessionrestore_many_windows', 18:40:17 INFO - 'sessionrestore_no_auto_restore', 18:40:17 INFO - 'tabpaint']}, 18:40:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:40:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:40:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:17 INFO - 'talos_options': ['--mitmproxy', 18:40:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:17 INFO - '--firstNonBlankPaint'], 18:40:17 INFO - 'tests': ['quantum_pageload_google', 18:40:17 INFO - 'quantum_pageload_youtube', 18:40:17 INFO - 'quantum_pageload_amazon', 18:40:17 INFO - 'quantum_pageload_facebook']}, 18:40:17 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:17 INFO - 'talos_options': ['--stylo', 18:40:17 INFO - '--mitmproxy', 18:40:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:17 INFO - '--firstNonBlankPaint'], 18:40:17 INFO - 'tests': ['quantum_pageload_google', 18:40:17 INFO - 'quantum_pageload_youtube', 18:40:17 INFO - 'quantum_pageload_amazon', 18:40:17 INFO - 'quantum_pageload_facebook']}, 18:40:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:40:17 INFO - 'tsvgr_opacity', 18:40:17 INFO - 'tart', 18:40:17 INFO - 'tscrollx', 18:40:17 INFO - 'cart', 18:40:17 INFO - 'tsvg_static']}, 18:40:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:40:17 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:40:17 INFO - 'talos_options': ['--stylo', 18:40:17 INFO - '--stylo-threads=1', 18:40:17 INFO - '--mitmproxy', 18:40:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:40:17 INFO - '--firstNonBlankPaint'], 18:40:17 INFO - 'tests': ['tp6_google', 18:40:17 INFO - 'tp6_youtube', 18:40:17 INFO - 'tp6_amazon', 18:40:17 INFO - 'tp6_facebook']}, 18:40:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:40:17 INFO - 'talos_options': ['--xperf_path', 18:40:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:40:17 INFO - 'tests': ['tp5n']}}} 18:40:17 INFO - Running post-action listener: _resource_record_post_action 18:40:17 INFO - [mozharness: 2017-08-03 01:40:17.949079Z] Finished populate-webroot step (success) 18:40:17 INFO - [mozharness: 2017-08-03 01:40:17.949168Z] Running create-virtualenv step. 18:40:17 INFO - Running pre-action listener: _resource_record_pre_action 18:40:17 INFO - Running main action method: create_virtualenv 18:40:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:40:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:40:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:40:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:40:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:40:18 INFO - Using real prefix '/usr' 18:40:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:40:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:40:20 INFO - Installing pip.................done. 18:40:20 INFO - Return code: 0 18:40:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:40:20 INFO - Reading from file tmpfile_stdout 18:40:20 INFO - Output received: 18:40:20 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:40:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:40:20 INFO - Using env: {'DISPLAY': ':0', 18:40:20 INFO - 'HOME': '/home/cltbld', 18:40:20 INFO - 'LANG': 'en_US.UTF-8', 18:40:20 INFO - 'LANGUAGE': 'en_US:en', 18:40:20 INFO - 'LOGNAME': 'cltbld', 18:40:20 INFO - 'MAIL': '/var/mail/cltbld', 18:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:20 INFO - 'MOZ_NO_REMOTE': '1', 18:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:20 INFO - 'NO_EM_RESTART': '1', 18:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:20 INFO - 'PWD': '/builds/slave/test', 18:40:20 INFO - 'SHELL': '/bin/bash', 18:40:20 INFO - 'SHLVL': '1', 18:40:20 INFO - 'TERM': 'linux', 18:40:20 INFO - 'TMOUT': '86400', 18:40:20 INFO - 'USER': 'cltbld', 18:40:20 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:20 INFO - '_': '/tools/buildbot/bin/python'} 18:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:40:20 INFO - Cleaning up... 18:40:20 INFO - Return code: 0 18:40:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:40:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:40:20 INFO - Using env: {'DISPLAY': ':0', 18:40:20 INFO - 'HOME': '/home/cltbld', 18:40:20 INFO - 'LANG': 'en_US.UTF-8', 18:40:20 INFO - 'LANGUAGE': 'en_US:en', 18:40:20 INFO - 'LOGNAME': 'cltbld', 18:40:20 INFO - 'MAIL': '/var/mail/cltbld', 18:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:20 INFO - 'MOZ_NO_REMOTE': '1', 18:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:20 INFO - 'NO_EM_RESTART': '1', 18:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:20 INFO - 'PWD': '/builds/slave/test', 18:40:20 INFO - 'SHELL': '/bin/bash', 18:40:20 INFO - 'SHLVL': '1', 18:40:20 INFO - 'TERM': 'linux', 18:40:20 INFO - 'TMOUT': '86400', 18:40:20 INFO - 'USER': 'cltbld', 18:40:20 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:20 INFO - '_': '/tools/buildbot/bin/python'} 18:40:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:21 INFO - Downloading/unpacking psutil>=3.1.1 18:40:21 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 18:40:21 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 18:40:21 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 18:40:21 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 18:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:22 INFO - Installing collected packages: psutil 18:40:22 INFO - Running setup.py install for psutil 18:40:22 INFO - building 'psutil._psutil_linux' extension 18:40:22 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 18:40:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:40:22 INFO - building 'psutil._psutil_posix' extension 18:40:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:40:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:40:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:40:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:40:22 INFO - Successfully installed psutil 18:40:22 INFO - Cleaning up... 18:40:22 INFO - Return code: 0 18:40:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:40: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')]} 18:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40: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')]} 18:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:40:22 INFO - Using env: {'DISPLAY': ':0', 18:40:22 INFO - 'HOME': '/home/cltbld', 18:40:22 INFO - 'LANG': 'en_US.UTF-8', 18:40:22 INFO - 'LANGUAGE': 'en_US:en', 18:40:22 INFO - 'LOGNAME': 'cltbld', 18:40:22 INFO - 'MAIL': '/var/mail/cltbld', 18:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:22 INFO - 'MOZ_NO_REMOTE': '1', 18:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:22 INFO - 'NO_EM_RESTART': '1', 18:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:22 INFO - 'PWD': '/builds/slave/test', 18:40:22 INFO - 'SHELL': '/bin/bash', 18:40:22 INFO - 'SHLVL': '1', 18:40:22 INFO - 'TERM': 'linux', 18:40:22 INFO - 'TMOUT': '86400', 18:40:22 INFO - 'USER': 'cltbld', 18:40:22 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:22 INFO - '_': '/tools/buildbot/bin/python'} 18:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:40:23 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 18:40:23 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 18:40:23 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 18:40:23 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 18:40:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:40:24 INFO - Installing collected packages: mozsystemmonitor 18:40:24 INFO - Running setup.py install for mozsystemmonitor 18:40:24 INFO - Successfully installed mozsystemmonitor 18:40:24 INFO - Cleaning up... 18:40:24 INFO - Return code: 0 18:40:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:40:24 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')]} 18:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:24 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')]} 18:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:24 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 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:24 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 18:40:24 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 18:40:24 INFO - Using env: {'DISPLAY': ':0', 18:40:24 INFO - 'HOME': '/home/cltbld', 18:40:24 INFO - 'LANG': 'en_US.UTF-8', 18:40:24 INFO - 'LANGUAGE': 'en_US:en', 18:40:24 INFO - 'LOGNAME': 'cltbld', 18:40:24 INFO - 'MAIL': '/var/mail/cltbld', 18:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:24 INFO - 'MOZ_NO_REMOTE': '1', 18:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:24 INFO - 'NO_EM_RESTART': '1', 18:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:24 INFO - 'PWD': '/builds/slave/test', 18:40:24 INFO - 'SHELL': '/bin/bash', 18:40:24 INFO - 'SHLVL': '1', 18:40:24 INFO - 'TERM': 'linux', 18:40:24 INFO - 'TMOUT': '86400', 18:40:24 INFO - 'USER': 'cltbld', 18:40:24 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:24 INFO - '_': '/tools/buildbot/bin/python'} 18:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:24 INFO - Downloading/unpacking jsonschema==2.5.1 18:40:24 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 18:40:24 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 18:40:24 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 18:40:24 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 18:40:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:40:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:25 INFO - Downloading functools32-3.2.3-2.tar.gz 18:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:40:25 INFO - warning: no files found matching '*.txt' 18:40:25 INFO - no previously-included directories found matching 'build' 18:40:25 INFO - no previously-included directories found matching 'dist' 18:40:25 INFO - no previously-included directories found matching '.git*' 18:40:25 INFO - Installing collected packages: jsonschema, functools32 18:40:25 INFO - Running setup.py install for functools32 18:40:25 INFO - warning: no files found matching '*.txt' 18:40:25 INFO - no previously-included directories found matching 'build' 18:40:25 INFO - no previously-included directories found matching 'dist' 18:40:25 INFO - no previously-included directories found matching '.git*' 18:40:26 INFO - Successfully installed jsonschema functools32 18:40:26 INFO - Cleaning up... 18:40:26 INFO - Return code: 0 18:40:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:40:26 INFO - Using env: {'DISPLAY': ':0', 18:40:26 INFO - 'HOME': '/home/cltbld', 18:40:26 INFO - 'LANG': 'en_US.UTF-8', 18:40:26 INFO - 'LANGUAGE': 'en_US:en', 18:40:26 INFO - 'LOGNAME': 'cltbld', 18:40:26 INFO - 'MAIL': '/var/mail/cltbld', 18:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:26 INFO - 'MOZ_NO_REMOTE': '1', 18:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:26 INFO - 'NO_EM_RESTART': '1', 18:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:26 INFO - 'PWD': '/builds/slave/test', 18:40:26 INFO - 'SHELL': '/bin/bash', 18:40:26 INFO - 'SHLVL': '1', 18:40:26 INFO - 'TERM': 'linux', 18:40:26 INFO - 'TMOUT': '86400', 18:40:26 INFO - 'USER': 'cltbld', 18:40:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:26 INFO - '_': '/tools/buildbot/bin/python'} 18:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:40:26 INFO - Cleaning up... 18:40:26 INFO - Return code: 0 18:40:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:40:26 INFO - Using env: {'DISPLAY': ':0', 18:40:26 INFO - 'HOME': '/home/cltbld', 18:40:26 INFO - 'LANG': 'en_US.UTF-8', 18:40:26 INFO - 'LANGUAGE': 'en_US:en', 18:40:26 INFO - 'LOGNAME': 'cltbld', 18:40:26 INFO - 'MAIL': '/var/mail/cltbld', 18:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:26 INFO - 'MOZ_NO_REMOTE': '1', 18:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:26 INFO - 'NO_EM_RESTART': '1', 18:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:26 INFO - 'PWD': '/builds/slave/test', 18:40:26 INFO - 'SHELL': '/bin/bash', 18:40:26 INFO - 'SHLVL': '1', 18:40:26 INFO - 'TERM': 'linux', 18:40:26 INFO - 'TMOUT': '86400', 18:40:26 INFO - 'USER': 'cltbld', 18:40:26 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:26 INFO - '_': '/tools/buildbot/bin/python'} 18:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:26 INFO - Downloading/unpacking blobuploader==1.2.4 18:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:27 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:28 INFO - Downloading docopt-0.6.1.tar.gz 18:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:28 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:28 INFO - Running setup.py install for blobuploader 18:40:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:28 INFO - Running setup.py install for requests 18:40:28 INFO - Running setup.py install for docopt 18:40:28 INFO - Successfully installed blobuploader requests docopt 18:40:28 INFO - Cleaning up... 18:40:28 INFO - Return code: 0 18:40:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:28 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')]} 18:40:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:28 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')]} 18:40:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:28 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 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:28 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 18:40:28 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 18:40:28 INFO - Using env: {'DISPLAY': ':0', 18:40:28 INFO - 'HOME': '/home/cltbld', 18:40:28 INFO - 'LANG': 'en_US.UTF-8', 18:40:28 INFO - 'LANGUAGE': 'en_US:en', 18:40:28 INFO - 'LOGNAME': 'cltbld', 18:40:28 INFO - 'MAIL': '/var/mail/cltbld', 18:40:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:28 INFO - 'MOZ_NO_REMOTE': '1', 18:40:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:28 INFO - 'NO_EM_RESTART': '1', 18:40:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:28 INFO - 'PWD': '/builds/slave/test', 18:40:28 INFO - 'SHELL': '/bin/bash', 18:40:28 INFO - 'SHLVL': '1', 18:40:28 INFO - 'TERM': 'linux', 18:40:28 INFO - 'TMOUT': '86400', 18:40:28 INFO - 'USER': 'cltbld', 18:40:28 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:28 INFO - '_': '/tools/buildbot/bin/python'} 18:40:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:28 INFO - Running setup.py (path:/tmp/pip-e0iHiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:29 INFO - Running setup.py (path:/tmp/pip-3CXIVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:29 INFO - Running setup.py (path:/tmp/pip-cb0hUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:29 INFO - Running setup.py (path:/tmp/pip-CuVbpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:29 INFO - Running setup.py (path:/tmp/pip-a7qrnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:29 INFO - Running setup.py (path:/tmp/pip-vGY3Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:29 INFO - Running setup.py (path:/tmp/pip-TxZLO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:29 INFO - Running setup.py (path:/tmp/pip-JkbasA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:29 INFO - Running setup.py (path:/tmp/pip-hrhFZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:29 INFO - Running setup.py (path:/tmp/pip-Ukc8gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:29 INFO - Running setup.py (path:/tmp/pip-E3Sylv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:29 INFO - Running setup.py (path:/tmp/pip-YtIpoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:29 INFO - Running setup.py (path:/tmp/pip-CGCE_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:30 INFO - Running setup.py (path:/tmp/pip-ikSGsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:30 INFO - Running setup.py (path:/tmp/pip-36us1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:30 INFO - Running setup.py (path:/tmp/pip-VpqS_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:30 INFO - Running setup.py (path:/tmp/pip-pz_1Bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:30 INFO - Running setup.py install for manifestparser 18:40:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:30 INFO - Running setup.py install for mozcrash 18:40:30 INFO - Running setup.py install for mozdebug 18:40:30 INFO - Running setup.py install for mozdevice 18:40:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:30 INFO - Running setup.py install for mozfile 18:40:30 INFO - Running setup.py install for mozhttpd 18:40:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:30 INFO - Running setup.py install for mozinfo 18:40:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for mozInstall 18:40:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for mozleak 18:40:31 INFO - Running setup.py install for mozlog 18:40:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for moznetwork 18:40:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for mozprocess 18:40:31 INFO - Running setup.py install for mozprofile 18:40:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for mozrunner 18:40:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:31 INFO - Running setup.py install for mozscreenshot 18:40:31 INFO - Running setup.py install for moztest 18:40:31 INFO - Running setup.py install for mozversion 18:40:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:32 INFO - Cleaning up... 18:40:32 INFO - Return code: 0 18:40:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40: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')]} 18:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40: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')]} 18:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:40:32 INFO - Using env: {'DISPLAY': ':0', 18:40:32 INFO - 'HOME': '/home/cltbld', 18:40:32 INFO - 'LANG': 'en_US.UTF-8', 18:40:32 INFO - 'LANGUAGE': 'en_US:en', 18:40:32 INFO - 'LOGNAME': 'cltbld', 18:40:32 INFO - 'MAIL': '/var/mail/cltbld', 18:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:32 INFO - 'MOZ_NO_REMOTE': '1', 18:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:32 INFO - 'NO_EM_RESTART': '1', 18:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:32 INFO - 'PWD': '/builds/slave/test', 18:40:32 INFO - 'SHELL': '/bin/bash', 18:40:32 INFO - 'SHLVL': '1', 18:40:32 INFO - 'TERM': 'linux', 18:40:32 INFO - 'TMOUT': '86400', 18:40:32 INFO - 'USER': 'cltbld', 18:40:32 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:32 INFO - '_': '/tools/buildbot/bin/python'} 18:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:32 INFO - Running setup.py (path:/tmp/pip-yHuo8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:32 INFO - Running setup.py (path:/tmp/pip-eHVRpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:32 INFO - Running setup.py (path:/tmp/pip-5SOgVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:32 INFO - Running setup.py (path:/tmp/pip-U3PDg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:32 INFO - Running setup.py (path:/tmp/pip-QcQQ8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:32 INFO - Running setup.py (path:/tmp/pip-JmYXZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:32 INFO - Running setup.py (path:/tmp/pip-qUGbXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:32 INFO - Running setup.py (path:/tmp/pip-S13dy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:32 INFO - Running setup.py (path:/tmp/pip-r9HJ9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:32 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)) 18:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:32 INFO - Running setup.py (path:/tmp/pip-eE88lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:33 INFO - Running setup.py (path:/tmp/pip-FzLd38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:33 INFO - Running setup.py (path:/tmp/pip-cGbFz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:33 INFO - Running setup.py (path:/tmp/pip-oWFoIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:33 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)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:33 INFO - Running setup.py (path:/tmp/pip-Kz6ty1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:33 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)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:33 INFO - Running setup.py (path:/tmp/pip-a436_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:33 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)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:33 INFO - Running setup.py (path:/tmp/pip-F5Hx9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:33 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)) 18:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:33 INFO - Running setup.py (path:/tmp/pip-HvSJto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:33 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)) 18:40:33 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)) 18:40:33 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)) 18:40:33 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)) 18:40:33 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)) 18:40:33 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)) 18:40:33 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)) 18:40:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:33 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 18:40:33 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 18:40:33 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 18:40:33 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 18:40:34 INFO - Downloading blessings-1.6.tar.gz 18:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:34 INFO - Installing collected packages: blessings 18:40:34 INFO - Running setup.py install for blessings 18:40:34 INFO - Successfully installed blessings 18:40:34 INFO - Cleaning up... 18:40:34 INFO - Return code: 0 18:40:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:35 INFO - Reading from file tmpfile_stdout 18:40:35 INFO - Current package versions: 18:40:35 INFO - argparse == 1.2.1 18:40:35 INFO - blessings == 1.6 18:40:35 INFO - blobuploader == 1.2.4 18:40:35 INFO - docopt == 0.6.1 18:40:35 INFO - functools32 == 3.2.3-2 18:40:35 INFO - jsonschema == 2.5.1 18:40:35 INFO - manifestparser == 1.1 18:40:35 INFO - mozInstall == 1.13 18:40:35 INFO - mozcrash == 1.0 18:40:35 INFO - mozdebug == 0.1 18:40:35 INFO - mozdevice == 0.51 18:40:35 INFO - mozfile == 1.2 18:40:35 INFO - mozhttpd == 0.7 18:40:35 INFO - mozinfo == 0.10 18:40:35 INFO - mozleak == 0.1 18:40:35 INFO - mozlog == 3.5 18:40:35 INFO - moznetwork == 0.27 18:40:35 INFO - mozprocess == 0.25 18:40:35 INFO - mozprofile == 0.28 18:40:35 INFO - mozrunner == 6.13 18:40:35 INFO - mozscreenshot == 0.1 18:40:35 INFO - mozsystemmonitor == 0.3 18:40:35 INFO - moztest == 0.8 18:40:35 INFO - mozversion == 1.4 18:40:35 INFO - psutil == 3.1.1 18:40:35 INFO - requests == 1.2.3 18:40:35 INFO - wsgiref == 0.1.2 18:40:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:40:35 INFO - Using env: {'DISPLAY': ':0', 18:40:35 INFO - 'HOME': '/home/cltbld', 18:40:35 INFO - 'LANG': 'en_US.UTF-8', 18:40:35 INFO - 'LANGUAGE': 'en_US:en', 18:40:35 INFO - 'LOGNAME': 'cltbld', 18:40:35 INFO - 'MAIL': '/var/mail/cltbld', 18:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:35 INFO - 'MOZ_NO_REMOTE': '1', 18:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:35 INFO - 'NO_EM_RESTART': '1', 18:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:35 INFO - 'PWD': '/builds/slave/test', 18:40:35 INFO - 'SHELL': '/bin/bash', 18:40:35 INFO - 'SHLVL': '1', 18:40:35 INFO - 'TERM': 'linux', 18:40:35 INFO - 'TMOUT': '86400', 18:40:35 INFO - 'USER': 'cltbld', 18:40:35 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:35 INFO - '_': '/tools/buildbot/bin/python'} 18:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 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)) 18:40:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:40:36 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)) 18:40:36 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)) 18:40:36 INFO - Installing collected packages: simplejson 18:40:36 INFO - Running setup.py install for simplejson 18:40:36 INFO - building 'simplejson._speedups' extension 18:40:36 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 18:40:37 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 18:40:37 INFO - Successfully installed simplejson 18:40:37 INFO - Cleaning up... 18:40:37 INFO - Return code: 0 18:40:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40:37 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')]} 18:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:37 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')]} 18:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c40d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, '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': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', '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 18:40:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:40:37 INFO - Using env: {'DISPLAY': ':0', 18:40:37 INFO - 'HOME': '/home/cltbld', 18:40:37 INFO - 'LANG': 'en_US.UTF-8', 18:40:37 INFO - 'LANGUAGE': 'en_US:en', 18:40:37 INFO - 'LOGNAME': 'cltbld', 18:40:37 INFO - 'MAIL': '/var/mail/cltbld', 18:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:37 INFO - 'MOZ_NO_REMOTE': '1', 18:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:37 INFO - 'NO_EM_RESTART': '1', 18:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:37 INFO - 'PWD': '/builds/slave/test', 18:40:37 INFO - 'SHELL': '/bin/bash', 18:40:37 INFO - 'SHLVL': '1', 18:40:37 INFO - 'TERM': 'linux', 18:40:37 INFO - 'TMOUT': '86400', 18:40:37 INFO - 'USER': 'cltbld', 18:40:37 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:37 INFO - '_': '/tools/buildbot/bin/python'} 18:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:37 INFO - Cleaning up... 18:40:37 INFO - Return code: 0 18:40:37 INFO - Running post-action listener: _resource_record_post_action 18:40:37 INFO - Running post-action listener: _start_resource_monitoring 18:40:37 INFO - Starting resource monitoring. 18:40:37 INFO - [mozharness: 2017-08-03 01:40:37.802251Z] Finished create-virtualenv step (success) 18:40:37 INFO - [mozharness: 2017-08-03 01:40:37.802767Z] Running install step. 18:40:37 INFO - Running pre-action listener: _resource_record_pre_action 18:40:37 INFO - Running main action method: install 18:40:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:38 INFO - Reading from file tmpfile_stdout 18:40:38 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:38 INFO - Reading from file tmpfile_stdout 18:40:38 INFO - Output received: 18:40:38 INFO - Usage: mozinstall [options] installer 18:40:38 INFO - Options: 18:40:38 INFO - -h, --help show this help message and exit 18:40:38 INFO - -d DEST, --destination=DEST 18:40:38 INFO - Directory to install application into. [default: 18:40:38 INFO - "/builds/slave/test"] 18:40:38 INFO - --app=APP Application being installed. [default: firefox] 18:40:38 INFO - mkdir: /builds/slave/test/build/application 18:40:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:40:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:40:56 INFO - Reading from file tmpfile_stdout 18:40:56 INFO - Output received: 18:40:56 INFO - /builds/slave/test/build/application/firefox/firefox 18:40:56 INFO - Running post-action listener: _resource_record_post_action 18:40:56 INFO - [mozharness: 2017-08-03 01:40:56.200911Z] Finished install step (success) 18:40:56 INFO - [mozharness: 2017-08-03 01:40:56.201194Z] Running setup-mitmproxy step. 18:40:56 INFO - Running pre-action listener: _resource_record_pre_action 18:40:56 INFO - Running main action method: setup_mitmproxy 18:40:56 INFO - Skipping: mitmproxy is not required 18:40:56 INFO - Running post-action listener: _resource_record_post_action 18:40:56 INFO - [mozharness: 2017-08-03 01:40:56.202391Z] Finished setup-mitmproxy step (success) 18:40:56 INFO - [mozharness: 2017-08-03 01:40:56.202612Z] Running run-tests step. 18:40:56 INFO - Running pre-action listener: _resource_record_pre_action 18:40:56 INFO - Running pre-action listener: _set_gcov_prefix 18:40:56 INFO - Running main action method: run_tests 18:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:40:56 INFO - Python 2.7.3 18:40:56 INFO - Return code: 0 18:40:56 INFO - grabbing minidump binary from tooltool 18:40: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')]} 18:40:56 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 0x2c3deb0>, '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 0x2c3edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c3f240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:40:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:40:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:40:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--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 18:40:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:40:56 INFO - Return code: 0 18:40:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:40:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:40:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:40:56 INFO - ENV: RUST_BACKTRACE is now 1 18:40:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:40:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 18:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 18:40:56 INFO - Using env: {'DISPLAY': ':0', 18:40:56 INFO - 'HOME': '/home/cltbld', 18:40:56 INFO - 'LANG': 'en_US.UTF-8', 18:40:56 INFO - 'LANGUAGE': 'en_US:en', 18:40:56 INFO - 'LOGNAME': 'cltbld', 18:40:56 INFO - 'MAIL': '/var/mail/cltbld', 18:40:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:40:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:56 INFO - 'MOZ_NO_REMOTE': '1', 18:40:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:40:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:56 INFO - 'NO_EM_RESTART': '1', 18:40:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:56 INFO - 'PWD': '/builds/slave/test', 18:40:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:40:56 INFO - 'RUST_BACKTRACE': '1', 18:40:56 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:40:56 INFO - 'SHELL': '/bin/bash', 18:40:56 INFO - 'SHLVL': '1', 18:40:56 INFO - 'TERM': 'linux', 18:40:56 INFO - 'TMOUT': '86400', 18:40:56 INFO - 'USER': 'cltbld', 18:40:56 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602', 18:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:56 INFO - '_': '/tools/buildbot/bin/python'} 18:40:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 18:40:56 INFO - mozversion application_buildid: 20170802231601 18:40:56 INFO - mozversion application_changeset: 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 18:40:56 INFO - mozversion application_display_name: Nightly 18:40:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:40:56 INFO - mozversion application_name: Firefox 18:40:56 INFO - mozversion application_remotingname: firefox 18:40:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:40:56 INFO - mozversion application_vendor: Mozilla 18:40:56 INFO - mozversion application_version: 57.0a1 18:40:56 INFO - mozversion platform_buildid: 20170802231601 18:40:56 INFO - mozversion platform_changeset: 792d0a2e04d7bc337c77f4777848337ac6ba6dd6 18:40:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:40:56 INFO - mozversion platform_version: 57.0a1 18:40:56 INFO - using testdate: 1501724456 18:40:56 INFO - actual date: 1501724456 18:40:56 INFO - starting webserver on 'localhost:40362' 18:40:56 INFO - SUITE-START | Running 2 tests 18:40:56 INFO - TEST-START | dromaeo_css 18:40:56 INFO - Initialising browser for dromaeo_css test... 18:40:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40362/getInfo.html -profile /tmp/tmpKAIQHr/profile 18:40:56 INFO - TEST-INFO | started process 17260 (/builds/slave/test/build/application/firefox/firefox http://localhost:40362/getInfo.html) 18:41:02 INFO - TEST-INFO | 17260: exit 0 18:41:02 INFO - Browser initialized. 18:41:02 INFO - Running cycle 1/1 for dromaeo_css test... 18:41:02 INFO - TEST-INFO | started process 17467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKAIQHr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:41:03 INFO - PID 17467 | 18:41:03 INFO - PID 17467 | (/builds/slave/test/build/application/firefox/firefox:17517): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:41:03 INFO - PID 17467 | 18:41:13 INFO - PID 17467 | RSS: Main: 165343232 18:41:13 INFO - PID 17467 | 18:44:12 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40362/tests/dromaeo/cssquery-ext.html) 18:44:13 INFO - PID 17467 | RSS: Main: 167129088 18:44:13 INFO - PID 17467 | 18:47:14 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-ext.html (next: http://localhost:40362/tests/dromaeo/cssquery-jquery.html) 18:47:15 INFO - PID 17467 | RSS: Main: 164179968 18:47:15 INFO - PID 17467 | 18:50:17 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40362/tests/dromaeo/cssquery-mootools.html) 18:50:17 INFO - PID 17467 | RSS: Main: 167096320 18:50:17 INFO - PID 17467 | 18:53:19 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40362/tests/dromaeo/cssquery-prototype.html) 18:53:19 INFO - PID 17467 | RSS: Main: 164888576 18:53:19 INFO - PID 17467 | 18:56:23 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40362/tests/dromaeo/cssquery-yui.html) 18:56:24 INFO - PID 17467 | RSS: Main: 168845312 18:56:24 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | Cycle 1(1): loaded http://localhost:40362/tests/dromaeo/cssquery-yui.html (next: http://localhost:40362/tests/dromaeo/cssquery-dojo.html) 18:59:25 INFO - PID 17467 | RSS: Main: 169242624 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | __start_tp_report 18:59:25 INFO - PID 17467 | _x_x_mozilla_page_load 18:59:25 INFO - PID 17467 | _x_x_mozilla_page_load_details 18:59:25 INFO - PID 17467 | |i|pagename|runs| 18:59:25 INFO - PID 17467 | |0;dojo.html;3390.3727810355085;3423.2639982403784;3423.7774544654594;3442.173878269216;3457.567804024497;6200.813975580729;6211.720472578733;6289.685515724213;6297.055441683749;6342.873142537146;6149.3235744068115;6249.312575616678;6250.8124756257275;6257;6267.686615669221;5398.78404863805;5458.918116228259;5459.727013649322;5473.8357849264385;5500.7524661390335;5529.972350138244;5578.274824272859;5581.7209139543065;5608.6073974821775;5635.520980716644;5465.371482279549;5532.889342213153;5553.194786755897;5621.7751289948355;5648.830535083954;5388.811391601275;5455.290812194429;5462.289902312674;5462.617616766828;5494.340679118492;5470.316210473691;5480.150576660624;5499.065158922953;5537.723113844291;5541.473560011793;5972.9701351493395;6091.208142941434;6173.783917562864;6176.8764624707255;6208.1308616793685;6629.436497897636;6660.134182556237;6669;6670.93329066708;6671.86656266872;6765.695543700545;6803.523753337268;6814.318568143196;6816.522843400964;6817.216020157695;6288.654124023177;6299.086632438317;6316.210473690789;6321.083442900754;6322.241331040259;6856.6228857413325;6905.447564194852;6935.063766391573;6993.230744618088;7019.192792828788;6554.9672251639395;6669.933300666931;6678.565893216925;6719.126513553207;6744.22441419243;6756.324367563205;6763.154605674291;6763.695633696496;6764;6769.018492318586;6674.933250667431;6675.866482670416;6682.565633233824;6765.560238584476;6786.049953006583;6779.762708305186;6801.4898882584;6808.761693340709;6812.386885180357;6817.625030623264;4870.586000190024;4877.951240483242;4934.309196712463;4934.5312195341385;4937.901241975141;4307.698461107755;4312.396264522969;4333.934990975138;4385.802638881258;4410;6349.809505714836;6429.8714025720155;6455.193100862392;6456.9354306456335;6462.418382345518;6291.339409362043;6809.455243580502;6817.454603631698;6817.931820681829;6818.829529261709;6322.873542529123;6326.873462530723;6332.303446620868;6339.302676705559;6415.069814876817;5589.217509548666;5590.357108932443;5592.7762889484775;5593.3847276799515;5606.6916319602815;7103.396211322096;7140.107486564179;7144.3570078693165;7209.387202087776;7230.349268565854;6601.075849381186;6734.989751537309;6777;6844.8973265402055;6850.691718872762;7045.330693584101;7051.788446346618;7053.823654408476;7065.894011589933;7071.151461824614;6555.410013098844;6599.406053455212;6639.336066393322;6647.268800431852;6656.434203092791;6725.630090345078;6761.695723692347;6799.89800153008;6817.318268173143;6878.3465570770695;6557.639329836714;6573.375529324707;6619.569727967667;6633.568818027006;6638.701258443478;6446.903296450463;6506.869862602816;6545.770898018546;6547.672616369257;6551.6069035858;6501.577397469149;6533.542652014314;6553.934460655332;6565.638889861103;6603.900941485786;6442.677866106582;6631.469482441489;6639.103720997604;6679.56582822115;6707.798766037026;6440.516961228021;6450.967745161244;6510.121133646897;6527.184101987252;6542.8364290893105 18:59:25 INFO - PID 17467 | |1;ext.html;865.2081451918314;909.454327403558;937.2736129499636;964.594870154535;967.2793768642363;41882.37176442356;42385.57614423855;42621.36067958983;42677.78661106694;42721;40325.59674403255;40358.19283614333;40563.59436405635;40657.390139147865;40679.38980915289;6552.377524135223;6619.8014059578045;6631.336866313378;6631.7347306107695;6631.867362652744;6661.9000714989315;6727.360900714424;6748.932510674904;6758.324167583251;6788.049673045777;7340.743073992411;7521.736739214129;7523.435742319348;7525.285097915689;7525.924740752577;7446.2553744625375;7471.178170401252;7471.925280747178;7493.73771917983;7497.962510187442;6743.5953842769595;6811.25076241613;7167.3549380556;7350.11798584168;7370.189279179286;39593.20813583712;39739.8013009936;39869.60130398717;39898.40152397716;39991;3401.1667141550233;3419.606745224306;3428.3828910796046;3432.3306955143757;3448.8620455181763;31367.686323136706;31420.842895785605;31544.684553154635;31552.368952620818;31562.684373156433;5003.874903127415;5017.34774479319;5021.096202683516;5040.294358789773;5057.747112644353;216969;216991;218852;219791;220045;52192.21711674328;52206.47793522092;52256;52264.21603675948;52339;54489.72755136278;54722.17916731252;54765.452345476035;54790;54914.17628735572;16848.073355965294;17069.40257090996;17140;17181.140942952803;17219.913900430667;14075.71848563023;14126.152430854181;14131.929340353438;14133.85866141346;14135.85864141366;15650.13924234178;15720.528384148494;15754.76367854483;15791.684166316609;15809.36762529509;5909.379515150933;6029.186059881859;6041;6142.324344322121;6167.907481387782;1080.287010573018;1080.573173596425;1084.8481212630238;1090.7818436312768;1100.4442756408123;24590.139345122836;24601.507969840863;24622;24684.876575617007;24785.25644230676;1194.9820752688718;1201.1291813435364;1212.6422705301957;1213.5752486629785;1220.6338098570393;13064.412101455457;13076.803847942288;17703.645927081387;17845;18100.909495452437;264787;267879;267939;268218;269505;58427.41572584305;61593;61709.074363884574;61754.69122654358;61900.38099619036;1493.3877110384908;1518.2105305241212;1525.0620868165997;1528.9311980960883;1531.1043039821607;30406.239844004078;30744.84627576848;30794.846025769726;30842.074737757903;31069.533956991116;56848;57444.425555745576;57471.71264143653;57498.7125064372;57582;231263;233586;234197;234446;234472;37152.07119822026;37877.242455151296;37902.24195516019;38042.239155216186;38228.80885595554;46208.76895615501;46331.30503042525;46364.768176158905;46624.30063548982;46762.29856552086;36211.81894090513;36490.452643210905;36675;36751.816240918626;36770.632293677794;35022.47466288059;35368.646313536534;35513.28973420569;35945.10137246485;36203.63796362003;40757.388639171026;41083.58916410917;41535.58464415317;41731.37402938898;41825.581744183386;34285.14287142841;34584.48123278103;34778.478322824674;34822;35524.64475355214;25730.228093157235;26973.055943041898;27071;27433.725662743116;27609.309767255978 18:59:25 INFO - PID 17467 | |2;jquery.html;571.072007987021;571.2316933724139;571.8277531061326;574.250602963133;592.5970340168685;23259.418514537145;24054.639180412265;24095.879520602415;24138.51722965542;24143.03427862888;25338.873305633493;26543.601845972276;27400.45199096022;27746.722532774667;27930.860345698293;6160.876782464348;6337.746490140389;6360.17317748692;6368.458681012096;6371;5732.971335143318;6189.876202475948;6219.098230756537;6233.096201050845;6248.187735594389;6236.656983865885;6243.687815609224;6251.468625166866;6252.562320637558;6253.499720022387;6208.1308616793685;6233.252009758835;6243.344448832898;6243.843903902393;6247.250329960389;5795.275590551181;5812.186293918855;5816.156657284712;5822.621529600562;5831.533477321804;30705.69294307073;30984.53523197154;31322.84338578315;31336.529952050736;32467.18832029218;2165.4478108082494;2222.4999375140624;2224;2224.366055674141;2224.6663000549884;19179.52051198717;19419.902900485547;19499.512512187168;20341.288054918008;20354.79645203544;2419.9758002419926;2433.37942381936;2469.5184439034397;2471.715752688428;2472.171822439485;145675.2716236412;149301.25349373292;149422.25288873486;150077;150174;15138.621534461727;15832.92083539575;16044.598885027968;16152.35390584387;16269.071567118033;24555.140570079962;24582;24589.262322130366;24593;24618.507629847303;10969.780604388026;11050.950159734812;11070.391128487849;11073.778524429466;11126.165537584713;10323.225758068174;10352.482375881176;10358.585656573652;10465.215108866865;10519;8592.312614990786;9731.92948775634;9835.950820245997;9933.751656208653;10014.499275036365;2772.4039331543813;2848.928776780556;2886.307286251327;2896.4641541314504;2935;993.5926270229171;1038.1539045677748;1050.6375300521308;1059.5708737961138;1071.9303245289032;21574.352769416942;26876;27632.723672763015;27647.30881727973;28489.57265641017;1106.411320585925;1131.8924702153283;1134.1040577943331;1145.9828102578467;1156.6992581928591;12014;12475.625731228078;12585.811212831815;12637.43131559082;12645.810312845315;571705;584148;607243;621932;625318;136837.31581342028;138521;139239.30380348035;139689.30155349363;140407.29796351158;1315.7236980234259;1328.2628141381626;1354.1942544186193;1357.1585616917575;1362.6184668292894;19628.901855490632;19954.60090798205;20064.197432102552;20096.19615215375;20431.38705838827;66016;66585.66707166433;66833.33166668465;67014;67780.6610966942;80473;81206;81809;81975.590122049;82304;15093.47172848945;15258.237088145326;15293.617659558155;15491.767623485883;15524.611884702972;24424.389390265387;24573.13994010201;24576.262712118663;24685.259442216764;24763.62854557147;19738.802611973697;19903.203871845544;20007.299744508873;20205.59588808245;20262.290819821235;17811.821881781016;18049.63900721952;18236;18296.72554911651;18597.256109755457;19588.9020554902;19693;20052.298169563994;20138.59722805565;20139.79860201438;15352.616184595474;15439.459618913284;15491;15605.453809116627;15635.76546351783;18446.63106737831;18504.537386565444;18530.536736581693;20668.379948601567;20833 18:59:25 INFO - PID 17467 | |3;mootools.html;1405.177970887031;1466.2229018620135;1477.069446248863;1477.9852201477988;1481.496291260971;14833.554993350202;15661.843381566181;15695.293711782968;15698.136602486858;15873.285702143403;15833.683326333496;16261.512154635351;16284.592885177846;16296.83703162968;16320.34718611257;2691.3137150026764;2709.9322516937136;2728.249731323892;2741.1776467059904;2748.945021099577;2714.185744276719;2744.3550765570176;2744.5745909384077;2745.3685652299982;2745.8764355604044;2637.868106594672;2664.174106027128;2677.705452400234;2680.021792045899;2716.6875809281887;2498.25052484254;2532.1770424612073;2692.9596056059177;2704.7024827268983;2707.7292270772864;2660.840349579031;2661.920142395731;2679.7454241846995;2685.1675980446125;2690.811643184978;15316.846831531653;15433.228338583138;15501.457448989344;15534.145621990787;15535.145566993811;7995.400344974092;8236.464629799104;8259.793505162359;8272.917270827274;8276.213759692819;5381.300430943991;5570.86072848178;5661.688607126606;5687.544996400278;5721;1983.6726940054873;1993.4816947593586;1996.9800301996938;2016.9798302016939;2043.2746375036797;26041;26115.347116322053;26198.34504137412;26319.34201644974;26340.20979370622;6981.930180698229;6989.95150727395;7012.439004879598;7152.713891444388;7158.14102307716;17878.463646090637;18209.817901821076;18210.817891821178;18219.72670409945;18273.817261827477;7991.760247192594;8146.348292136615;8148.388870834711;8148.551829649307;8165.305948994283;5863.237779088691;6679.666016699242;7375.078115235596;7539.170691223961;7703.730369437043;5335.439778823245;5501.724913754377;5509.641873278224;5533.363663178786;5620;1531.931063102163;1546.0569052877736;1555.6188733760075;1558.1430213382594;1579.1314776872673;936.9812603747887;949.4730424614405;960.4669408478362;970.2916870684439;978.280963491833;8620.137986201455;8694.391392602583;8923.330750193762;8934.329925255632;9111.225545828545;1014.8579198912158;1025.4718819807806;1031.376017509411;1035.295998720862;1060.4962642744636;5241.240020197126;5458.426865179178;5542.196381524737;6046.667433291212;6185.134081228632;20920.895395522926;21534;21562.353129406143;21599.892000539898;21753.238636647642;21470.78529214688;22581.209657661904;22596.435089122573;22644.207452739076;22645.320640380814;11987.22083064598;12170.513179472722;12172;12351.505939762308;12382.81425778614;8674.436161649473;8875.289976801969;8970.68602598932;9160.770980725536;9206.769830754285;18822.24711011544;19085.618287634446;19328.903355483133;19959.301424450074;20086.59826803485;19796.703049453983;19882.304119355755;19902.90048549748;20102.296419625243;20219.59560808805;12672.366381681064;12918.160319579198;12920.806187907001;13073.803892941803;13198.934005329911;14185.787213192018;14285.714285714019;14352.425902963765;14367.28163591837;14377.353019114375;11785.764284714429;11796.233244839059;11961.581344652895;11989.40052997364;11996.280223186637;11536.538538458368;11543.769124617293;11645.825312620149;11741.11941604366;11844.111691622991;9871.555779989774;9914.801703965735;9935.850962235716;10011.54948027326;10017.649382271877;7771.067471903408;7897.723579674684;7957.960210198912;7971.561564114029;8014.879776803469;7862.371010319046;7918.722844700408;7988.560629165219;8010.759677209693;8069.112397636372 18:59:25 INFO - PID 17467 | |4;prototype.html;506.8039426952394;513.5634710496078;526.6260954722147;542.4602520492111;546.4262524349434;6161.907571386421;6188.350223226564;6191.814245572628;6214.378562143789;6226.346233645459;6045.498596277388;6152.661603611799;6193.69031548423;6204.6587437690905;6216.595921265126;4938.456769755342;4974.502549745014;4975.427825800043;4980.825671101512;4992.051510213048;4781.402324709411;4828.951710482903;4897.779599917994;4921.655484116113;4933.087378834927;4899.436564795041;4905.435874874382;4935.8272460463895;4982.551570358667;4997.200447928332;4932.4574296827495;4940.380744004349;4953.727544985024;4995.650304478688;5007.148784706572;4599.770011499411;4635.142498637729;4636.420447444069;4652.720836749806;4672.0889426561835;6068.453839154453;6094.6952652367645;6095.359987201325;6100.7254673539355;6108.205933228652;5995.7109221517585;6019.849503762397;6032.185654936571;6053.69731513427;6055.666938318391;6623.437007854338;6628.73485060597;6630.336966303379;6639.867202655968;6659.500537459709;5258.474152584749;5277;5309.761060752276;5332.866678333073;5337.8131765388025;6537.182852143482;6698.196216454056;6726.697298621476;6802.897956530656;6873.690683919185;5471.890562188734;5472.808451704172;5477.643953143112;5485.643433176911;5486.972565137149;5540.556755459554;5592.384837667934;5606.439356064361;5607.299087614048;5639.8590035249445;6023.186869772525;6024.909626355608;6036.8188954331445;6056.182415373956;6072.149899014142;6448.709808058648;6523.749306489349;6539.705713242915;6621.86756264872;6696.799096027127;1881.7271495633056;1916.1760443009362;1923.1730355947077;1924.7978962209047;1943.8542109341856;1402.1516982225608;1433.1512349069583;1444.9668487031822;1452.2717965620877;1462.7878957551095;6166.506679465632;6214.533909956681;6218.657973811393;6233.127362169209;6282.340354262828;6475.7733479328;6645.501587380966;6673.799786006428;6751.932480675228;6782.491313151533;6242.563020588515;6349.634828511892;6368.522360822957;6371.362863713592;6389.872202555923;3487.8604855805484;3524.242287908112;3536.8585256589963;3542.6280240574883;3572.2676851245433;7046.964765176243;7082.29177082298;7128.322809333105;7192.82017949545;7223.747168849065;6842.349976752201;6880.69036893341;6900.585964842126;6911.965440172868;6927.272636373209;7133.357997780225;7146.178189508273;7156.570605763671;7172.21105678375;7183.317584829433;6676.82698313554;6687.130673012672;6733.494987875831;6744.302279088208;6747.730090796314;6580.33496433945;6624.377027628069;6631.3700198481065;6656.602113556014;6748.628825414649;6975.511714179958;6993.4055605274125;7053.259407762316;7057.50597458173;7076.638596666542;4980.103581355391;5135.794568217229;5145.897082058413;5152.9742351288005;5157.406898206604;6540.444062254762;6713.261541230559;6719.294474080151;6809.829754256183;6834.897476537955;6466.51501137426;6501.707423166064;6537.901931470937;6547.443467305142;6626.834329141617;6520.347965203442;6522.5760325578685;6524.151860258136;6529.216494020748;6564.671766411756;6468.935310646833;6521.413072823469;6532.673366331569;6535.2811190768025;6559.7376104957175;6395.744170233139;6467.611943283418;6513.641749703812;6534.444572211225;6568.638724870178;6280.833112576154;6295.622262664255;6355.968220158869;6358.04350976798;6402.455791257796 18:59:25 INFO - PID 17467 | |5;yui.html;887.8357503861782;900.7567956651704;921.7879887625842;923.7875288683603;926.296015028578;18283.817161828378;18906.52733681657;18913.432597022078;18928.5267868303;20567.177312907465;21091.367258982256;21666;21807;21836.563268734615;21865.234716784915;999.2812362736082;1025.6512785652876;1026.851106589544;1029.1818004686254;1034.5292891734243;1032.6230925712098;1077.9245452818307;1080.200651517875;1086.6631344283298;1088.5972190289604;1144.5936692474177;1144.9656510304662;1145.1354227558224;1145.341428678509;1148.3511815824074;1124.9943750281277;1128.4752590045669;1131.9886801131966;1132.8583927009124;1134.0813940708053;830.1076342931373;830.5722552885269;832.7335252719132;833.7332053742805;837.8408102460513;18408.263669453205;18543.165557549808;18596.814031859645;19221.61556768857;20768.792312076836;21374.465638359008;21467.141314347406;21726.456838579004;21757.564848702936;21781.564368712694;15588.766168507482;15835;15896.125713085776;15942.282597283034;16034.438794642132;3628.6734193922675;3643.4899114124046;3647.1246900743895;3649;3653.671169594723;139547.30226348905;139616;140004;143756;143995.28002359922;16356.100414477318;16470.505884823473;16742.497725068268;16816.32734690623;16842.41051563214;30370;30774.692253077184;31675.683243167736;32001.199970000936;32183;7772.611369431619;8188.303994160444;8869.423487473294;8928.419652722552;9456.57445414958;4604.148232576984;4720.881977950578;4736.64475164364;4740.5733483986605;4745.762711864393;5464.562834973192;5584.553235741131;5610.1304297833085;5612.382637909826;5638.802641907513;1115.576081089181;1137.9360298121283;1154.8267759836092;1158.2645020412099;1163.7381589142376;688.7245101959156;706.4948561778353;711.9181294151135;713.4874066977936;717.3543810570424;12192.878071219175;12793.104482686309;13425.0602457827;13471.12437691547;13610.795838062437;694.2502097734434;713.2119008495641;725.9491835571565;737.6864832446189;745.9440541959375;5832.854178645568;6790.422814060761;6865.210500792373;6934.375906168369;6961.671360377119;127711.36144319219;131309.3434532821;131839;133797;134282;104824.47587762165;107240;109618.45190773995;112480.43759781148;112907.43546282216;91552.54223728972;93989;93994;96578.99999999859;97288;13613.591592252249;14193.219372934587;14212.715745684822;14320.71358572802;14343.211123388313;44774;44818.77590612026;45556.31665524953;46514.534854652375;46915.29627055665;80287.59856200681;80692.59653701929;80698.5965070171;82814.58592706997;83435;20731.481712956695;21116.155353786293;21297.68053479168;21340.78659213388;21548.35354939354;23112;23427.76572234256;23435.41411464727;23620.409489762893;23858.642120367862;19280.71078933789;19331.903340483208;19874.304399345954;20531.4867128323;20578.691319630518;19850.50373740668;20708.378748637566;20731.68902466434;21421.678674819577;21462.356129316144;19521.804781952567;19851.495523907608;20644.17423303051;20937.790622093584;21663.45841353979;14409;14667.779983300472;14913.701725965637;15023.699526009637;15242.542723718307;16194.67610647757;16238.67522649564;16399.590010249838;16565.91717041407;16608.501744947673 18:59:25 INFO - PID 17467 | __end_tp_report 18:59:25 INFO - PID 17467 | __start_cc_report 18:59:25 INFO - PID 17467 | _x_x_mozilla_cycle_collect,337 18:59:25 INFO - PID 17467 | __end_cc_report 18:59:25 INFO - PID 17467 | __startTimestamp1501725565927__endTimestamp 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | ------- Summary: start ------- 18:59:25 INFO - PID 17467 | Number of tests: 6 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#0] dojo.html Cycles:165 Average:6207.04 Median:6510.12 stddev:808.58 (12.4%) stddev-sans-first:780.29 18:59:25 INFO - PID 17467 | Values: 3390.4 3423.3 3423.8 3442.2 3457.6 6200.8 6211.7 6289.7 6297.1 6342.9 6149.3 6249.3 6250.8 6257.0 6267.7 5398.8 5458.9 5459.7 5473.8 5500.8 5530.0 5578.3 5581.7 5608.6 5635.5 5465.4 5532.9 5553.2 5621.8 5648.8 5388.8 5455.3 5462.3 5462.6 5494.3 5470.3 5480.2 5499.1 5537.7 5541.5 5973.0 6091.2 6173.8 6176.9 6208.1 6629.4 6660.1 6669.0 6670.9 6671.9 6765.7 6803.5 6814.3 6816.5 6817.2 6288.7 6299.1 6316.2 6321.1 6322.2 6856.6 6905.4 6935.1 6993.2 7019.2 6555.0 6669.9 6678.6 6719.1 6744.2 6756.3 6763.2 6763.7 6764.0 6769.0 6674.9 6675.9 6682.6 6765.6 6786.0 6779.8 6801.5 6808.8 6812.4 6817.6 4870.6 4878.0 4934.3 4934.5 4937.9 4307.7 4312.4 4333.9 4385.8 4410.0 6349.8 6429.9 6455.2 6456.9 6462.4 6291.3 6809.5 6817.5 6817.9 6818.8 6322.9 6326.9 6332.3 6339.3 6415.1 5589.2 5590.4 5592.8 5593.4 5606.7 7103.4 7140.1 7144.4 7209.4 7230.3 6601.1 6735.0 6777.0 6844.9 6850.7 7045.3 7051.8 7053.8 7065.9 7071.2 6555.4 6599.4 6639.3 6647.3 6656.4 6725.6 6761.7 6799.9 6817.3 6878.3 6557.6 6573.4 6619.6 6633.6 6638.7 6446.9 6506.9 6545.8 6547.7 6551.6 6501.6 6533.5 6553.9 6565.6 6603.9 6442.7 6631.5 6639.1 6679.6 6707.8 6440.5 6451.0 6510.1 6527.2 6542.8 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#1] ext.html Cycles:180 Average:42559.60 Median:37514.66 stddev:62594.97 (166.9%) stddev-sans-first:62692.28 18:59:25 INFO - PID 17467 | Values: 865.2 909.5 937.3 964.6 967.3 41882.4 42385.6 42621.4 42677.8 42721.0 40325.6 40358.2 40563.6 40657.4 40679.4 6552.4 6619.8 6631.3 6631.7 6631.9 6661.9 6727.4 6748.9 6758.3 6788.0 7340.7 7521.7 7523.4 7525.3 7525.9 7446.3 7471.2 7471.9 7493.7 7498.0 6743.6 6811.3 7167.4 7350.1 7370.2 39593.2 39739.8 39869.6 39898.4 39991.0 3401.2 3419.6 3428.4 3432.3 3448.9 31367.7 31420.8 31544.7 31552.4 31562.7 5003.9 5017.3 5021.1 5040.3 5057.7 216969.0 216991.0 218852.0 219791.0 220045.0 52192.2 52206.5 52256.0 52264.2 52339.0 54489.7 54722.2 54765.5 54790.0 54914.2 16848.1 17069.4 17140.0 17181.1 17219.9 14075.7 14126.2 14131.9 14133.9 14135.9 15650.1 15720.5 15754.8 15791.7 15809.4 5909.4 6029.2 6041.0 6142.3 6167.9 1080.3 1080.6 1084.8 1090.8 1100.4 24590.1 24601.5 24622.0 24684.9 24785.3 1195.0 1201.1 1212.6 1213.6 1220.6 13064.4 13076.8 17703.6 17845.0 18100.9 264787.0 267879.0 267939.0 268218.0 269505.0 58427.4 61593.0 61709.1 61754.7 61900.4 1493.4 1518.2 1525.1 1528.9 1531.1 30406.2 30744.8 30794.8 30842.1 31069.5 56848.0 57444.4 57471.7 57498.7 57582.0 231263.0 233586.0 234197.0 234446.0 234472.0 37152.1 37877.2 37902.2 38042.2 38228.8 46208.8 46331.3 46364.8 46624.3 46762.3 36211.8 36490.5 36675.0 36751.8 36770.6 35022.5 35368.6 35513.3 35945.1 36203.6 40757.4 41083.6 41535.6 41731.4 41825.6 34285.1 34584.5 34778.5 34822.0 35524.6 25730.2 26973.1 27071.0 27433.7 27609.3 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#2] jquery.html Cycles:180 Average:40173.77 Median:12742.04 stddev:101022.16 (792.8%) stddev-sans-first:101261.79 18:59:25 INFO - PID 17467 | Values: 571.1 571.2 571.8 574.3 592.6 23259.4 24054.6 24095.9 24138.5 24143.0 25338.9 26543.6 27400.5 27746.7 27930.9 6160.9 6337.7 6360.2 6368.5 6371.0 5733.0 6189.9 6219.1 6233.1 6248.2 6236.7 6243.7 6251.5 6252.6 6253.5 6208.1 6233.3 6243.3 6243.8 6247.3 5795.3 5812.2 5816.2 5822.6 5831.5 30705.7 30984.5 31322.8 31336.5 32467.2 2165.4 2222.5 2224.0 2224.4 2224.7 19179.5 19419.9 19499.5 20341.3 20354.8 2420.0 2433.4 2469.5 2471.7 2472.2 145675.3 149301.3 149422.3 150077.0 150174.0 15138.6 15832.9 16044.6 16152.4 16269.1 24555.1 24582.0 24589.3 24593.0 24618.5 10969.8 11051.0 11070.4 11073.8 11126.2 10323.2 10352.5 10358.6 10465.2 10519.0 8592.3 9731.9 9836.0 9933.8 10014.5 2772.4 2848.9 2886.3 2896.5 2935.0 993.6 1038.2 1050.6 1059.6 1071.9 21574.4 26876.0 27632.7 27647.3 28489.6 1106.4 1131.9 1134.1 1146.0 1156.7 12014.0 12475.6 12585.8 12637.4 12645.8 571705.0 584148.0 607243.0 621932.0 625318.0 136837.3 138521.0 139239.3 139689.3 140407.3 1315.7 1328.3 1354.2 1357.2 1362.6 19628.9 19954.6 20064.2 20096.2 20431.4 66016.0 66585.7 66833.3 67014.0 67780.7 80473.0 81206.0 81809.0 81975.6 82304.0 15093.5 15258.2 15293.6 15491.8 15524.6 24424.4 24573.1 24576.3 24685.3 24763.6 19738.8 19903.2 20007.3 20205.6 20262.3 17811.8 18049.6 18236.0 18296.7 18597.3 19588.9 19693.0 20052.3 20138.6 20139.8 15352.6 15439.5 15491.0 15605.5 15635.8 18446.6 18504.5 18530.5 20668.4 20833.0 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#3] mootools.html Cycles:180 Average:9702.22 Median:26156.85 stddev:6830.09 (26.1%) stddev-sans-first:6820.80 18:59:25 INFO - PID 17467 | Values: 1405.2 1466.2 1477.1 1478.0 1481.5 14833.6 15661.8 15695.3 15698.1 15873.3 15833.7 16261.5 16284.6 16296.8 16320.3 2691.3 2709.9 2728.2 2741.2 2748.9 2714.2 2744.4 2744.6 2745.4 2745.9 2637.9 2664.2 2677.7 2680.0 2716.7 2498.3 2532.2 2693.0 2704.7 2707.7 2660.8 2661.9 2679.7 2685.2 2690.8 15316.8 15433.2 15501.5 15534.1 15535.1 7995.4 8236.5 8259.8 8272.9 8276.2 5381.3 5570.9 5661.7 5687.5 5721.0 1983.7 1993.5 1997.0 2017.0 2043.3 26041.0 26115.3 26198.3 26319.3 26340.2 6981.9 6990.0 7012.4 7152.7 7158.1 17878.5 18209.8 18210.8 18219.7 18273.8 7991.8 8146.3 8148.4 8148.6 8165.3 5863.2 6679.7 7375.1 7539.2 7703.7 5335.4 5501.7 5509.6 5533.4 5620.0 1531.9 1546.1 1555.6 1558.1 1579.1 937.0 949.5 960.5 970.3 978.3 8620.1 8694.4 8923.3 8934.3 9111.2 1014.9 1025.5 1031.4 1035.3 1060.5 5241.2 5458.4 5542.2 6046.7 6185.1 20920.9 21534.0 21562.4 21599.9 21753.2 21470.8 22581.2 22596.4 22644.2 22645.3 11987.2 12170.5 12172.0 12351.5 12382.8 8674.4 8875.3 8970.7 9160.8 9206.8 18822.2 19085.6 19328.9 19959.3 20086.6 19796.7 19882.3 19902.9 20102.3 20219.6 12672.4 12918.2 12920.8 13073.8 13198.9 14185.8 14285.7 14352.4 14367.3 14377.4 11785.8 11796.2 11961.6 11989.4 11996.3 11536.5 11543.8 11645.8 11741.1 11844.1 9871.6 9914.8 9935.9 10011.5 10017.6 7771.1 7897.7 7958.0 7971.6 8014.9 7862.4 7918.7 7988.6 8010.8 8069.1 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#4] prototype.html Cycles:180 Average:5659.12 Median:6217.63 stddev:1555.08 (25.0%) stddev-sans-first:1510.59 18:59:25 INFO - PID 17467 | Values: 506.8 513.6 526.6 542.5 546.4 6161.9 6188.4 6191.8 6214.4 6226.3 6045.5 6152.7 6193.7 6204.7 6216.6 4938.5 4974.5 4975.4 4980.8 4992.1 4781.4 4829.0 4897.8 4921.7 4933.1 4899.4 4905.4 4935.8 4982.6 4997.2 4932.5 4940.4 4953.7 4995.7 5007.1 4599.8 4635.1 4636.4 4652.7 4672.1 6068.5 6094.7 6095.4 6100.7 6108.2 5995.7 6019.8 6032.2 6053.7 6055.7 6623.4 6628.7 6630.3 6639.9 6659.5 5258.5 5277.0 5309.8 5332.9 5337.8 6537.2 6698.2 6726.7 6802.9 6873.7 5471.9 5472.8 5477.6 5485.6 5487.0 5540.6 5592.4 5606.4 5607.3 5639.9 6023.2 6024.9 6036.8 6056.2 6072.1 6448.7 6523.7 6539.7 6621.9 6696.8 1881.7 1916.2 1923.2 1924.8 1943.9 1402.2 1433.2 1445.0 1452.3 1462.8 6166.5 6214.5 6218.7 6233.1 6282.3 6475.8 6645.5 6673.8 6751.9 6782.5 6242.6 6349.6 6368.5 6371.4 6389.9 3487.9 3524.2 3536.9 3542.6 3572.3 7047.0 7082.3 7128.3 7192.8 7223.7 6842.3 6880.7 6900.6 6912.0 6927.3 7133.4 7146.2 7156.6 7172.2 7183.3 6676.8 6687.1 6733.5 6744.3 6747.7 6580.3 6624.4 6631.4 6656.6 6748.6 6975.5 6993.4 7053.3 7057.5 7076.6 4980.1 5135.8 5145.9 5153.0 5157.4 6540.4 6713.3 6719.3 6809.8 6834.9 6466.5 6501.7 6537.9 6547.4 6626.8 6520.3 6522.6 6524.2 6529.2 6564.7 6468.9 6521.4 6532.7 6535.3 6559.7 6395.7 6467.6 6513.6 6534.4 6568.6 6280.8 6295.6 6356.0 6358.0 6402.5 18:59:25 INFO - PID 17467 | 18:59:25 INFO - PID 17467 | [#5] yui.html Cycles:180 Average:26455.29 Median:20853.29 stddev:36755.49 (176.3%) stddev-sans-first:36808.46 18:59:25 INFO - PID 17467 | Values: 887.8 900.8 921.8 923.8 926.3 18283.8 18906.5 18913.4 18928.5 20567.2 21091.4 21666.0 21807.0 21836.6 21865.2 999.3 1025.7 1026.9 1029.2 1034.5 1032.6 1077.9 1080.2 1086.7 1088.6 1144.6 1145.0 1145.1 1145.3 1148.4 1125.0 1128.5 1132.0 1132.9 1134.1 830.1 830.6 832.7 833.7 837.8 18408.3 18543.2 18596.8 19221.6 20768.8 21374.5 21467.1 21726.5 21757.6 21781.6 15588.8 15835.0 15896.1 15942.3 16034.4 3628.7 3643.5 3647.1 3649.0 3653.7 139547.3 139616.0 140004.0 143756.0 143995.3 16356.1 16470.5 16742.5 16816.3 16842.4 30370.0 30774.7 31675.7 32001.2 32183.0 7772.6 8188.3 8869.4 8928.4 9456.6 4604.1 4720.9 4736.6 4740.6 4745.8 5464.6 5584.6 5610.1 5612.4 5638.8 1115.6 1137.9 1154.8 1158.3 1163.7 688.7 706.5 711.9 713.5 717.4 12192.9 12793.1 13425.1 13471.1 13610.8 694.3 713.2 725.9 737.7 745.9 5832.9 6790.4 6865.2 6934.4 6961.7 127711.4 131309.3 131839.0 133797.0 134282.0 104824.5 107240.0 109618.5 112480.4 112907.4 91552.5 93989.0 93994.0 96579.0 97288.0 13613.6 14193.2 14212.7 14320.7 14343.2 44774.0 44818.8 45556.3 46514.5 46915.3 80287.6 80692.6 80698.6 82814.6 83435.0 20731.5 21116.2 21297.7 21340.8 21548.4 23112.0 23427.8 23435.4 23620.4 23858.6 19280.7 19331.9 19874.3 20531.5 20578.7 19850.5 20708.4 20731.7 21421.7 21462.4 19521.8 19851.5 20644.2 20937.8 21663.5 14409.0 14667.8 14913.7 15023.7 15242.5 16194.7 16238.7 16399.6 16565.9 16608.5 18:59:25 INFO - PID 17467 | -------- Summary: end -------- 18:59:25 INFO - PID 17467 | 18:59:26 INFO - TEST-INFO | 17467: exit 0 18:59:26 INFO - TEST-OK | dromaeo_css | took 1110017ms 18:59:26 INFO - TEST-START | kraken 18:59:26 INFO - Initialising browser for kraken test... 18:59:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40362/getInfo.html -profile /tmp/tmp8C2f6h/profile 18:59:26 INFO - TEST-INFO | started process 17832 (/builds/slave/test/build/application/firefox/firefox http://localhost:40362/getInfo.html) 18:59:32 INFO - TEST-INFO | 17832: exit 0 18:59:32 INFO - Browser initialized. 18:59:32 INFO - Running cycle 1/1 for kraken test... 18:59:32 INFO - TEST-INFO | started process 18043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8C2f6h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:33 INFO - PID 18043 | 18:59:33 INFO - PID 18043 | (/builds/slave/test/build/application/firefox/firefox:18091): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:59:33 INFO - PID 18043 | 18:59:43 INFO - PID 18043 | RSS: Main: 164651008 18:59:43 INFO - PID 18043 | 18:59:46 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40362/tests/kraken/driver.html?testName=audio-beat-detection) 18:59:47 INFO - PID 18043 | RSS: Main: 169115648 18:59:47 INFO - PID 18043 | 18:59:49 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40362/tests/kraken/driver.html?testName=audio-dft) 18:59:50 INFO - PID 18043 | RSS: Main: 170315776 18:59:50 INFO - PID 18043 | 18:59:53 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40362/tests/kraken/driver.html?testName=audio-fft) 18:59:53 INFO - PID 18043 | RSS: Main: 164347904 18:59:53 INFO - PID 18043 | 18:59:55 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40362/tests/kraken/driver.html?testName=audio-oscillator) 18:59:56 INFO - PID 18043 | RSS: Main: 165937152 18:59:56 INFO - PID 18043 | 18:59:58 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:59:59 INFO - PID 18043 | RSS: Main: 165826560 18:59:59 INFO - PID 18043 | 19:00:02 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40362/tests/kraken/driver.html?testName=imaging-darkroom) 19:00:02 INFO - PID 18043 | RSS: Main: 169037824 19:00:02 INFO - PID 18043 | 19:00:06 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40362/tests/kraken/driver.html?testName=imaging-desaturate) 19:00:06 INFO - PID 18043 | RSS: Main: 170897408 19:00:06 INFO - PID 18043 | 19:00:09 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40362/tests/kraken/driver.html?testName=json-parse-financial) 19:00:10 INFO - PID 18043 | RSS: Main: 169218048 19:00:10 INFO - PID 18043 | 19:00:11 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:00:12 INFO - PID 18043 | RSS: Main: 169263104 19:00:12 INFO - PID 18043 | 19:00:14 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:00:14 INFO - PID 18043 | RSS: Main: 169168896 19:00:14 INFO - PID 18043 | 19:00:16 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:00:17 INFO - PID 18043 | RSS: Main: 166404096 19:00:17 INFO - PID 18043 | 19:00:20 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:00:20 INFO - PID 18043 | RSS: Main: 166424576 19:00:20 INFO - PID 18043 | 19:00:23 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:00:24 INFO - PID 18043 | RSS: Main: 166477824 19:00:24 INFO - PID 18043 | 19:00:25 INFO - PID 18043 | Cycle 1(1): loaded http://localhost:40362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40362/tests/kraken/driver.html?testName=ai-astar) 19:00:26 INFO - PID 18043 | RSS: Main: 168251392 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | __start_tp_report 19:00:26 INFO - PID 18043 | _x_x_mozilla_page_load 19:00:26 INFO - PID 18043 | _x_x_mozilla_page_load_details 19:00:26 INFO - PID 18043 | |i|pagename|runs| 19:00:26 INFO - PID 18043 | |0;ai-astar;97;107;100;106;107;109;108;102;106;109 19:00:26 INFO - PID 18043 | |1;audio-beat-detection;140;118;140;159;115;138;139;115;163;114 19:00:26 INFO - PID 18043 | |2;audio-dft;165;165;166;162;163;164;164;162;173;169 19:00:26 INFO - PID 18043 | |3;audio-fft;74;76;75;123;75;74;75;90;95;75 19:00:26 INFO - PID 18043 | |4;audio-oscillator;78;77;128;79;79;79;138;77;77;131 19:00:26 INFO - PID 18043 | |5;imaging-gaussian-blur;114;114;114;113;113;114;114;114;114;115 19:00:26 INFO - PID 18043 | |6;imaging-darkroom;149;148;147;148;149;148;149;149;149;147 19:00:26 INFO - PID 18043 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;94;93 19:00:26 INFO - PID 18043 | |8;json-parse-financial;46;47;56;48;49;47;46;47;48;48 19:00:26 INFO - PID 18043 | |9;json-stringify-tinderbox;52;53;54;53;53;53;53;53;53;53 19:00:26 INFO - PID 18043 | |10;stanford-crypto-aes;82;74;74;74;75;74;74;73;74;75 19:00:26 INFO - PID 18043 | |11;stanford-crypto-ccm;122;118;121;116;115;125;121;121;118;148 19:00:26 INFO - PID 18043 | |12;stanford-crypto-pbkdf2;164;162;168;163;169;167;158;174;166;162 19:00:26 INFO - PID 18043 | |13;stanford-crypto-sha256-iterative;62;61;61;60;66;60;60;58;59;61 19:00:26 INFO - PID 18043 | __end_tp_report 19:00:26 INFO - PID 18043 | __start_cc_report 19:00:26 INFO - PID 18043 | _x_x_mozilla_cycle_collect,881 19:00:26 INFO - PID 18043 | __end_cc_report 19:00:26 INFO - PID 18043 | __startTimestamp1501725626176__endTimestamp 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | ------- Summary: start ------- 19:00:26 INFO - PID 18043 | Number of tests: 14 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#0] ai-astar Cycles:10 Average:105.10 Median:107.50 stddev:4.07 (3.8%) stddev-sans-first:3.08 19:00:26 INFO - PID 18043 | Values: 97.0 107.0 100.0 106.0 107.0 109.0 108.0 102.0 106.0 109.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:139.50 stddev:18.13 (13.0%) stddev-sans-first:19.10 19:00:26 INFO - PID 18043 | Values: 140.0 118.0 140.0 159.0 115.0 138.0 139.0 115.0 163.0 114.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.40 (2.1%) stddev-sans-first:3.61 19:00:26 INFO - PID 18043 | Values: 165.0 165.0 166.0 162.0 163.0 164.0 164.0 162.0 173.0 169.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:15.85 (21.1%) stddev-sans-first:16.45 19:00:26 INFO - PID 18043 | Values: 74.0 76.0 75.0 123.0 75.0 74.0 75.0 90.0 95.0 75.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:77.50 stddev:26.37 (34.0%) stddev-sans-first:27.30 19:00:26 INFO - PID 18043 | Values: 78.0 77.0 128.0 79.0 79.0 79.0 138.0 77.0 77.0 131.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 19:00:26 INFO - PID 18043 | Values: 114.0 114.0 114.0 113.0 113.0 114.0 114.0 114.0 114.0 115.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 19:00:26 INFO - PID 18043 | Values: 149.0 148.0 147.0 148.0 149.0 148.0 149.0 149.0 149.0 147.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 19:00:26 INFO - PID 18043 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 93.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#8] json-parse-financial Cycles:10 Average:48.20 Median:48.00 stddev:2.90 (6.0%) stddev-sans-first:2.96 19:00:26 INFO - PID 18043 | Values: 46.0 47.0 56.0 48.0 49.0 47.0 46.0 47.0 48.0 48.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#9] json-stringify-tinderbox Cycles:10 Average:53.00 Median:53.00 stddev:0.47 (0.9%) stddev-sans-first:0.33 19:00:26 INFO - PID 18043 | Values: 52.0 53.0 54.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:2.56 (3.5%) stddev-sans-first:0.60 19:00:26 INFO - PID 18043 | Values: 82.0 74.0 74.0 74.0 75.0 74.0 74.0 73.0 74.0 75.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#11] stanford-crypto-ccm Cycles:10 Average:122.50 Median:121.00 stddev:9.44 (7.8%) stddev-sans-first:10.01 19:00:26 INFO - PID 18043 | Values: 122.0 118.0 121.0 116.0 115.0 125.0 121.0 121.0 118.0 148.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.50 stddev:4.50 (2.7%) stddev-sans-first:4.75 19:00:26 INFO - PID 18043 | Values: 164.0 162.0 168.0 163.0 169.0 167.0 158.0 174.0 166.0 162.0 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.00 stddev:2.15 (3.5%) stddev-sans-first:2.24 19:00:26 INFO - PID 18043 | Values: 62.0 61.0 61.0 60.0 66.0 60.0 60.0 58.0 59.0 61.0 19:00:26 INFO - PID 18043 | -------- Summary: end -------- 19:00:26 INFO - PID 18043 | 19:00:26 INFO - PID 18043 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:00:26 INFO - TEST-INFO | 18043: exit 0 19:00:27 INFO - TEST-OK | kraken | took 60465ms 19:00:27 INFO - SUITE-END | took 1170s 19:00:27 INFO - Completed test suite (00:19:30) 19:00:27 INFO - javascript benchmark 19:00:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8976.404139705546, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.3727810355085, 3423.2639982403784, 3423.7774544654594, 3442.173878269216, 3457.567804024497, 6200.813975580729, 6211.720472578733, 6289.685515724213, 6297.055441683749, 6342.873142537146, 6149.3235744068115, 6249.312575616678, 6250.8124756257275, 6257.0, 6267.686615669221, 5398.78404863805, 5458.918116228259, 5459.727013649322, 5473.8357849264385, 5500.7524661390335, 5529.972350138244, 5578.274824272859, 5581.7209139543065, 5608.6073974821775, 5635.520980716644, 5465.371482279549, 5532.889342213153, 5553.194786755897, 5621.7751289948355, 5648.830535083954, 5388.811391601275, 5455.290812194429, 5462.289902312674, 5462.617616766828, 5494.340679118492, 5470.316210473691, 5480.150576660624, 5499.065158922953, 5537.723113844291, 5541.473560011793, 5972.9701351493395, 6091.208142941434, 6173.783917562864, 6176.8764624707255, 6208.1308616793685, 6629.436497897636, 6660.134182556237, 6669.0, 6670.93329066708, 6671.86656266872, 6765.695543700545, 6803.523753337268, 6814.318568143196, 6816.522843400964, 6817.216020157695, 6288.654124023177, 6299.086632438317, 6316.210473690789, 6321.083442900754, 6322.241331040259, 6856.6228857413325, 6905.447564194852, 6935.063766391573, 6993.230744618088, 7019.192792828788, 6554.9672251639395, 6669.933300666931, 6678.565893216925, 6719.126513553207, 6744.22441419243, 6756.324367563205, 6763.154605674291, 6763.695633696496, 6764.0, 6769.018492318586, 6674.933250667431, 6675.866482670416, 6682.565633233824, 6765.560238584476, 6786.049953006583, 6779.762708305186, 6801.4898882584, 6808.761693340709, 6812.386885180357, 6817.625030623264, 4870.586000190024, 4877.951240483242, 4934.309196712463, 4934.5312195341385, 4937.901241975141, 4307.698461107755, 4312.396264522969, 4333.934990975138, 4385.802638881258, 4410.0, 6349.809505714836, 6429.8714025720155, 6455.193100862392, 6456.9354306456335, 6462.418382345518, 6291.339409362043, 6809.455243580502, 6817.454603631698, 6817.931820681829, 6818.829529261709, 6322.873542529123, 6326.873462530723, 6332.303446620868, 6339.302676705559, 6415.069814876817, 5589.217509548666, 5590.357108932443, 5592.7762889484775, 5593.3847276799515, 5606.6916319602815, 7103.396211322096, 7140.107486564179, 7144.3570078693165, 7209.387202087776, 7230.349268565854, 6601.075849381186, 6734.989751537309, 6777.0, 6844.8973265402055, 6850.691718872762, 7045.330693584101, 7051.788446346618, 7053.823654408476, 7065.894011589933, 7071.151461824614, 6555.410013098844, 6599.406053455212, 6639.336066393322, 6647.268800431852, 6656.434203092791, 6725.630090345078, 6761.695723692347, 6799.89800153008, 6817.318268173143, 6878.3465570770695, 6557.639329836714, 6573.375529324707, 6619.569727967667, 6633.568818027006, 6638.701258443478, 6446.903296450463, 6506.869862602816, 6545.770898018546, 6547.672616369257, 6551.6069035858, 6501.577397469149, 6533.542652014314, 6553.934460655332, 6565.638889861103, 6603.900941485786, 6442.677866106582, 6631.469482441489, 6639.103720997604, 6679.56582822115, 6707.798766037026, 6440.516961228021, 6450.967745161244, 6510.121133646897, 6527.184101987252, 6542.8364290893105], "value": 6144.151987003557, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.2081451918314, 909.454327403558, 937.2736129499636, 964.594870154535, 967.2793768642363, 41882.37176442356, 42385.57614423855, 42621.36067958983, 42677.78661106694, 42721.0, 40325.59674403255, 40358.19283614333, 40563.59436405635, 40657.390139147865, 40679.38980915289, 6552.377524135223, 6619.8014059578045, 6631.336866313378, 6631.7347306107695, 6631.867362652744, 6661.9000714989315, 6727.360900714424, 6748.932510674904, 6758.324167583251, 6788.049673045777, 7340.743073992411, 7521.736739214129, 7523.435742319348, 7525.285097915689, 7525.924740752577, 7446.2553744625375, 7471.178170401252, 7471.925280747178, 7493.73771917983, 7497.962510187442, 6743.5953842769595, 6811.25076241613, 7167.3549380556, 7350.11798584168, 7370.189279179286, 39593.20813583712, 39739.8013009936, 39869.60130398717, 39898.40152397716, 39991.0, 3401.1667141550233, 3419.606745224306, 3428.3828910796046, 3432.3306955143757, 3448.8620455181763, 31367.686323136706, 31420.842895785605, 31544.684553154635, 31552.368952620818, 31562.684373156433, 5003.874903127415, 5017.34774479319, 5021.096202683516, 5040.294358789773, 5057.747112644353, 216969.0, 216991.0, 218852.0, 219791.0, 220045.0, 52192.21711674328, 52206.47793522092, 52256.0, 52264.21603675948, 52339.0, 54489.72755136278, 54722.17916731252, 54765.452345476035, 54790.0, 54914.17628735572, 16848.073355965294, 17069.40257090996, 17140.0, 17181.140942952803, 17219.913900430667, 14075.71848563023, 14126.152430854181, 14131.929340353438, 14133.85866141346, 14135.85864141366, 15650.13924234178, 15720.528384148494, 15754.76367854483, 15791.684166316609, 15809.36762529509, 5909.379515150933, 6029.186059881859, 6041.0, 6142.324344322121, 6167.907481387782, 1080.287010573018, 1080.573173596425, 1084.8481212630238, 1090.7818436312768, 1100.4442756408123, 24590.139345122836, 24601.507969840863, 24622.0, 24684.876575617007, 24785.25644230676, 1194.9820752688718, 1201.1291813435364, 1212.6422705301957, 1213.5752486629785, 1220.6338098570393, 13064.412101455457, 13076.803847942288, 17703.645927081387, 17845.0, 18100.909495452437, 264787.0, 267879.0, 267939.0, 268218.0, 269505.0, 58427.41572584305, 61593.0, 61709.074363884574, 61754.69122654358, 61900.38099619036, 1493.3877110384908, 1518.2105305241212, 1525.0620868165997, 1528.9311980960883, 1531.1043039821607, 30406.239844004078, 30744.84627576848, 30794.846025769726, 30842.074737757903, 31069.533956991116, 56848.0, 57444.425555745576, 57471.71264143653, 57498.7125064372, 57582.0, 231263.0, 233586.0, 234197.0, 234446.0, 234472.0, 37152.07119822026, 37877.242455151296, 37902.24195516019, 38042.239155216186, 38228.80885595554, 46208.76895615501, 46331.30503042525, 46364.768176158905, 46624.30063548982, 46762.29856552086, 36211.81894090513, 36490.452643210905, 36675.0, 36751.816240918626, 36770.632293677794, 35022.47466288059, 35368.646313536534, 35513.28973420569, 35945.10137246485, 36203.63796362003, 40757.388639171026, 41083.58916410917, 41535.58464415317, 41731.37402938898, 41825.581744183386, 34285.14287142841, 34584.48123278103, 34778.478322824674, 34822.0, 35524.64475355214, 25730.228093157235, 26973.055943041898, 27071.0, 27433.725662743116, 27609.309767255978], "value": 18499.79656190101, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.072007987021, 571.2316933724139, 571.8277531061326, 574.250602963133, 592.5970340168685, 23259.418514537145, 24054.639180412265, 24095.879520602415, 24138.51722965542, 24143.03427862888, 25338.873305633493, 26543.601845972276, 27400.45199096022, 27746.722532774667, 27930.860345698293, 6160.876782464348, 6337.746490140389, 6360.17317748692, 6368.458681012096, 6371.0, 5732.971335143318, 6189.876202475948, 6219.098230756537, 6233.096201050845, 6248.187735594389, 6236.656983865885, 6243.687815609224, 6251.468625166866, 6252.562320637558, 6253.499720022387, 6208.1308616793685, 6233.252009758835, 6243.344448832898, 6243.843903902393, 6247.250329960389, 5795.275590551181, 5812.186293918855, 5816.156657284712, 5822.621529600562, 5831.533477321804, 30705.69294307073, 30984.53523197154, 31322.84338578315, 31336.529952050736, 32467.18832029218, 2165.4478108082494, 2222.4999375140624, 2224.0, 2224.366055674141, 2224.6663000549884, 19179.52051198717, 19419.902900485547, 19499.512512187168, 20341.288054918008, 20354.79645203544, 2419.9758002419926, 2433.37942381936, 2469.5184439034397, 2471.715752688428, 2472.171822439485, 145675.2716236412, 149301.25349373292, 149422.25288873486, 150077.0, 150174.0, 15138.621534461727, 15832.92083539575, 16044.598885027968, 16152.35390584387, 16269.071567118033, 24555.140570079962, 24582.0, 24589.262322130366, 24593.0, 24618.507629847303, 10969.780604388026, 11050.950159734812, 11070.391128487849, 11073.778524429466, 11126.165537584713, 10323.225758068174, 10352.482375881176, 10358.585656573652, 10465.215108866865, 10519.0, 8592.312614990786, 9731.92948775634, 9835.950820245997, 9933.751656208653, 10014.499275036365, 2772.4039331543813, 2848.928776780556, 2886.307286251327, 2896.4641541314504, 2935.0, 993.5926270229171, 1038.1539045677748, 1050.6375300521308, 1059.5708737961138, 1071.9303245289032, 21574.352769416942, 26876.0, 27632.723672763015, 27647.30881727973, 28489.57265641017, 1106.411320585925, 1131.8924702153283, 1134.1040577943331, 1145.9828102578467, 1156.6992581928591, 12014.0, 12475.625731228078, 12585.811212831815, 12637.43131559082, 12645.810312845315, 571705.0, 584148.0, 607243.0, 621932.0, 625318.0, 136837.31581342028, 138521.0, 139239.30380348035, 139689.30155349363, 140407.29796351158, 1315.7236980234259, 1328.2628141381626, 1354.1942544186193, 1357.1585616917575, 1362.6184668292894, 19628.901855490632, 19954.60090798205, 20064.197432102552, 20096.19615215375, 20431.38705838827, 66016.0, 66585.66707166433, 66833.33166668465, 67014.0, 67780.6610966942, 80473.0, 81206.0, 81809.0, 81975.590122049, 82304.0, 15093.47172848945, 15258.237088145326, 15293.617659558155, 15491.767623485883, 15524.611884702972, 24424.389390265387, 24573.13994010201, 24576.262712118663, 24685.259442216764, 24763.62854557147, 19738.802611973697, 19903.203871845544, 20007.299744508873, 20205.59588808245, 20262.290819821235, 17811.821881781016, 18049.63900721952, 18236.0, 18296.72554911651, 18597.256109755457, 19588.9020554902, 19693.0, 20052.298169563994, 20138.59722805565, 20139.79860201438, 15352.616184595474, 15439.459618913284, 15491.0, 15605.453809116627, 15635.76546351783, 18446.63106737831, 18504.537386565444, 18530.536736581693, 20668.379948601567, 20833.0], "value": 12837.488226475354, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.177970887031, 1466.2229018620135, 1477.069446248863, 1477.9852201477988, 1481.496291260971, 14833.554993350202, 15661.843381566181, 15695.293711782968, 15698.136602486858, 15873.285702143403, 15833.683326333496, 16261.512154635351, 16284.592885177846, 16296.83703162968, 16320.34718611257, 2691.3137150026764, 2709.9322516937136, 2728.249731323892, 2741.1776467059904, 2748.945021099577, 2714.185744276719, 2744.3550765570176, 2744.5745909384077, 2745.3685652299982, 2745.8764355604044, 2637.868106594672, 2664.174106027128, 2677.705452400234, 2680.021792045899, 2716.6875809281887, 2498.25052484254, 2532.1770424612073, 2692.9596056059177, 2704.7024827268983, 2707.7292270772864, 2660.840349579031, 2661.920142395731, 2679.7454241846995, 2685.1675980446125, 2690.811643184978, 15316.846831531653, 15433.228338583138, 15501.457448989344, 15534.145621990787, 15535.145566993811, 7995.400344974092, 8236.464629799104, 8259.793505162359, 8272.917270827274, 8276.213759692819, 5381.300430943991, 5570.86072848178, 5661.688607126606, 5687.544996400278, 5721.0, 1983.6726940054873, 1993.4816947593586, 1996.9800301996938, 2016.9798302016939, 2043.2746375036797, 26041.0, 26115.347116322053, 26198.34504137412, 26319.34201644974, 26340.20979370622, 6981.930180698229, 6989.95150727395, 7012.439004879598, 7152.713891444388, 7158.14102307716, 17878.463646090637, 18209.817901821076, 18210.817891821178, 18219.72670409945, 18273.817261827477, 7991.760247192594, 8146.348292136615, 8148.388870834711, 8148.551829649307, 8165.305948994283, 5863.237779088691, 6679.666016699242, 7375.078115235596, 7539.170691223961, 7703.730369437043, 5335.439778823245, 5501.724913754377, 5509.641873278224, 5533.363663178786, 5620.0, 1531.931063102163, 1546.0569052877736, 1555.6188733760075, 1558.1430213382594, 1579.1314776872673, 936.9812603747887, 949.4730424614405, 960.4669408478362, 970.2916870684439, 978.280963491833, 8620.137986201455, 8694.391392602583, 8923.330750193762, 8934.329925255632, 9111.225545828545, 1014.8579198912158, 1025.4718819807806, 1031.376017509411, 1035.295998720862, 1060.4962642744636, 5241.240020197126, 5458.426865179178, 5542.196381524737, 6046.667433291212, 6185.134081228632, 20920.895395522926, 21534.0, 21562.353129406143, 21599.892000539898, 21753.238636647642, 21470.78529214688, 22581.209657661904, 22596.435089122573, 22644.207452739076, 22645.320640380814, 11987.22083064598, 12170.513179472722, 12172.0, 12351.505939762308, 12382.81425778614, 8674.436161649473, 8875.289976801969, 8970.68602598932, 9160.770980725536, 9206.769830754285, 18822.24711011544, 19085.618287634446, 19328.903355483133, 19959.301424450074, 20086.59826803485, 19796.703049453983, 19882.304119355755, 19902.90048549748, 20102.296419625243, 20219.59560808805, 12672.366381681064, 12918.160319579198, 12920.806187907001, 13073.803892941803, 13198.934005329911, 14185.787213192018, 14285.714285714019, 14352.425902963765, 14367.28163591837, 14377.353019114375, 11785.764284714429, 11796.233244839059, 11961.581344652895, 11989.40052997364, 11996.280223186637, 11536.538538458368, 11543.769124617293, 11645.825312620149, 11741.11941604366, 11844.111691622991, 9871.555779989774, 9914.801703965735, 9935.850962235716, 10011.54948027326, 10017.649382271877, 7771.067471903408, 7897.723579674684, 7957.960210198912, 7971.561564114029, 8014.879776803469, 7862.371010319046, 7918.722844700408, 7988.560629165219, 8010.759677209693, 8069.112397636372], "value": 6946.3604131470165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.8039426952394, 513.5634710496078, 526.6260954722147, 542.4602520492111, 546.4262524349434, 6161.907571386421, 6188.350223226564, 6191.814245572628, 6214.378562143789, 6226.346233645459, 6045.498596277388, 6152.661603611799, 6193.69031548423, 6204.6587437690905, 6216.595921265126, 4938.456769755342, 4974.502549745014, 4975.427825800043, 4980.825671101512, 4992.051510213048, 4781.402324709411, 4828.951710482903, 4897.779599917994, 4921.655484116113, 4933.087378834927, 4899.436564795041, 4905.435874874382, 4935.8272460463895, 4982.551570358667, 4997.200447928332, 4932.4574296827495, 4940.380744004349, 4953.727544985024, 4995.650304478688, 5007.148784706572, 4599.770011499411, 4635.142498637729, 4636.420447444069, 4652.720836749806, 4672.0889426561835, 6068.453839154453, 6094.6952652367645, 6095.359987201325, 6100.7254673539355, 6108.205933228652, 5995.7109221517585, 6019.849503762397, 6032.185654936571, 6053.69731513427, 6055.666938318391, 6623.437007854338, 6628.73485060597, 6630.336966303379, 6639.867202655968, 6659.500537459709, 5258.474152584749, 5277.0, 5309.761060752276, 5332.866678333073, 5337.8131765388025, 6537.182852143482, 6698.196216454056, 6726.697298621476, 6802.897956530656, 6873.690683919185, 5471.890562188734, 5472.808451704172, 5477.643953143112, 5485.643433176911, 5486.972565137149, 5540.556755459554, 5592.384837667934, 5606.439356064361, 5607.299087614048, 5639.8590035249445, 6023.186869772525, 6024.909626355608, 6036.8188954331445, 6056.182415373956, 6072.149899014142, 6448.709808058648, 6523.749306489349, 6539.705713242915, 6621.86756264872, 6696.799096027127, 1881.7271495633056, 1916.1760443009362, 1923.1730355947077, 1924.7978962209047, 1943.8542109341856, 1402.1516982225608, 1433.1512349069583, 1444.9668487031822, 1452.2717965620877, 1462.7878957551095, 6166.506679465632, 6214.533909956681, 6218.657973811393, 6233.127362169209, 6282.340354262828, 6475.7733479328, 6645.501587380966, 6673.799786006428, 6751.932480675228, 6782.491313151533, 6242.563020588515, 6349.634828511892, 6368.522360822957, 6371.362863713592, 6389.872202555923, 3487.8604855805484, 3524.242287908112, 3536.8585256589963, 3542.6280240574883, 3572.2676851245433, 7046.964765176243, 7082.29177082298, 7128.322809333105, 7192.82017949545, 7223.747168849065, 6842.349976752201, 6880.69036893341, 6900.585964842126, 6911.965440172868, 6927.272636373209, 7133.357997780225, 7146.178189508273, 7156.570605763671, 7172.21105678375, 7183.317584829433, 6676.82698313554, 6687.130673012672, 6733.494987875831, 6744.302279088208, 6747.730090796314, 6580.33496433945, 6624.377027628069, 6631.3700198481065, 6656.602113556014, 6748.628825414649, 6975.511714179958, 6993.4055605274125, 7053.259407762316, 7057.50597458173, 7076.638596666542, 4980.103581355391, 5135.794568217229, 5145.897082058413, 5152.9742351288005, 5157.406898206604, 6540.444062254762, 6713.261541230559, 6719.294474080151, 6809.829754256183, 6834.897476537955, 6466.51501137426, 6501.707423166064, 6537.901931470937, 6547.443467305142, 6626.834329141617, 6520.347965203442, 6522.5760325578685, 6524.151860258136, 6529.216494020748, 6564.671766411756, 6468.935310646833, 6521.413072823469, 6532.673366331569, 6535.2811190768025, 6559.7376104957175, 6395.744170233139, 6467.611943283418, 6513.641749703812, 6534.444572211225, 6568.638724870178, 6280.833112576154, 6295.622262664255, 6355.968220158869, 6358.04350976798, 6402.455791257796], "value": 5214.302012185371, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.8357503861782, 900.7567956651704, 921.7879887625842, 923.7875288683603, 926.296015028578, 18283.817161828378, 18906.52733681657, 18913.432597022078, 18928.5267868303, 20567.177312907465, 21091.367258982256, 21666.0, 21807.0, 21836.563268734615, 21865.234716784915, 999.2812362736082, 1025.6512785652876, 1026.851106589544, 1029.1818004686254, 1034.5292891734243, 1032.6230925712098, 1077.9245452818307, 1080.200651517875, 1086.6631344283298, 1088.5972190289604, 1144.5936692474177, 1144.9656510304662, 1145.1354227558224, 1145.341428678509, 1148.3511815824074, 1124.9943750281277, 1128.4752590045669, 1131.9886801131966, 1132.8583927009124, 1134.0813940708053, 830.1076342931373, 830.5722552885269, 832.7335252719132, 833.7332053742805, 837.8408102460513, 18408.263669453205, 18543.165557549808, 18596.814031859645, 19221.61556768857, 20768.792312076836, 21374.465638359008, 21467.141314347406, 21726.456838579004, 21757.564848702936, 21781.564368712694, 15588.766168507482, 15835.0, 15896.125713085776, 15942.282597283034, 16034.438794642132, 3628.6734193922675, 3643.4899114124046, 3647.1246900743895, 3649.0, 3653.671169594723, 139547.30226348905, 139616.0, 140004.0, 143756.0, 143995.28002359922, 16356.100414477318, 16470.505884823473, 16742.497725068268, 16816.32734690623, 16842.41051563214, 30370.0, 30774.692253077184, 31675.683243167736, 32001.199970000936, 32183.0, 7772.611369431619, 8188.303994160444, 8869.423487473294, 8928.419652722552, 9456.57445414958, 4604.148232576984, 4720.881977950578, 4736.64475164364, 4740.5733483986605, 4745.762711864393, 5464.562834973192, 5584.553235741131, 5610.1304297833085, 5612.382637909826, 5638.802641907513, 1115.576081089181, 1137.9360298121283, 1154.8267759836092, 1158.2645020412099, 1163.7381589142376, 688.7245101959156, 706.4948561778353, 711.9181294151135, 713.4874066977936, 717.3543810570424, 12192.878071219175, 12793.104482686309, 13425.0602457827, 13471.12437691547, 13610.795838062437, 694.2502097734434, 713.2119008495641, 725.9491835571565, 737.6864832446189, 745.9440541959375, 5832.854178645568, 6790.422814060761, 6865.210500792373, 6934.375906168369, 6961.671360377119, 127711.36144319219, 131309.3434532821, 131839.0, 133797.0, 134282.0, 104824.47587762165, 107240.0, 109618.45190773995, 112480.43759781148, 112907.43546282216, 91552.54223728972, 93989.0, 93994.0, 96578.99999999859, 97288.0, 13613.591592252249, 14193.219372934587, 14212.715745684822, 14320.71358572802, 14343.211123388313, 44774.0, 44818.77590612026, 45556.31665524953, 46514.534854652375, 46915.29627055665, 80287.59856200681, 80692.59653701929, 80698.5965070171, 82814.58592706997, 83435.0, 20731.481712956695, 21116.155353786293, 21297.68053479168, 21340.78659213388, 21548.35354939354, 23112.0, 23427.76572234256, 23435.41411464727, 23620.409489762893, 23858.642120367862, 19280.71078933789, 19331.903340483208, 19874.304399345954, 20531.4867128323, 20578.691319630518, 19850.50373740668, 20708.378748637566, 20731.68902466434, 21421.678674819577, 21462.356129316144, 19521.804781952567, 19851.495523907608, 20644.17423303051, 20937.790622093584, 21663.45841353979, 14409.0, 14667.779983300472, 14913.701725965637, 15023.699526009637, 15242.542723718307, 16194.67610647757, 16238.67522649564, 16399.590010249838, 16565.91717041407, 16608.501744947673], "value": 9897.478009533503, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1463.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 106.0, 107.0, 109.0, 108.0, 102.0, 106.0, 109.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 140.0, 159.0, 115.0, 138.0, 139.0, 115.0, 163.0, 114.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 162.0, 163.0, 164.0, 164.0, 162.0, 173.0, 169.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 123.0, 75.0, 74.0, 75.0, 90.0, 95.0, 75.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 128.0, 79.0, 79.0, 79.0, 138.0, 77.0, 77.0, 131.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 149.0, 149.0, 149.0, 147.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 56.0, 48.0, 49.0, 47.0, 46.0, 47.0, 48.0, 48.0], "value": 48.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 74.0, 74.0, 74.0, 75.0, 74.0, 74.0, 73.0, 74.0, 75.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 118.0, 121.0, 116.0, 115.0, 125.0, 121.0, 121.0, 118.0, 148.0], "value": 122.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 168.0, 163.0, 169.0, 167.0, 158.0, 174.0, 166.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 66.0, 60.0, 60.0, 58.0, 59.0, 61.0], "value": 60.8, "unit": "score"}]}]} 19:00:27 INFO - Return code: 0 19:00:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:00:27 INFO - # TBPL SUCCESS # 19:00:27 INFO - Running post-action listener: _package_coverage_data 19:00:27 INFO - Running post-action listener: _resource_record_post_action 19:00:27 INFO - [mozharness: 2017-08-03 02:00:27.480269Z] Finished run-tests step (success) 19:00:27 INFO - Running post-run listener: _resource_record_post_run 19:00:27 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 8192; Write bytes: 422891520; Read time: 48; Write time: 298808 19:00:27 INFO - TinderboxPrint: CPU usage
13.1% 19:00:27 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 48 19:00:27 INFO - TinderboxPrint: I/O write bytes / time
422,891,520 / 298,808 19:00:27 INFO - TinderboxPrint: CPU idle
8,239.5 (86.9%) 19:00:27 INFO - TinderboxPrint: CPU user
1,192.3 (12.6%) 19:00:27 INFO - TinderboxPrint: Swap in / out
0 / 0 19:00:27 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108580864; Read time: 0; Write time: 84300 19:00:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:00:27 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314310656; Read time: 36; Write time: 214508 19:00:28 INFO - Running post-run listener: _upload_blobber_files 19:00:28 INFO - Blob upload gear active. 19:00:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:00:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:00:28 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:29 INFO - (blobuploader) - INFO - Done attempting. 19:00:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:30 INFO - (blobuploader) - INFO - Done attempting. 19:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:00:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:30 INFO - (blobuploader) - INFO - Done attempting. 19:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:37 INFO - (blobuploader) - INFO - Done attempting. 19:00:37 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:37 INFO - Return code: 0 19:00:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d923570b638c89f258e6337b7bf92763acd9933a1de0902faf0f9a4a84bf2a2812f222770480b7e9ab11cb291d231731a01ece7e390a64cf716620f3b071f3de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bab1c5b07127ab07ee32fcde6e8fec5fb2e59dcef172ce350f12963e78b3bc651335cb9a8947ba3cb09292f5ae85b7f9faaa94ec570fcfc6114004ab65fa655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55bac72f90d10683ea8b97fe3bd9a58d02f4851a477deac94d3ecabaaf342341e3e9a3bfcc58916713470b9f29a4645f2201211e0b57a311bbc1aeb5f9dc199d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bf7f4be5b0cd10fb15d2c9c3870bc3735fc0fb52aab25c228c49dc5bf800fc8fbfa12615a6fe782f1231eefda8ef098e71601ea0b4284091bb6d4ded1f0f90"} 19:00:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:37 INFO - Contents: 19:00:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d923570b638c89f258e6337b7bf92763acd9933a1de0902faf0f9a4a84bf2a2812f222770480b7e9ab11cb291d231731a01ece7e390a64cf716620f3b071f3de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bab1c5b07127ab07ee32fcde6e8fec5fb2e59dcef172ce350f12963e78b3bc651335cb9a8947ba3cb09292f5ae85b7f9faaa94ec570fcfc6114004ab65fa655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55bac72f90d10683ea8b97fe3bd9a58d02f4851a477deac94d3ecabaaf342341e3e9a3bfcc58916713470b9f29a4645f2201211e0b57a311bbc1aeb5f9dc199d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bf7f4be5b0cd10fb15d2c9c3870bc3735fc0fb52aab25c228c49dc5bf800fc8fbfa12615a6fe782f1231eefda8ef098e71601ea0b4284091bb6d4ded1f0f90"} 19:00:37 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:37 INFO - Copying logs to upload dir... 19:00:37 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.241394 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-02 19:00:37.029479) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 19:00:37.034156) ========= 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=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d923570b638c89f258e6337b7bf92763acd9933a1de0902faf0f9a4a84bf2a2812f222770480b7e9ab11cb291d231731a01ece7e390a64cf716620f3b071f3de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bab1c5b07127ab07ee32fcde6e8fec5fb2e59dcef172ce350f12963e78b3bc651335cb9a8947ba3cb09292f5ae85b7f9faaa94ec570fcfc6114004ab65fa655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55bac72f90d10683ea8b97fe3bd9a58d02f4851a477deac94d3ecabaaf342341e3e9a3bfcc58916713470b9f29a4645f2201211e0b57a311bbc1aeb5f9dc199d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bf7f4be5b0cd10fb15d2c9c3870bc3735fc0fb52aab25c228c49dc5bf800fc8fbfa12615a6fe782f1231eefda8ef098e71601ea0b4284091bb6d4ded1f0f90"} build_url:https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/HVGRaDqqSYePSzrqi_huVg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d923570b638c89f258e6337b7bf92763acd9933a1de0902faf0f9a4a84bf2a2812f222770480b7e9ab11cb291d231731a01ece7e390a64cf716620f3b071f3de", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bab1c5b07127ab07ee32fcde6e8fec5fb2e59dcef172ce350f12963e78b3bc651335cb9a8947ba3cb09292f5ae85b7f9faaa94ec570fcfc6114004ab65fa655", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/55bac72f90d10683ea8b97fe3bd9a58d02f4851a477deac94d3ecabaaf342341e3e9a3bfcc58916713470b9f29a4645f2201211e0b57a311bbc1aeb5f9dc199d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d1bf7f4be5b0cd10fb15d2c9c3870bc3735fc0fb52aab25c228c49dc5bf800fc8fbfa12615a6fe782f1231eefda8ef098e71601ea0b4284091bb6d4ded1f0f90"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 19:00:37.059471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 19:00:37.059819) ========= 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=1258088b6da462a47ba2cd90000001a2-1501724384.802664-1363865602 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 19:00:37.142811) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 19:00:37.143126) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 19:00:37.143414) ========= ========= Total master_lag: 0.17 =========