builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1501658070.55 results: success (0) revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.545653) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.546126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.546538) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.597122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.597415) ========= 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=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-02 00:14:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.9M=0s 2017-08-02 00:14:30 (31.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130875 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.754439) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.754726) ========= 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=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015629 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:30.838533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-02 00:14:30.838815) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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 51ffb9283f0c7c00e08eb8c39b33fbee218c370d --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=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-02 00:14:31,110 truncating revision to first 12 chars 2017-08-02 00:14:31,110 Setting DEBUG logging. 2017-08-02 00:14:31,110 attempt 1/10 2017-08-02 00:14:31,110 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51ffb9283f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-02 00:14:32,464 unpacking tar archive at: mozilla-central-51ffb9283f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.675598 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-02 00:14:32.532538) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.532825) ========= script_repo_revision: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.533199) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.533480) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-02 00:14:32.543435) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-02 00:14:32.543707) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:14:32 INFO - MultiFileLogger online at 20170802 00:14:32 in /builds/slave/test 00:14:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:14:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:14:32 INFO - {'append_to_log': False, 00:14:32 INFO - 'base_work_dir': '/builds/slave/test', 00:14:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:14:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:14:32 INFO - 'branch': 'Firefox-Non-PGO', 00:14:32 INFO - 'buildbot_json_path': 'buildprops.json', 00:14:32 INFO - 'code_coverage': False, 00:14:32 INFO - 'config_files': ('talos/linux_config.py',), 00:14:32 INFO - 'default_actions': ('clobber', 00:14:32 INFO - 'read-buildbot-config', 00:14:32 INFO - 'download-and-extract', 00:14:32 INFO - 'populate-webroot', 00:14:32 INFO - 'create-virtualenv', 00:14:32 INFO - 'install', 00:14:32 INFO - 'setup-mitmproxy', 00:14:32 INFO - 'run-tests'), 00:14:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:14:32 INFO - 'disable_ccov_upload': False, 00:14:32 INFO - 'download_minidump_stackwalk': True, 00:14:32 INFO - 'download_symbols': 'ondemand', 00:14:32 INFO - 'enable_stylo': False, 00:14:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:14:32 INFO - 'tooltool.py': '/tools/tooltool.py', 00:14:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:14:32 INFO - '/tools/misc-python/virtualenv.py')}, 00:14:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:14:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:14:32 INFO - 'gecko_profile': False, 00:14:32 INFO - 'gecko_profile_interval': 0, 00:14:32 INFO - 'installer_path': 'installer.exe', 00:14:32 INFO - 'log_level': 'info', 00:14:32 INFO - 'log_name': 'talos', 00:14:32 INFO - 'log_to_console': True, 00:14:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:14:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:14:32 INFO - 'opt_config_files': (), 00:14:32 INFO - 'pip_index': False, 00:14:32 INFO - 'suite': 'dromaeojs-e10s', 00:14:32 INFO - 'system_bits': '32', 00:14:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:14:32 INFO - 'title': 'talos-linux64-ix-038', 00:14:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:14:32 INFO - 'use_talos_json': True, 00:14:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:14:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:14:32 INFO - 'work_dir': 'build'} 00:14:32 INFO - [mozharness: 2017-08-02 07:14:32.915192Z] Running clobber step. 00:14:32 INFO - Running pre-action listener: _resource_record_pre_action 00:14:32 INFO - Running main action method: clobber 00:14:32 INFO - rmtree: /builds/slave/test/build 00:14:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:14:34 INFO - Running post-action listener: _resource_record_post_action 00:14:34 INFO - [mozharness: 2017-08-02 07:14:34.474544Z] Finished clobber step (success) 00:14:34 INFO - [mozharness: 2017-08-02 07:14:34.474647Z] Running read-buildbot-config step. 00:14:34 INFO - Running pre-action listener: _resource_record_pre_action 00:14:34 INFO - Running main action method: read_buildbot_config 00:14:34 INFO - Using buildbot properties: 00:14:34 INFO - { 00:14:34 INFO - "project": "", 00:14:34 INFO - "product": "firefox", 00:14:34 INFO - "who": "archaeopteryx@coole-files.de", 00:14:34 INFO - "installer_path": "public/build/target.tar.bz2", 00:14:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 00:14:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 00:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 00:14:34 INFO - "stage_platform": "linux64", 00:14:34 INFO - "basedir": "/builds/slave/test", 00:14:34 INFO - "buildnumber": 750, 00:14:34 INFO - "platform": "ubuntu64_hw", 00:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:14:34 INFO - "slavebuilddir": "test", 00:14:34 INFO - "taskId": "IGWFBgMnTGiHbvikxBnKmg", 00:14:34 INFO - "branch": "mozilla-central", 00:14:34 INFO - "script_repo_revision": "production", 00:14:34 INFO - "revision": "51ffb9283f0c7c00e08eb8c39b33fbee218c370d", 00:14:34 INFO - "slavename": "talos-linux64-ix-038", 00:14:34 INFO - "repo_path": "mozilla-central" 00:14:34 INFO - } 00:14:34 INFO - Finding installer, test and symbols from parent task. 00:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGWFBgMnTGiHbvikxBnKmg'}, attempt #1 00:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IGWFBgMnTGiHbvikxBnKmg'}, attempt #1 00:14:35 INFO - Task dependencies: JhuDbI3YQeS1KwM6F3P5lg 00:14:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg'}, attempt #1 00:14:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:14:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 00:14:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip 00:14:35 INFO - Running post-action listener: _resource_record_post_action 00:14:35 INFO - [mozharness: 2017-08-02 07:14:35.811460Z] Finished read-buildbot-config step (success) 00:14:35 INFO - [mozharness: 2017-08-02 07:14:35.811771Z] Running download-and-extract step. 00:14:35 INFO - Running pre-action listener: _resource_record_pre_action 00:14:35 INFO - Running main action method: download_and_extract 00:14:35 INFO - mkdir: /builds/slave/test/build/tests 00:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:14:36 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json 00:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 00:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 00:14:36 INFO - Downloaded 989 bytes. 00:14:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 00:14:36 INFO - Using the following test package requirements: 00:14:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 00:14:36 INFO - u'common': [u'target.common.tests.zip'], 00:14:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 00:14:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 00:14:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 00:14:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 00:14:36 INFO - u'mozbase': [u'target.common.tests.zip'], 00:14:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 00:14:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 00:14:36 INFO - u'web-platform': [u'target.common.tests.zip', 00:14:36 INFO - u'target.web-platform.tests.tar.gz'], 00:14:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 00:14:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 00:14:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 00:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:14:36 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 00:14:38 INFO - Content-Length response header: 72390374 00:14:38 INFO - Bytes received: 72390374 00:14:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 00:14:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip 00:14:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip'}, attempt #1 00:14:49 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.common.tests.zip into memory 00:14:51 INFO - Content-Length response header: 72390374 00:14:51 INFO - Bytes received: 72390374 00:15:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip 00:15:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 00:15:03 INFO - Fetch https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.talos.tests.zip into memory 00:15:04 INFO - Content-Length response header: 14496467 00:15:04 INFO - Bytes received: 14496467 00:15:04 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')]} 00:15:04 INFO - trying https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:04 INFO - Downloading https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 00:15:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 00:15:05 INFO - Downloaded 62292244 bytes. 00:15:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:05 INFO - mkdir: /builds/slave/test/properties 00:15:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:15:05 INFO - Writing to file /builds/slave/test/properties/build_url 00:15:05 INFO - Contents: 00:15:05 INFO - build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 00:15:05 INFO - Running post-action listener: _resource_record_post_action 00:15:05 INFO - Running post-action listener: set_extra_try_arguments 00:15:05 INFO - [mozharness: 2017-08-02 07:15:05.466342Z] Finished download-and-extract step (success) 00:15:05 INFO - [mozharness: 2017-08-02 07:15:05.466440Z] Running populate-webroot step. 00:15:05 INFO - Running pre-action listener: _resource_record_pre_action 00:15:05 INFO - Running main action method: populate_webroot 00:15:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:15:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:15:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:15:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:15:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:15:05 INFO - 'tests': ['damp', 'tps']}, 00:15:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:15:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 00:15:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 00:15:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 00:15:05 INFO - 'other-e10s': {'tests': ['a11yr', 00:15:05 INFO - 'ts_paint', 00:15:05 INFO - 'tpaint', 00:15:05 INFO - 'sessionrestore', 00:15:05 INFO - 'sessionrestore_many_windows', 00:15:05 INFO - 'sessionrestore_no_auto_restore', 00:15:05 INFO - 'tabpaint']}, 00:15:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 00:15:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 00:15:05 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:05 INFO - 'talos_options': ['--mitmproxy', 00:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:05 INFO - '--firstNonBlankPaint'], 00:15:05 INFO - 'tests': ['quantum_pageload_google', 00:15:05 INFO - 'quantum_pageload_youtube', 00:15:05 INFO - 'quantum_pageload_amazon', 00:15:05 INFO - 'quantum_pageload_facebook']}, 00:15:05 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:05 INFO - 'talos_options': ['--stylo', 00:15:05 INFO - '--mitmproxy', 00:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:05 INFO - '--firstNonBlankPaint'], 00:15:05 INFO - 'tests': ['quantum_pageload_google', 00:15:05 INFO - 'quantum_pageload_youtube', 00:15:05 INFO - 'quantum_pageload_amazon', 00:15:05 INFO - 'quantum_pageload_facebook']}, 00:15:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:15:05 INFO - 'tsvgr_opacity', 00:15:05 INFO - 'tart', 00:15:05 INFO - 'tscrollx', 00:15:05 INFO - 'cart', 00:15:05 INFO - 'tsvg_static']}, 00:15:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:15:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 00:15:05 INFO - 'talos_options': ['--stylo', 00:15:05 INFO - '--stylo-threads=1', 00:15:05 INFO - '--mitmproxy', 00:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 00:15:05 INFO - '--firstNonBlankPaint'], 00:15:05 INFO - 'tests': ['tp6_google', 00:15:05 INFO - 'tp6_youtube', 00:15:05 INFO - 'tp6_amazon', 00:15:05 INFO - 'tp6_facebook']}, 00:15:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:15:05 INFO - 'talos_options': ['--xperf_path', 00:15:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:15:05 INFO - 'tests': ['tp5n']}}} 00:15:05 INFO - Running post-action listener: _resource_record_post_action 00:15:05 INFO - [mozharness: 2017-08-02 07:15:05.475127Z] Finished populate-webroot step (success) 00:15:05 INFO - [mozharness: 2017-08-02 07:15:05.475218Z] Running create-virtualenv step. 00:15:05 INFO - Running pre-action listener: _resource_record_pre_action 00:15:05 INFO - Running main action method: create_virtualenv 00:15:05 INFO - Creating virtualenv /builds/slave/test/build/venv 00:15:05 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 00:15:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:15:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 00:15:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:15:05 INFO - Using real prefix '/usr' 00:15:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:15:06 INFO - Installing distribute.............................................................................................................................................................................................done. 00:15:08 INFO - Installing pip.................done. 00:15:08 INFO - Return code: 0 00:15:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:15:08 INFO - Reading from file tmpfile_stdout 00:15:08 INFO - Output received: 00:15:08 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) 00:15:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:15:08 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')]} 00:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:08 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')]} 00:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:08 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:08 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 00:15:08 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 00:15:08 INFO - Using env: {'DISPLAY': ':0', 00:15:08 INFO - 'HOME': '/home/cltbld', 00:15:08 INFO - 'LANG': 'en_US.UTF-8', 00:15:08 INFO - 'LANGUAGE': 'en_US:en', 00:15:08 INFO - 'LOGNAME': 'cltbld', 00:15:08 INFO - 'MAIL': '/var/mail/cltbld', 00:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:08 INFO - 'MOZ_NO_REMOTE': '1', 00:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:08 INFO - 'NO_EM_RESTART': '1', 00:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:08 INFO - 'PWD': '/builds/slave/test', 00:15:08 INFO - 'SHELL': '/bin/bash', 00:15:08 INFO - 'SHLVL': '1', 00:15:08 INFO - 'TERM': 'linux', 00:15:08 INFO - 'TMOUT': '86400', 00:15:08 INFO - 'USER': 'cltbld', 00:15:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:08 INFO - '_': '/tools/buildbot/bin/python'} 00:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:08 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 00:15:08 INFO - Cleaning up... 00:15:08 INFO - Return code: 0 00:15:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:15:08 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')]} 00:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:08 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')]} 00:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:08 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:08 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 00:15:08 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 00:15:08 INFO - Using env: {'DISPLAY': ':0', 00:15:08 INFO - 'HOME': '/home/cltbld', 00:15:08 INFO - 'LANG': 'en_US.UTF-8', 00:15:08 INFO - 'LANGUAGE': 'en_US:en', 00:15:08 INFO - 'LOGNAME': 'cltbld', 00:15:08 INFO - 'MAIL': '/var/mail/cltbld', 00:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:08 INFO - 'MOZ_NO_REMOTE': '1', 00:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:08 INFO - 'NO_EM_RESTART': '1', 00:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:08 INFO - 'PWD': '/builds/slave/test', 00:15:08 INFO - 'SHELL': '/bin/bash', 00:15:08 INFO - 'SHLVL': '1', 00:15:08 INFO - 'TERM': 'linux', 00:15:08 INFO - 'TMOUT': '86400', 00:15:08 INFO - 'USER': 'cltbld', 00:15:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:08 INFO - '_': '/tools/buildbot/bin/python'} 00:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:08 INFO - Downloading/unpacking psutil>=3.1.1 00:15:08 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 00:15:08 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 00:15:08 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 00:15:08 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 00:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:09 INFO - Installing collected packages: psutil 00:15:09 INFO - Running setup.py install for psutil 00:15:09 INFO - building 'psutil._psutil_linux' extension 00:15:09 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 00:15:10 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 00:15:10 INFO - building 'psutil._psutil_posix' extension 00:15:10 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 00:15:10 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 00:15:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:15:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:15:10 INFO - Successfully installed psutil 00:15:10 INFO - Cleaning up... 00:15:10 INFO - Return code: 0 00:15:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:15:10 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')]} 00:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:10 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')]} 00:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:10 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:10 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 00:15:10 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 00:15:10 INFO - Using env: {'DISPLAY': ':0', 00:15:10 INFO - 'HOME': '/home/cltbld', 00:15:10 INFO - 'LANG': 'en_US.UTF-8', 00:15:10 INFO - 'LANGUAGE': 'en_US:en', 00:15:10 INFO - 'LOGNAME': 'cltbld', 00:15:10 INFO - 'MAIL': '/var/mail/cltbld', 00:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:10 INFO - 'MOZ_NO_REMOTE': '1', 00:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:10 INFO - 'NO_EM_RESTART': '1', 00:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:10 INFO - 'PWD': '/builds/slave/test', 00:15:10 INFO - 'SHELL': '/bin/bash', 00:15:10 INFO - 'SHLVL': '1', 00:15:10 INFO - 'TERM': 'linux', 00:15:10 INFO - 'TMOUT': '86400', 00:15:10 INFO - 'USER': 'cltbld', 00:15:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:10 INFO - '_': '/tools/buildbot/bin/python'} 00:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:15:10 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 00:15:10 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 00:15:10 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 00:15:10 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 00:15:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:15:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:15:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:15:11 INFO - Installing collected packages: mozsystemmonitor 00:15:11 INFO - Running setup.py install for mozsystemmonitor 00:15:11 INFO - Successfully installed mozsystemmonitor 00:15:11 INFO - Cleaning up... 00:15:12 INFO - Return code: 0 00:15:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:12 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:12 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 00:15:12 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 00:15:12 INFO - Using env: {'DISPLAY': ':0', 00:15:12 INFO - 'HOME': '/home/cltbld', 00:15:12 INFO - 'LANG': 'en_US.UTF-8', 00:15:12 INFO - 'LANGUAGE': 'en_US:en', 00:15:12 INFO - 'LOGNAME': 'cltbld', 00:15:12 INFO - 'MAIL': '/var/mail/cltbld', 00:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:12 INFO - 'MOZ_NO_REMOTE': '1', 00:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:12 INFO - 'NO_EM_RESTART': '1', 00:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:12 INFO - 'PWD': '/builds/slave/test', 00:15:12 INFO - 'SHELL': '/bin/bash', 00:15:12 INFO - 'SHLVL': '1', 00:15:12 INFO - 'TERM': 'linux', 00:15:12 INFO - 'TMOUT': '86400', 00:15:12 INFO - 'USER': 'cltbld', 00:15:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:12 INFO - '_': '/tools/buildbot/bin/python'} 00:15:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:12 INFO - Downloading/unpacking jsonschema==2.5.1 00:15:12 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 00:15:12 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 00:15:12 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 00:15:12 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 00:15:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:15:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:15:13 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 00:15:13 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 00:15:13 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 00:15:13 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 00:15:13 INFO - Downloading functools32-3.2.3-2.tar.gz 00:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:15:13 INFO - warning: no files found matching '*.txt' 00:15:13 INFO - no previously-included directories found matching 'build' 00:15:13 INFO - no previously-included directories found matching 'dist' 00:15:13 INFO - no previously-included directories found matching '.git*' 00:15:13 INFO - Installing collected packages: jsonschema, functools32 00:15:13 INFO - Running setup.py install for functools32 00:15:13 INFO - warning: no files found matching '*.txt' 00:15:13 INFO - no previously-included directories found matching 'build' 00:15:13 INFO - no previously-included directories found matching 'dist' 00:15:13 INFO - no previously-included directories found matching '.git*' 00:15:13 INFO - Successfully installed jsonschema functools32 00:15:13 INFO - Cleaning up... 00:15:13 INFO - Return code: 0 00:15:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:15:13 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')]} 00:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:13 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')]} 00:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:13 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:13 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 00:15:13 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 00:15:13 INFO - Using env: {'DISPLAY': ':0', 00:15:13 INFO - 'HOME': '/home/cltbld', 00:15:13 INFO - 'LANG': 'en_US.UTF-8', 00:15:13 INFO - 'LANGUAGE': 'en_US:en', 00:15:13 INFO - 'LOGNAME': 'cltbld', 00:15:13 INFO - 'MAIL': '/var/mail/cltbld', 00:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:13 INFO - 'MOZ_NO_REMOTE': '1', 00:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:13 INFO - 'NO_EM_RESTART': '1', 00:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:13 INFO - 'PWD': '/builds/slave/test', 00:15:13 INFO - 'SHELL': '/bin/bash', 00:15:13 INFO - 'SHLVL': '1', 00:15:13 INFO - 'TERM': 'linux', 00:15:13 INFO - 'TMOUT': '86400', 00:15:13 INFO - 'USER': 'cltbld', 00:15:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:13 INFO - '_': '/tools/buildbot/bin/python'} 00:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:15:14 INFO - Cleaning up... 00:15:14 INFO - Return code: 0 00:15:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:15:14 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')]} 00:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:14 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')]} 00:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:14 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:14 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 00:15:14 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 00:15:14 INFO - Using env: {'DISPLAY': ':0', 00:15:14 INFO - 'HOME': '/home/cltbld', 00:15:14 INFO - 'LANG': 'en_US.UTF-8', 00:15:14 INFO - 'LANGUAGE': 'en_US:en', 00:15:14 INFO - 'LOGNAME': 'cltbld', 00:15:14 INFO - 'MAIL': '/var/mail/cltbld', 00:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:14 INFO - 'MOZ_NO_REMOTE': '1', 00:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:14 INFO - 'NO_EM_RESTART': '1', 00:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:14 INFO - 'PWD': '/builds/slave/test', 00:15:14 INFO - 'SHELL': '/bin/bash', 00:15:14 INFO - 'SHLVL': '1', 00:15:14 INFO - 'TERM': 'linux', 00:15:14 INFO - 'TMOUT': '86400', 00:15:14 INFO - 'USER': 'cltbld', 00:15:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:14 INFO - '_': '/tools/buildbot/bin/python'} 00:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:14 INFO - Downloading/unpacking blobuploader==1.2.4 00:15:14 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 00:15:14 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 00:15:14 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 00:15:14 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 00:15:15 INFO - Downloading blobuploader-1.2.4.tar.gz 00:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:15:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:15:15 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 00:15:15 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 00:15:15 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 00:15:15 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 00:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:15:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:15:15 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 00:15:15 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 00:15:15 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 00:15:15 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 00:15:15 INFO - Downloading docopt-0.6.1.tar.gz 00:15:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:15:15 INFO - Installing collected packages: blobuploader, requests, docopt 00:15:15 INFO - Running setup.py install for blobuploader 00:15:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:15:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:15:15 INFO - Running setup.py install for requests 00:15:16 INFO - Running setup.py install for docopt 00:15:16 INFO - Successfully installed blobuploader requests docopt 00:15:16 INFO - Cleaning up... 00:15:16 INFO - Return code: 0 00:15:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15: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')]} 00:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15: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')]} 00:15:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:16 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:16 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 00:15:16 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 00:15:16 INFO - Using env: {'DISPLAY': ':0', 00:15:16 INFO - 'HOME': '/home/cltbld', 00:15:16 INFO - 'LANG': 'en_US.UTF-8', 00:15:16 INFO - 'LANGUAGE': 'en_US:en', 00:15:16 INFO - 'LOGNAME': 'cltbld', 00:15:16 INFO - 'MAIL': '/var/mail/cltbld', 00:15:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:16 INFO - 'MOZ_NO_REMOTE': '1', 00:15:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:16 INFO - 'NO_EM_RESTART': '1', 00:15:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:16 INFO - 'PWD': '/builds/slave/test', 00:15:16 INFO - 'SHELL': '/bin/bash', 00:15:16 INFO - 'SHLVL': '1', 00:15:16 INFO - 'TERM': 'linux', 00:15:16 INFO - 'TMOUT': '86400', 00:15:16 INFO - 'USER': 'cltbld', 00:15:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:16 INFO - '_': '/tools/buildbot/bin/python'} 00:15:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:16 INFO - Running setup.py (path:/tmp/pip-NB1yBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:16 INFO - Running setup.py (path:/tmp/pip-4t2wjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:16 INFO - Running setup.py (path:/tmp/pip-SOfsji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:16 INFO - Running setup.py (path:/tmp/pip-nRYsb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:16 INFO - Running setup.py (path:/tmp/pip-AKfGUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:17 INFO - Running setup.py (path:/tmp/pip-AY6mha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:17 INFO - Running setup.py (path:/tmp/pip-OXOGgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:17 INFO - Running setup.py (path:/tmp/pip-QFt4vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:17 INFO - Running setup.py (path:/tmp/pip-BlbgDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:17 INFO - Running setup.py (path:/tmp/pip-EfvBoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:17 INFO - Running setup.py (path:/tmp/pip-FI0ojH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:17 INFO - Running setup.py (path:/tmp/pip-c3jIMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:17 INFO - Running setup.py (path:/tmp/pip-x3cYQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:17 INFO - Running setup.py (path:/tmp/pip-3zFqOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:17 INFO - Running setup.py (path:/tmp/pip-ywEm8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:17 INFO - Running setup.py (path:/tmp/pip-SfXPus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:17 INFO - Running setup.py (path:/tmp/pip-qAkj8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:15:17 INFO - Running setup.py install for manifestparser 00:15:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozcrash 00:15:18 INFO - Running setup.py install for mozdebug 00:15:18 INFO - Running setup.py install for mozdevice 00:15:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozfile 00:15:18 INFO - Running setup.py install for mozhttpd 00:15:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozinfo 00:15:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozInstall 00:15:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for mozleak 00:15:18 INFO - Running setup.py install for mozlog 00:15:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:15:18 INFO - Running setup.py install for moznetwork 00:15:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Running setup.py install for mozprocess 00:15:19 INFO - Running setup.py install for mozprofile 00:15:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Running setup.py install for mozrunner 00:15:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Running setup.py install for mozscreenshot 00:15:19 INFO - Running setup.py install for moztest 00:15:19 INFO - Running setup.py install for mozversion 00:15:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:15:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:15:19 INFO - Cleaning up... 00:15:19 INFO - Return code: 0 00:15:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15:19 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')]} 00:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:19 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')]} 00:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:19 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:19 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 00:15:19 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 00:15:19 INFO - Using env: {'DISPLAY': ':0', 00:15:19 INFO - 'HOME': '/home/cltbld', 00:15:19 INFO - 'LANG': 'en_US.UTF-8', 00:15:19 INFO - 'LANGUAGE': 'en_US:en', 00:15:19 INFO - 'LOGNAME': 'cltbld', 00:15:19 INFO - 'MAIL': '/var/mail/cltbld', 00:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:19 INFO - 'MOZ_NO_REMOTE': '1', 00:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:19 INFO - 'NO_EM_RESTART': '1', 00:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:19 INFO - 'PWD': '/builds/slave/test', 00:15:19 INFO - 'SHELL': '/bin/bash', 00:15:19 INFO - 'SHLVL': '1', 00:15:19 INFO - 'TERM': 'linux', 00:15:19 INFO - 'TMOUT': '86400', 00:15:19 INFO - 'USER': 'cltbld', 00:15:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:19 INFO - '_': '/tools/buildbot/bin/python'} 00:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:15:19 INFO - Running setup.py (path:/tmp/pip-cX8YGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:15:20 INFO - Running setup.py (path:/tmp/pip-cZhXC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:15:20 INFO - Running setup.py (path:/tmp/pip-Uv8Sg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:15:20 INFO - Running setup.py (path:/tmp/pip-6uNY64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:15:20 INFO - Running setup.py (path:/tmp/pip-6xE9P0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:15:20 INFO - Running setup.py (path:/tmp/pip-GrJVzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:15:20 INFO - Running setup.py (path:/tmp/pip-gK4sxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:15:20 INFO - Running setup.py (path:/tmp/pip-SmMuqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:15:20 INFO - Running setup.py (path:/tmp/pip-FH0BvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:15:20 INFO - Running setup.py (path:/tmp/pip-6Bb5v8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:15:20 INFO - Running setup.py (path:/tmp/pip-43PhYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:15:20 INFO - Running setup.py (path:/tmp/pip-M3MhUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:15:20 INFO - Running setup.py (path:/tmp/pip-CJA6DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:15:20 INFO - Running setup.py (path:/tmp/pip-xGubDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:15:20 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)) 00:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:20 INFO - Running setup.py (path:/tmp/pip-ztVnVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:15:21 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)) 00:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:15:21 INFO - Running setup.py (path:/tmp/pip-zvvuob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:15:21 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)) 00:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:15:21 INFO - Running setup.py (path:/tmp/pip-zzYpMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:15:21 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)) 00:15:21 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)) 00:15:21 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)) 00:15:21 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)) 00:15:21 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)) 00:15:21 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)) 00:15:21 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)) 00:15:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:15: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 00:15: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 00:15: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 00:15: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 00:15:22 INFO - Downloading blessings-1.6.tar.gz 00:15:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:15:22 INFO - Installing collected packages: blessings 00:15:22 INFO - Running setup.py install for blessings 00:15:22 INFO - Successfully installed blessings 00:15:22 INFO - Cleaning up... 00:15:22 INFO - Return code: 0 00:15:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:15:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:22 INFO - Reading from file tmpfile_stdout 00:15:22 INFO - Current package versions: 00:15:22 INFO - argparse == 1.2.1 00:15:22 INFO - blessings == 1.6 00:15:22 INFO - blobuploader == 1.2.4 00:15:22 INFO - docopt == 0.6.1 00:15:22 INFO - functools32 == 3.2.3-2 00:15:22 INFO - jsonschema == 2.5.1 00:15:22 INFO - manifestparser == 1.1 00:15:22 INFO - mozInstall == 1.13 00:15:22 INFO - mozcrash == 1.0 00:15:22 INFO - mozdebug == 0.1 00:15:22 INFO - mozdevice == 0.51 00:15:22 INFO - mozfile == 1.2 00:15:22 INFO - mozhttpd == 0.7 00:15:22 INFO - mozinfo == 0.10 00:15:22 INFO - mozleak == 0.1 00:15:22 INFO - mozlog == 3.5 00:15:22 INFO - moznetwork == 0.27 00:15:22 INFO - mozprocess == 0.25 00:15:22 INFO - mozprofile == 0.28 00:15:22 INFO - mozrunner == 6.13 00:15:22 INFO - mozscreenshot == 0.1 00:15:22 INFO - mozsystemmonitor == 0.3 00:15:22 INFO - moztest == 0.8 00:15:22 INFO - mozversion == 1.4 00:15:22 INFO - psutil == 3.1.1 00:15:22 INFO - requests == 1.2.3 00:15:22 INFO - wsgiref == 0.1.2 00:15:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:15: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')]} 00:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15: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')]} 00:15:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:22 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 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:22 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 00:15:22 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 00:15:22 INFO - Using env: {'DISPLAY': ':0', 00:15:22 INFO - 'HOME': '/home/cltbld', 00:15:22 INFO - 'LANG': 'en_US.UTF-8', 00:15:22 INFO - 'LANGUAGE': 'en_US:en', 00:15:22 INFO - 'LOGNAME': 'cltbld', 00:15:22 INFO - 'MAIL': '/var/mail/cltbld', 00:15:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:22 INFO - 'MOZ_NO_REMOTE': '1', 00:15:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:22 INFO - 'NO_EM_RESTART': '1', 00:15:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:22 INFO - 'PWD': '/builds/slave/test', 00:15:22 INFO - 'SHELL': '/bin/bash', 00:15:22 INFO - 'SHLVL': '1', 00:15:22 INFO - 'TERM': 'linux', 00:15:22 INFO - 'TMOUT': '86400', 00:15:22 INFO - 'USER': 'cltbld', 00:15:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:22 INFO - '_': '/tools/buildbot/bin/python'} 00:15:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 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)) 00:15:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 00:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:15:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:15:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 00:15:24 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)) 00:15:24 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)) 00:15:24 INFO - Installing collected packages: simplejson 00:15:24 INFO - Running setup.py install for simplejson 00:15:24 INFO - building 'simplejson._speedups' extension 00:15:24 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 00:15:25 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 00:15:25 INFO - Successfully installed simplejson 00:15:25 INFO - Cleaning up... 00:15:25 INFO - Return code: 0 00:15:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:15:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf021f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, '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': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', '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 00:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:15:25 INFO - Using env: {'DISPLAY': ':0', 00:15:25 INFO - 'HOME': '/home/cltbld', 00:15:25 INFO - 'LANG': 'en_US.UTF-8', 00:15:25 INFO - 'LANGUAGE': 'en_US:en', 00:15:25 INFO - 'LOGNAME': 'cltbld', 00:15:25 INFO - 'MAIL': '/var/mail/cltbld', 00:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:25 INFO - 'MOZ_NO_REMOTE': '1', 00:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:25 INFO - 'NO_EM_RESTART': '1', 00:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:25 INFO - 'PWD': '/builds/slave/test', 00:15:25 INFO - 'SHELL': '/bin/bash', 00:15:25 INFO - 'SHLVL': '1', 00:15:25 INFO - 'TERM': 'linux', 00:15:25 INFO - 'TMOUT': '86400', 00:15:25 INFO - 'USER': 'cltbld', 00:15:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:25 INFO - '_': '/tools/buildbot/bin/python'} 00:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:15:25 INFO - Cleaning up... 00:15:25 INFO - Return code: 0 00:15:25 INFO - Running post-action listener: _resource_record_post_action 00:15:25 INFO - Running post-action listener: _start_resource_monitoring 00:15:25 INFO - Starting resource monitoring. 00:15:25 INFO - [mozharness: 2017-08-02 07:15:25.430687Z] Finished create-virtualenv step (success) 00:15:25 INFO - [mozharness: 2017-08-02 07:15:25.431204Z] Running install step. 00:15:25 INFO - Running pre-action listener: _resource_record_pre_action 00:15:25 INFO - Running main action method: install 00:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:15:25 INFO - Reading from file tmpfile_stdout 00:15:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:15:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:15:25 INFO - Reading from file tmpfile_stdout 00:15:25 INFO - Output received: 00:15:25 INFO - Usage: mozinstall [options] installer 00:15:25 INFO - Options: 00:15:25 INFO - -h, --help show this help message and exit 00:15:25 INFO - -d DEST, --destination=DEST 00:15:25 INFO - Directory to install application into. [default: 00:15:25 INFO - "/builds/slave/test"] 00:15:25 INFO - --app=APP Application being installed. [default: firefox] 00:15:25 INFO - mkdir: /builds/slave/test/build/application 00:15:25 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'] 00:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 00:15:43 INFO - Reading from file tmpfile_stdout 00:15:43 INFO - Output received: 00:15:43 INFO - /builds/slave/test/build/application/firefox/firefox 00:15:43 INFO - Running post-action listener: _resource_record_post_action 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.916633Z] Finished install step (success) 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.916889Z] Running setup-mitmproxy step. 00:15:43 INFO - Running pre-action listener: _resource_record_pre_action 00:15:43 INFO - Running main action method: setup_mitmproxy 00:15:43 INFO - Skipping: mitmproxy is not required 00:15:43 INFO - Running post-action listener: _resource_record_post_action 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.918069Z] Finished setup-mitmproxy step (success) 00:15:43 INFO - [mozharness: 2017-08-02 07:15:43.918291Z] Running run-tests step. 00:15:43 INFO - Running pre-action listener: _resource_record_pre_action 00:15:43 INFO - Running pre-action listener: _set_gcov_prefix 00:15:43 INFO - Running main action method: run_tests 00:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:15:43 INFO - Python 2.7.3 00:15:43 INFO - Return code: 0 00:15:43 INFO - grabbing minidump binary from tooltool 00:15:43 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')]} 00:15:43 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 0x126feb0>, '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 0x1270db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1271240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:15:43 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 00:15:43 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 00:15:43 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 00:15:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:15:44 INFO - Return code: 0 00:15:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:15:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:15:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:15:44 INFO - ENV: RUST_BACKTRACE is now 1 00:15:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:15:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 00:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 00:15:44 INFO - Using env: {'DISPLAY': ':0', 00:15:44 INFO - 'HOME': '/home/cltbld', 00:15:44 INFO - 'LANG': 'en_US.UTF-8', 00:15:44 INFO - 'LANGUAGE': 'en_US:en', 00:15:44 INFO - 'LOGNAME': 'cltbld', 00:15:44 INFO - 'MAIL': '/var/mail/cltbld', 00:15:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:15:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:15:44 INFO - 'MOZ_NO_REMOTE': '1', 00:15:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:15:44 INFO - 'NO_EM_RESTART': '1', 00:15:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:15:44 INFO - 'PWD': '/builds/slave/test', 00:15:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:15:44 INFO - 'RUST_BACKTRACE': '1', 00:15:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 00:15:44 INFO - 'SHELL': '/bin/bash', 00:15:44 INFO - 'SHLVL': '1', 00:15:44 INFO - 'TERM': 'linux', 00:15:44 INFO - 'TMOUT': '86400', 00:15:44 INFO - 'USER': 'cltbld', 00:15:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166', 00:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:15:44 INFO - '_': '/tools/buildbot/bin/python'} 00:15:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 00:15:44 INFO - mozversion application_buildid: 20170801092414 00:15:44 INFO - mozversion application_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 00:15:44 INFO - mozversion application_display_name: Nightly 00:15:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:15:44 INFO - mozversion application_name: Firefox 00:15:44 INFO - mozversion application_remotingname: firefox 00:15:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:15:44 INFO - mozversion application_vendor: Mozilla 00:15:44 INFO - mozversion application_version: 56.0a1 00:15:44 INFO - mozversion platform_buildid: 20170801092414 00:15:44 INFO - mozversion platform_changeset: 51ffb9283f0c7c00e08eb8c39b33fbee218c370d 00:15:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:15:44 INFO - mozversion platform_version: 56.0a1 00:15:44 INFO - using testdate: 1501658144 00:15:44 INFO - actual date: 1501658144 00:15:44 INFO - starting webserver on 'localhost:42683' 00:15:44 INFO - SUITE-START | Running 2 tests 00:15:44 INFO - TEST-START | dromaeo_css 00:15:44 INFO - Initialising browser for dromaeo_css test... 00:15:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42683/getInfo.html -profile /tmp/tmpzrahKP/profile 00:15:44 INFO - TEST-INFO | started process 4922 (/builds/slave/test/build/application/firefox/firefox http://localhost:42683/getInfo.html) 00:15:51 INFO - TEST-INFO | 4922: exit 0 00:15:51 INFO - Browser initialized. 00:15:51 INFO - Running cycle 1/1 for dromaeo_css test... 00:15:51 INFO - TEST-INFO | started process 5127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzrahKP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:15:52 INFO - PID 5127 | 00:15:52 INFO - PID 5127 | (/builds/slave/test/build/application/firefox/firefox:5175): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:15:52 INFO - PID 5127 | 00:16:02 INFO - PID 5127 | RSS: Main: 170938368 00:16:02 INFO - PID 5127 | 00:19:02 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42683/tests/dromaeo/cssquery-ext.html) 00:19:03 INFO - PID 5127 | RSS: Main: 173752320 00:19:03 INFO - PID 5127 | 00:22:05 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-ext.html (next: http://localhost:42683/tests/dromaeo/cssquery-jquery.html) 00:22:06 INFO - PID 5127 | RSS: Main: 170672128 00:22:06 INFO - PID 5127 | 00:25:08 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42683/tests/dromaeo/cssquery-mootools.html) 00:25:08 INFO - PID 5127 | RSS: Main: 173248512 00:25:08 INFO - PID 5127 | 00:28:10 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42683/tests/dromaeo/cssquery-prototype.html) 00:28:11 INFO - PID 5127 | RSS: Main: 171393024 00:28:11 INFO - PID 5127 | 00:31:14 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42683/tests/dromaeo/cssquery-yui.html) 00:31:15 INFO - PID 5127 | RSS: Main: 174739456 00:31:15 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | Cycle 1(1): loaded http://localhost:42683/tests/dromaeo/cssquery-yui.html (next: http://localhost:42683/tests/dromaeo/cssquery-dojo.html) 00:34:17 INFO - PID 5127 | RSS: Main: 175603712 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | __start_tp_report 00:34:17 INFO - PID 5127 | _x_x_mozilla_page_load 00:34:17 INFO - PID 5127 | _x_x_mozilla_page_load_details 00:34:17 INFO - PID 5127 | |i|pagename|runs| 00:34:17 INFO - PID 5127 | |0;dojo.html;3138.639056508502;3141.2461009357753;3163.478026125689;3172.349668317995;3216.5979252593424;6112.7860524881635;6204.7518099276085;6243.188385509883;6267.122602835601;6300.275468321144;6189.938100618992;6246.406591373823;6262.561620686553;6273.090401891723;6276.215473065867;5660.632058916178;5696.629719068268;5719.656820590757;5719.8570035749235;5729.484346408823;5679.488846003859;5686.3744988051285;5733.971330143343;5761.193432919374;5792.82621521355;5658;5732.0255556555485;5732.885342293152;5733.971330143343;5743.483086522212;5564.1931919871795;5615.073512870372;5618.494335509783;5754.367019627837;5778.104393818965;5605.990921634104;5624.3531993820825;5650.29371328584;5663.980483512966;5696.857578560528;6088.726007329681;6111.052786818051;6137.41694539018;6190.2571691397325;6204.81385558434;6472;6585.341465853424;6590.176227971504;6597.835054123638;6701.966490167567;6681.5656982296;6690.866182676368;6693.297203793629;6720.49596280276;6724.83187920301;6256.374362563707;6278.654673992928;6285.057241413824;6288.591241569284;6291.905621415683;6730.528862979642;6919.4464442844455;6928.307169283032;6935.583864968118;6938.132733408324;6482.319356467598;6515.381038801306;6577.80266592003;6612.305707900601;6623.503237257129;6549.639769812611;6655.0682904393425;6669.7665581704405;6758.42553382968;6762.76330328446;6561.507886908501;6593.241777195588;6603.504737144637;6607.4053335199105;6617.371349721769;6638.601683898982;6644.235912870082;6650.767223147167;6651.102101216371;6659.034440006269;5328.706921119376;5336.786528538815;5345.786168553214;5356.276902618175;5363.973180134074;4370.8033138508845;4580.702254353457;4608.654350923694;4614.192516309632;4625.560571745679;5666.34836993751;5742.368339482654;5745.482906538348;5762.711864406763;5884.823455296348;6732.562383445061;6752.324767523307;6756.3919247266995;6779.084823548857;6784.3554862288;5614.438556144353;5773.336066352424;5855.648661080349;5856.209411729447;5857.765689372377;5776.624519406309;5852.619579727304;5868.2077919480325;5869.031609784423;5922.318933322723;6390.904136437957;6442.48460123189;6442.903356449563;6472.838179045561;6477.1579694639395;6657.234418041793;6683.933160668331;6781.525293229624;6783.3555812197765;6788.9660551696925;6332.715027823667;6465.77369792055;6486.351364863476;6577.539572230089;6578.079068930258;6479.287278399466;6518.445932095636;6584.341565843377;6598.307177746459;6638.50211234169;6684.732610695518;6704.463642908653;6705.8994115087335;6722.394984451423;6780.525363224724;6387.776427825004;6480.773172938924;6538.346165383424;6580.539362244597;6587.63767992765;6436.227652681709;6443.065755465525;6474.560340349898;6564.048213009182;6569.343065693583;6471.4822814175695;6481.027845822976;6486.351364863476;6497.317781632861;6501.317361677145;6498.252700939453;6558.475321974326;6578.407943285128;6579.276279609144;6584.506162037962;6284.8428789278805;6332.810015699536;6403.935960640334;6423.678816059271;6447.323031081856 00:34:17 INFO - PID 5127 | |1;ext.html;798.8761741930003;880.3397451911067;909.1862782809386;1157.57748421826;1186.0393081603895;37378.81310593447;41170.38244426336;41198.382024269624;41226.58773412269;41279.174416511654;41543.37684934728;41885.790571047175;41901.58098419015;41964.16071678565;42110.789446052804;7169.713211471535;7550.660220290087;7669.118051424074;7674.808129796744;7684.154742978268;7581.09026916768;7676;7681.385489160882;7684.116326622454;7687.269709377628;7601.163871974106;7636.312731854132;7663.885041724378;7695.192004839495;7699.499532530368;7616.6572504237165;7642.159362470124;7654.196309387517;7655.119661238945;7658.195889431641;7534.321911028033;7590.810229744246;7594.430417718693;7594.734184303523;7595.506292091051;37848.053798654975;37922.62077379219;38010;38118;38270;3476.8261586920553;3536.6816986471085;3538.6461353864406;3552.7335449841366;3552.946705799415;30378.54432183519;30388.69611303903;30473.847630761706;30826.845865770527;30970.380592388025;4758.357621721093;4814.374131362935;4831.420229572439;4831.734254615994;4898.093852637237;189706;190126;190465;190708.9999999986;191802;48970.755146224044;49132.75433622809;49326.75336623294;49401;49428.50571494239;51229;51323;51327;51446.742766285926;51483.48516514862;16167.514974550782;16408;16423;16468.83531164697;16486.34054637801;10694.625688101034;10865.076468500109;10865.728356791144;13587.59237222885;13613.795793063113;14334.569962901129;14393.28033598316;14437.92781036109;14478.203698796668;14631;5884.676342801187;6019.337872833985;6037.969810150921;6136;6146.78486252979;964.7009427077488;983.852422136671;985.7880555680563;997.9151772099308;999.9700008999596;21751.56496870054;22589.322320330088;22830.771692282866;22976.885115574314;23179.536409272056;1091.2034215023077;1095.3318475729798;1112.7607564373698;1129.3449799116493;1132.0999805154922;11829.52681892732;11969.16215864881;12045.698857528456;12150.5139794409;12163.14857959952;219511;221329;222131;223537;223894;51286.48713512892;51593.742031290356;51791;51911.74044129755;52003;1447.8190226221723;1473.7715654073636;1504.2704288420107;1508.7661412481084;1512.3874830693587;21671.241506547194;21961.095279395366;22256.554868902207;22504.549909002057;22921;36557.817210913774;36723.44914826333;36813.63186368102;36896.63103368932;36938.26123477462;189747;190615.04692477002;191250;191637;191823;31384.37231255408;32369;32600.51099233466;32915.50626740553;32933.17667058343;41247;41623.16753664849;41893.37159942542;42018.36972445354;42541;27624.8618756913;29528;30058.549121762753;30168.09495715132;30296.09111726652;31546.684533155294;32146.839265803523;32491.837540812143;32496.512552311262;32696.50955235721;36534;36647.26705465822;36915.26169476542;36953.815230923676;37117.07207319839;31071;31824.204394890312;32173.195670108435;32382.676173237967;32699;23433.531329372978;23748;23753.04987800538;23949;23953.520929580962 00:34:17 INFO - PID 5127 | |2;jquery.html;532.464872802833;557.8716895114123;560.3360018378221;566.1507738392411;579.2903692976104;22031.889840550793;22882.427939301524;22902.198423055197;23032.76967230327;23036.769632303673;25899.352516187104;26724.331891702717;26736.86631566844;26749.19752407431;26801.32996675084;6464.8060558183215;6636.50226233032;6638.933610663904;6640.867182656344;6642.468602511787;5902.468777809996;6366.4588509976475;6441.420272175504;6451.225852897659;6478.935210647904;6424.646644434554;6437.9678101609425;6438.7746428875;6439.613623182624;6445.097686323918;6414.422701956823;6433.22801263849;6441.742330306805;6442.6778661066755;6450.064740612632;5994.940050599482;5998.700064996733;5999.880002399971;6001.789937352171;6010.128531362928;28938.13185604435;30315.242118947204;30703.69296307053;30858.228544286572;31173.688263117307;1957.07039156401;1994.5711671990446;1994.800519948008;1997.1512107354317;1999.0804230054193;18655;19168.424947251606;19214.615707685767;19329.613407731766;19351.225950961943;2220.11195521791;2268.6937263469385;2279.41874821921;2320.3409562162965;2443.0716327795503;135667.32166339204;141687;141769;141787.29106354507;142182;14411.78382324266;14823.70352592942;14860.256987150815;15183.772243416357;15793.49885282689;23470.295891123293;23585.88207058988;23618.4095397613;23701.525969480514;23802.880985594962;10324.225683073799;10780.98684111876;10798.190135739695;10867.565297388015;10958.123350131971;8204.097549269576;9998.100170984646;10042.74893127663;10094.348991955565;10154.746131346628;8663.436876603;9366.718998430058;9678.75803104914;9795.412275263507;9807.117359437685;2784.930376740557;2794.686497346244;2796.4686709525126;2802.8178168418985;2915.854207289627;952.6237136331249;955.2356149574932;967.3373738988815;996.6063404955003;1004.2919741582167;19842.305519306756;20194.192232310543;20222.898885505772;20482;22709.432264193198;990.5443495991781;1013.4578000769553;1021.9897801021895;1028.89711028898;1057.2704833664748;11404.258723182966;11598.246114002563;11691.76616467666;11700.765984680258;11743.11926605508;472933;484900;488454;505425;508940;119729;128904;135110.32444837713;136259.31870340585;137564;1197.5988044005182;1243.9813402798966;1255.0963306419364;1271.0530654662336;1277.0549793153186;20265.69601456009;20606.69089963682;21547.245846395926;21814.672779907996;22408.439789005406;59427.70286148541;60671.69664151651;60741.392586073576;61735.691321543105;62025.689871550356;71572.28427715656;72668.63665681849;72933.635331823;72941;73481.6325918367;15118.622034449227;15226.086434813946;15279.541613751606;15342.923285383502;15407.306671200047;23840.40398990039;23949.16177933764;23984.52030959336;24267.27198184057;24400.75599243985;17363;18560.2575896968;18910.338138165098;19123.617527649647;19146.13842377124;15644.452444164855;16587;16655.75016374731;16876.57808554747;16939.32242710278;18069.367572134914;19101;19570.51073723168;19582.608347833248;19618.50953726168;15186.46847360337;15204.847951520343;15221.391144354102;15258.389664413744;15272;18245.08774561293;18629.72055419197;18823.152958117193;18876.150573224513;18913.905430472758 00:34:17 INFO - PID 5127 | |3;mootools.html;1342.6978929740806;1384.1003347823914;1386.750384930712;1397.1267957526545;1402.894782891283;13460.46158153674;14230.857691423096;14238.216898070603;14242.643933901658;14244.21656808875;13837.238951857644;14292.142471451694;14793.112413255212;14797.704045919076;14833.92583037086;2611.294950363401;2651.3371657085727;2664.653595032643;2664.7202043785414;2666.7733242674394;2519.143491212987;2555.821092523515;2593.15722390223;2616.4113074558168;2705;2652.2573679369807;2687.4625074985083;2700.7704345130687;2709.6612923384578;2710.7018227994904;2618.188361607898;2644.775194108503;2647.457271259387;2652.416468376954;2666.7466590673853;2472.6538284639987;2491.9626205606933;2495.1142344467635;2515.5472015037285;2516.5344411283972;13637;13866.237356945365;13887.861121388858;13893.4442622295;13914.234717090556;7438.367738742213;7793.376529877596;7867.252611001945;7886.566238856861;7912.80217994549;5104.923426148611;5136.332276804029;5215.478452154792;5295.470452954673;5327.413984461706;1607.718649236379;1630.9429169979112;1639.7294446416327;1676.8407001334976;1678.2196278730328;23088.884555577115;23291.4177145571;23298.53402931932;23301.76698233013;23327;6358.205224346957;6496.35036496356;6674.499412544079;6683.532152749261;6702.061711360413;15898;15905.363785448684;15941.521754347388;15953.122578258308;15954;7852.5288482690075;8045.718399856094;8095.3523718102415;8115.066767321833;8124.63439145228;7158.570485770871;7223.422126229889;7232.529885557527;7249.746258880914;7309.232530584319;4944.554990050912;5139.820106296262;5168.9224661630105;5174.97412512935;5226.947730522722;1432.885369170464;1444.3139508733268;1497.176552895903;1498.730228558848;1509.4037855047413;835.7910522369408;852.6674596907087;859.1108203009854;865.1435079271602;865.1737590600961;6922.480813938974;7100.396466300423;7123.536970096927;7257.8911316330295;7311.3785328247695;922.4419226367951;960.4525420510242;962.9711108666751;965.9130678238852;1003.4982508745627;4659.860204193879;4668.486466488684;4687.742174180385;4706.388169537938;4738.289256611536;18806.717899231524;18828.905855470908;19818;19855.900720496305;20004.399868003984;18901.905490472735;19291.61416771657;19717.309894153637;19765.308214212433;19792.70310945337;10510.47447627631;10703.46482675863;10738.140948724084;10752.19358548112;10766.515506802212;7210;7590.468667193464;7622.504537205064;7687.11598166218;7974.202579741979;16421;16726.33094676248;16988;17140.82859171442;17217.82782172162;16808.327666893187;16956.66086678284;17305.221265042852;17331.65336693234;17374.391896284076;11677;11859.407029648655;11863.40682965831;11870.703232419259;11893.583724569598;12992;13008.869911301144;13229.669258268621;13232.206067635972;13439;9866.210703143875;10318.122959548222;10422.687319380431;10433.895661043292;10589.894101058891;10034.548445319831;10354.1198998086;10508.579656813641;10666.83999739989;10678.038976491842;8989.28085753125;9161.816763664556;9164.312676549418;9170.082991700776;9185.127412895765;6212.1303017578475;6496.870062598627;6574;6625;6670.266270710315;6243.594166379171;6305.274893387135;6322.715477803418;6323.272823625342;6439.195100612424 00:34:17 INFO - PID 5127 | |4;prototype.html;460.61078388761484;485.7182833956306;489.7869426799345;497.96532940997014;516.8552805214539;6016.548758843093;6099.817005489836;6117.103697853663;6129.938700612993;6230.781922632709;5857.238558987337;5931.466168044875;5973.4623883850445;6009.707912798747;6071;4838.225883858583;4840;4883.704658810353;4897.853064408056;4906;4713.222318317474;4852.684575502581;4858.854234372974;4887.584555312803;4946.9752651236695;4759.90480190396;4862.756862156895;4866.46468888422;4868.488808675092;4902.681325713835;4804.759762011903;4853.3690620219495;4876.2685597160535;4879.097366987084;4893.46171921092;4360.324149756792;4373.803178856959;4387.3857659927635;4391.8682439526865;4419.712718673276;5924.348321684612;5943.524518038546;5955.940440595582;5980.192673989043;5988.431099045583;5506.119020956668;5530.834074977717;5549.694766787825;5618.887622247573;5622.297212848394;6329.177206963065;6341.397567231105;6359.332270111618;6383.585066970632;6421.454176395012;4754.286856971447;4781.976090119562;4791.32921391002;4792.562231330622;4842.297866809293;6771.729130834711;6775.864482710318;6794.898076528856;6801.353871382211;6854.588724676535;4841.491643377465;4845.41854977405;4860.198067318924;4863.683860549053;4887.926681099786;4821;4910.631702622318;4947.703137811743;4959.231319145466;4961.330220420269;5586.642418913254;5607.8878422432135;5624.156376543469;5644.379118296984;5645.745941432645;6546.18172728409;6550.508711846631;6554.442872355808;6565.507586930999;6591.769288074895;1656.892302000366;1698.3036954848699;1699.7875265591802;1721.7589537464764;1723.482955113461;1192.946317415701;1203.5907791350983;1207.082617210926;1207.432506721857;1211.878812118781;5658.773649054074;5691.601587888808;5698.601097923106;5699.829005129853;5700.97149514258;6476.514261430411;6571.6057036577;6598.505112116611;6606.7026983785845;6623.337666233435;5663.638997971539;5689.728406166388;5696.458836410535;5702.173184888168;5723.54211663066;3475.079104037432;3504.7021003214504;3506.8246587670515;3510.613832478425;3547.290541891632;6328.71520781566;6338.07039635429;6431.163948686641;6510.544261901716;6530.673466326664;6728.360805723449;6764.391204791593;6836.4530837532875;6847.931520684829;6898.172219333712;6334.524910631813;6394.424501794861;6415.903761443582;6457.386548277812;6461.353864613595;6502.902456463252;6542.607443553402;6601.702923368556;6602.29305984544;6708.886700689267;6487;6520.836979075561;6593.604383736991;6618.172728408949;6636.402723754885;6356.555041147075;6430.64631445275;6435.903461448176;6468.223813142453;6477.578957367756;4924.9507504924495;4954.826581069645;4962.230854217602;4963.429205641398;4964.429090654621;6732.3267673232285;6747.359000894907;6754.290799465985;6756.223034351113;6769.559978601572;6461.256955450183;6483.351664833479;6485.740570377132;6529.216494020748;6537.738490460329;6455.322191169859;6469.741210351722;6472.15861937945;6490.943160524672;6506.869862602816;6061.242344706911;6306.180196574416;6308.558400911892;6361.300256971822;6406.519511036784;6225.533085018551;6395.616263024233;6458.451031662174;6493.415592596689;6526.608403495616;6149.877002460015;6217.844553886189;6239.188905442264;6273.905891411724;6296.275928268308 00:34:17 INFO - PID 5127 | |5;yui.html;880.0759202837015;894.4275663575313;905.5155491811882;910.2263076385074;913.5843191347935;17456.38902638408;18246.726299105525;18274;18312.359067432626;20521.179152833905;19794.812311261336;20104.49738756532;20201.292954746586;20298.594028119427;20368.592628147428;988.5353883674661;1004.8844382895951;1016.065219997604;1016.1616666250336;1017.1303535477172;939.5631031570318;988.0860204311019;1045.4511381524721;1047.8323468245082;1053.6101642392325;1094.1028356747431;1106.9280496767724;1110.4669758515918;1111.794318051159;1112.054753459561;1098.6319582939725;1101.5979167603848;1102.873169585492;1107.1198397274145;1107.7839821234863;800.995995020027;804.6580203413585;810.6595230003413;811.9269265766051;812.2486699802718;18229.270829166817;18503.167357468945;18732.719009214874;18803.341883034165;19016.61966760671;20328.186872525082;20765.58468830615;20911.581768364547;21019.159233630635;21142;15620.531384058497;15797.92101039499;15827.841721582752;15837.683246335124;16129.354825806953;3563.572371315433;3567.4292113262013;3573.0888623401124;3573.94639080414;3580.874669386585;112640;116454;117212;118719.40640296743;119480.40259798645;14836.777448338284;15447.150406727738;15554.144522051169;15577.299021544057;15578.298976546082;29116.41767164645;29347.85326073356;29426.411471770443;29427.558586621217;29658.110256692333;7614.923850761532;8038.356931445471;8115.594220288962;8226.341892648574;9107.271418286522;4229.2175947449205;4390;4394.231009573312;4396.450443694538;4397.8240870364825;5147.485251474823;5169.405518365361;5276.314079169761;5284.762185701653;5302.469753024744;1015.8679371681634;1025.738436698637;1035.1304903880775;1042.093378760468;1045.0803293102022;640.270092095012;662.6819126819154;676.0636518422021;688.2360579756466;698.6436917172177;10823.350598964087;11575.652730418102;12318.384080795924;12350.44423000967;12611.810822837664;662.2384258103124;663.6117871045396;685.8388278754488;709.0604948443333;713.9036230108869;4917.286993385939;5467.781288748405;5631.436856314336;5778.335491418541;6161.507079433634;93361;101712;102215;102549.48725256475;103277.48361258296;86249.56875215584;88245.55877220572;88589.55705221562;90647;94173;76218.6189069051;76948.2305176941;83112.58443707864;83801.58099209465;85612.57193713992;11456;12186.75626487483;12335.198212116184;12405.565805196775;12743.808842867178;33114.834425827714;35216;35559.11102222465;35955.30335224921;36569.9886506234;41987.580124198365;43389.349159761994;44381.778091109336;45041;45334;17379.913100434416;17444.47666570005;17847.286108555512;18002.819971800116;18037.63924721472;17697.938123712618;17965.281388744304;18015.369462068764;18175.818241817942;19910.800891990893;17989.640207196044;18104.456866294033;18365.632687346446;18366.357177498725;18971.24115035383;16542.503724888273;16765.664686705953;16789.74815377746;18077.728834067762;18337.08314584239;17361.131943402528;17385.391511297043;17782.110894454967;17961.910190448965;18128.18423170934;12131.332776697367;13346.866531334563;13385.263810490516;13638.659033523845;13698.246596437291;13940.372683229076;14623.41506339777;14693.265336732908;14829.777553336924;14844 00:34:17 INFO - PID 5127 | __end_tp_report 00:34:17 INFO - PID 5127 | __start_cc_report 00:34:17 INFO - PID 5127 | _x_x_mozilla_cycle_collect,353 00:34:17 INFO - PID 5127 | __end_cc_report 00:34:17 INFO - PID 5127 | __startTimestamp1501659257527__endTimestamp 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | ------- Summary: start ------- 00:34:17 INFO - PID 5127 | Number of tests: 6 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#0] dojo.html Cycles:165 Average:6141.77 Median:6436.23 stddev:731.75 (11.4%) stddev-sans-first:695.04 00:34:17 INFO - PID 5127 | Values: 3138.6 3141.2 3163.5 3172.3 3216.6 6112.8 6204.8 6243.2 6267.1 6300.3 6189.9 6246.4 6262.6 6273.1 6276.2 5660.6 5696.6 5719.7 5719.9 5729.5 5679.5 5686.4 5734.0 5761.2 5792.8 5658.0 5732.0 5732.9 5734.0 5743.5 5564.2 5615.1 5618.5 5754.4 5778.1 5606.0 5624.4 5650.3 5664.0 5696.9 6088.7 6111.1 6137.4 6190.3 6204.8 6472.0 6585.3 6590.2 6597.8 6702.0 6681.6 6690.9 6693.3 6720.5 6724.8 6256.4 6278.7 6285.1 6288.6 6291.9 6730.5 6919.4 6928.3 6935.6 6938.1 6482.3 6515.4 6577.8 6612.3 6623.5 6549.6 6655.1 6669.8 6758.4 6762.8 6561.5 6593.2 6603.5 6607.4 6617.4 6638.6 6644.2 6650.8 6651.1 6659.0 5328.7 5336.8 5345.8 5356.3 5364.0 4370.8 4580.7 4608.7 4614.2 4625.6 5666.3 5742.4 5745.5 5762.7 5884.8 6732.6 6752.3 6756.4 6779.1 6784.4 5614.4 5773.3 5855.6 5856.2 5857.8 5776.6 5852.6 5868.2 5869.0 5922.3 6390.9 6442.5 6442.9 6472.8 6477.2 6657.2 6683.9 6781.5 6783.4 6789.0 6332.7 6465.8 6486.4 6577.5 6578.1 6479.3 6518.4 6584.3 6598.3 6638.5 6684.7 6704.5 6705.9 6722.4 6780.5 6387.8 6480.8 6538.3 6580.5 6587.6 6436.2 6443.1 6474.6 6564.0 6569.3 6471.5 6481.0 6486.4 6497.3 6501.3 6498.3 6558.5 6578.4 6579.3 6584.5 6284.8 6332.8 6403.9 6423.7 6447.3 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#1] ext.html Cycles:180 Average:36925.01 Median:3552.84 stddev:52245.67 (1470.5%) stddev-sans-first:52321.82 00:34:17 INFO - PID 5127 | Values: 798.9 880.3 909.2 1157.6 1186.0 37378.8 41170.4 41198.4 41226.6 41279.2 41543.4 41885.8 41901.6 41964.2 42110.8 7169.7 7550.7 7669.1 7674.8 7684.2 7581.1 7676.0 7681.4 7684.1 7687.3 7601.2 7636.3 7663.9 7695.2 7699.5 7616.7 7642.2 7654.2 7655.1 7658.2 7534.3 7590.8 7594.4 7594.7 7595.5 37848.1 37922.6 38010.0 38118.0 38270.0 3476.8 3536.7 3538.6 3552.7 3552.9 30378.5 30388.7 30473.8 30826.8 30970.4 4758.4 4814.4 4831.4 4831.7 4898.1 189706.0 190126.0 190465.0 190709.0 191802.0 48970.8 49132.8 49326.8 49401.0 49428.5 51229.0 51323.0 51327.0 51446.7 51483.5 16167.5 16408.0 16423.0 16468.8 16486.3 10694.6 10865.1 10865.7 13587.6 13613.8 14334.6 14393.3 14437.9 14478.2 14631.0 5884.7 6019.3 6038.0 6136.0 6146.8 964.7 983.9 985.8 997.9 1000.0 21751.6 22589.3 22830.8 22976.9 23179.5 1091.2 1095.3 1112.8 1129.3 1132.1 11829.5 11969.2 12045.7 12150.5 12163.1 219511.0 221329.0 222131.0 223537.0 223894.0 51286.5 51593.7 51791.0 51911.7 52003.0 1447.8 1473.8 1504.3 1508.8 1512.4 21671.2 21961.1 22256.6 22504.5 22921.0 36557.8 36723.4 36813.6 36896.6 36938.3 189747.0 190615.0 191250.0 191637.0 191823.0 31384.4 32369.0 32600.5 32915.5 32933.2 41247.0 41623.2 41893.4 42018.4 42541.0 27624.9 29528.0 30058.5 30168.1 30296.1 31546.7 32146.8 32491.8 32496.5 32696.5 36534.0 36647.3 36915.3 36953.8 37117.1 31071.0 31824.2 32173.2 32382.7 32699.0 23433.5 23748.0 23753.0 23949.0 23953.5 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#2] jquery.html Cycles:180 Average:35815.92 Median:12494.43 stddev:83488.87 (668.2%) stddev-sans-first:83681.05 00:34:17 INFO - PID 5127 | Values: 532.5 557.9 560.3 566.2 579.3 22031.9 22882.4 22902.2 23032.8 23036.8 25899.4 26724.3 26736.9 26749.2 26801.3 6464.8 6636.5 6638.9 6640.9 6642.5 5902.5 6366.5 6441.4 6451.2 6478.9 6424.6 6438.0 6438.8 6439.6 6445.1 6414.4 6433.2 6441.7 6442.7 6450.1 5994.9 5998.7 5999.9 6001.8 6010.1 28938.1 30315.2 30703.7 30858.2 31173.7 1957.1 1994.6 1994.8 1997.2 1999.1 18655.0 19168.4 19214.6 19329.6 19351.2 2220.1 2268.7 2279.4 2320.3 2443.1 135667.3 141687.0 141769.0 141787.3 142182.0 14411.8 14823.7 14860.3 15183.8 15793.5 23470.3 23585.9 23618.4 23701.5 23802.9 10324.2 10781.0 10798.2 10867.6 10958.1 8204.1 9998.1 10042.7 10094.3 10154.7 8663.4 9366.7 9678.8 9795.4 9807.1 2784.9 2794.7 2796.5 2802.8 2915.9 952.6 955.2 967.3 996.6 1004.3 19842.3 20194.2 20222.9 20482.0 22709.4 990.5 1013.5 1022.0 1028.9 1057.3 11404.3 11598.2 11691.8 11700.8 11743.1 472933.0 484900.0 488454.0 505425.0 508940.0 119729.0 128904.0 135110.3 136259.3 137564.0 1197.6 1244.0 1255.1 1271.1 1277.1 20265.7 20606.7 21547.2 21814.7 22408.4 59427.7 60671.7 60741.4 61735.7 62025.7 71572.3 72668.6 72933.6 72941.0 73481.6 15118.6 15226.1 15279.5 15342.9 15407.3 23840.4 23949.2 23984.5 24267.3 24400.8 17363.0 18560.3 18910.3 19123.6 19146.1 15644.5 16587.0 16655.8 16876.6 16939.3 18069.4 19101.0 19570.5 19582.6 19618.5 15186.5 15204.8 15221.4 15258.4 15272.0 18245.1 18629.7 18823.2 18876.2 18913.9 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#3] mootools.html Cycles:180 Average:8665.24 Median:2537.48 stddev:6003.13 (236.6%) stddev-sans-first:5994.76 00:34:17 INFO - PID 5127 | Values: 1342.7 1384.1 1386.8 1397.1 1402.9 13460.5 14230.9 14238.2 14242.6 14244.2 13837.2 14292.1 14793.1 14797.7 14833.9 2611.3 2651.3 2664.7 2664.7 2666.8 2519.1 2555.8 2593.2 2616.4 2705.0 2652.3 2687.5 2700.8 2709.7 2710.7 2618.2 2644.8 2647.5 2652.4 2666.7 2472.7 2492.0 2495.1 2515.5 2516.5 13637.0 13866.2 13887.9 13893.4 13914.2 7438.4 7793.4 7867.3 7886.6 7912.8 5104.9 5136.3 5215.5 5295.5 5327.4 1607.7 1630.9 1639.7 1676.8 1678.2 23088.9 23291.4 23298.5 23301.8 23327.0 6358.2 6496.4 6674.5 6683.5 6702.1 15898.0 15905.4 15941.5 15953.1 15954.0 7852.5 8045.7 8095.4 8115.1 8124.6 7158.6 7223.4 7232.5 7249.7 7309.2 4944.6 5139.8 5168.9 5175.0 5226.9 1432.9 1444.3 1497.2 1498.7 1509.4 835.8 852.7 859.1 865.1 865.2 6922.5 7100.4 7123.5 7257.9 7311.4 922.4 960.5 963.0 965.9 1003.5 4659.9 4668.5 4687.7 4706.4 4738.3 18806.7 18828.9 19818.0 19855.9 20004.4 18901.9 19291.6 19717.3 19765.3 19792.7 10510.5 10703.5 10738.1 10752.2 10766.5 7210.0 7590.5 7622.5 7687.1 7974.2 16421.0 16726.3 16988.0 17140.8 17217.8 16808.3 16956.7 17305.2 17331.7 17374.4 11677.0 11859.4 11863.4 11870.7 11893.6 12992.0 13008.9 13229.7 13232.2 13439.0 9866.2 10318.1 10422.7 10433.9 10589.9 10034.5 10354.1 10508.6 10666.8 10678.0 8989.3 9161.8 9164.3 9170.1 9185.1 6212.1 6496.9 6574.0 6625.0 6670.3 6243.6 6305.3 6322.7 6323.3 6439.2 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#4] prototype.html Cycles:180 Average:5419.55 Median:5976.83 stddev:1532.07 (25.6%) stddev-sans-first:1490.47 00:34:17 INFO - PID 5127 | Values: 460.6 485.7 489.8 498.0 516.9 6016.5 6099.8 6117.1 6129.9 6230.8 5857.2 5931.5 5973.5 6009.7 6071.0 4838.2 4840.0 4883.7 4897.9 4906.0 4713.2 4852.7 4858.9 4887.6 4947.0 4759.9 4862.8 4866.5 4868.5 4902.7 4804.8 4853.4 4876.3 4879.1 4893.5 4360.3 4373.8 4387.4 4391.9 4419.7 5924.3 5943.5 5955.9 5980.2 5988.4 5506.1 5530.8 5549.7 5618.9 5622.3 6329.2 6341.4 6359.3 6383.6 6421.5 4754.3 4782.0 4791.3 4792.6 4842.3 6771.7 6775.9 6794.9 6801.4 6854.6 4841.5 4845.4 4860.2 4863.7 4887.9 4821.0 4910.6 4947.7 4959.2 4961.3 5586.6 5607.9 5624.2 5644.4 5645.7 6546.2 6550.5 6554.4 6565.5 6591.8 1656.9 1698.3 1699.8 1721.8 1723.5 1192.9 1203.6 1207.1 1207.4 1211.9 5658.8 5691.6 5698.6 5699.8 5701.0 6476.5 6571.6 6598.5 6606.7 6623.3 5663.6 5689.7 5696.5 5702.2 5723.5 3475.1 3504.7 3506.8 3510.6 3547.3 6328.7 6338.1 6431.2 6510.5 6530.7 6728.4 6764.4 6836.5 6847.9 6898.2 6334.5 6394.4 6415.9 6457.4 6461.4 6502.9 6542.6 6601.7 6602.3 6708.9 6487.0 6520.8 6593.6 6618.2 6636.4 6356.6 6430.6 6435.9 6468.2 6477.6 4925.0 4954.8 4962.2 4963.4 4964.4 6732.3 6747.4 6754.3 6756.2 6769.6 6461.3 6483.4 6485.7 6529.2 6537.7 6455.3 6469.7 6472.2 6490.9 6506.9 6061.2 6306.2 6308.6 6361.3 6406.5 6225.5 6395.6 6458.5 6493.4 6526.6 6149.9 6217.8 6239.2 6273.9 6296.3 00:34:17 INFO - PID 5127 | 00:34:17 INFO - PID 5127 | [#5] yui.html Cycles:180 Average:21755.06 Median:18768.03 stddev:28912.05 (154.0%) stddev-sans-first:28950.67 00:34:17 INFO - PID 5127 | Values: 880.1 894.4 905.5 910.2 913.6 17456.4 18246.7 18274.0 18312.4 20521.2 19794.8 20104.5 20201.3 20298.6 20368.6 988.5 1004.9 1016.1 1016.2 1017.1 939.6 988.1 1045.5 1047.8 1053.6 1094.1 1106.9 1110.5 1111.8 1112.1 1098.6 1101.6 1102.9 1107.1 1107.8 801.0 804.7 810.7 811.9 812.2 18229.3 18503.2 18732.7 18803.3 19016.6 20328.2 20765.6 20911.6 21019.2 21142.0 15620.5 15797.9 15827.8 15837.7 16129.4 3563.6 3567.4 3573.1 3573.9 3580.9 112640.0 116454.0 117212.0 118719.4 119480.4 14836.8 15447.2 15554.1 15577.3 15578.3 29116.4 29347.9 29426.4 29427.6 29658.1 7614.9 8038.4 8115.6 8226.3 9107.3 4229.2 4390.0 4394.2 4396.5 4397.8 5147.5 5169.4 5276.3 5284.8 5302.5 1015.9 1025.7 1035.1 1042.1 1045.1 640.3 662.7 676.1 688.2 698.6 10823.4 11575.7 12318.4 12350.4 12611.8 662.2 663.6 685.8 709.1 713.9 4917.3 5467.8 5631.4 5778.3 6161.5 93361.0 101712.0 102215.0 102549.5 103277.5 86249.6 88245.6 88589.6 90647.0 94173.0 76218.6 76948.2 83112.6 83801.6 85612.6 11456.0 12186.8 12335.2 12405.6 12743.8 33114.8 35216.0 35559.1 35955.3 36570.0 41987.6 43389.3 44381.8 45041.0 45334.0 17379.9 17444.5 17847.3 18002.8 18037.6 17697.9 17965.3 18015.4 18175.8 19910.8 17989.6 18104.5 18365.6 18366.4 18971.2 16542.5 16765.7 16789.7 18077.7 18337.1 17361.1 17385.4 17782.1 17961.9 18128.2 12131.3 13346.9 13385.3 13638.7 13698.2 13940.4 14623.4 14693.3 14829.8 14844.0 00:34:17 INFO - PID 5127 | -------- Summary: end -------- 00:34:17 INFO - PID 5127 | 00:34:18 INFO - TEST-INFO | 5127: exit 0 00:34:18 INFO - TEST-OK | dromaeo_css | took 1114141ms 00:34:18 INFO - TEST-START | kraken 00:34:18 INFO - Initialising browser for kraken test... 00:34:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42683/getInfo.html -profile /tmp/tmpJbQMoN/profile 00:34:18 INFO - TEST-INFO | started process 5489 (/builds/slave/test/build/application/firefox/firefox http://localhost:42683/getInfo.html) 00:34:25 INFO - TEST-INFO | 5489: exit 0 00:34:25 INFO - Browser initialized. 00:34:25 INFO - Running cycle 1/1 for kraken test... 00:34:25 INFO - TEST-INFO | started process 5695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJbQMoN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:34:26 INFO - PID 5695 | 00:34:26 INFO - PID 5695 | (/builds/slave/test/build/application/firefox/firefox:5744): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:34:26 INFO - PID 5695 | 00:34:36 INFO - PID 5695 | RSS: Main: 171978752 00:34:36 INFO - PID 5695 | 00:34:39 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42683/tests/kraken/driver.html?testName=audio-beat-detection) 00:34:40 INFO - PID 5695 | RSS: Main: 177430528 00:34:40 INFO - PID 5695 | 00:34:42 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42683/tests/kraken/driver.html?testName=audio-dft) 00:34:43 INFO - PID 5695 | RSS: Main: 177594368 00:34:43 INFO - PID 5695 | 00:34:46 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42683/tests/kraken/driver.html?testName=audio-fft) 00:34:47 INFO - PID 5695 | RSS: Main: 171216896 00:34:47 INFO - PID 5695 | 00:34:49 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42683/tests/kraken/driver.html?testName=audio-oscillator) 00:34:49 INFO - PID 5695 | RSS: Main: 172441600 00:34:49 INFO - PID 5695 | 00:34:52 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42683/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:34:52 INFO - PID 5695 | RSS: Main: 172851200 00:34:52 INFO - PID 5695 | 00:34:55 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42683/tests/kraken/driver.html?testName=imaging-darkroom) 00:34:56 INFO - PID 5695 | RSS: Main: 175194112 00:34:56 INFO - PID 5695 | 00:34:59 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42683/tests/kraken/driver.html?testName=imaging-desaturate) 00:35:00 INFO - PID 5695 | RSS: Main: 175534080 00:35:00 INFO - PID 5695 | 00:35:03 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42683/tests/kraken/driver.html?testName=json-parse-financial) 00:35:03 INFO - PID 5695 | RSS: Main: 175656960 00:35:03 INFO - PID 5695 | 00:35:05 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42683/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:35:06 INFO - PID 5695 | RSS: Main: 175644672 00:35:06 INFO - PID 5695 | 00:35:07 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:35:08 INFO - PID 5695 | RSS: Main: 175742976 00:35:08 INFO - PID 5695 | 00:35:10 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:35:11 INFO - PID 5695 | RSS: Main: 173027328 00:35:11 INFO - PID 5695 | 00:35:14 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:35:14 INFO - PID 5695 | RSS: Main: 174014464 00:35:14 INFO - PID 5695 | 00:35:17 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:35:18 INFO - PID 5695 | RSS: Main: 173649920 00:35:18 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | Cycle 1(1): loaded http://localhost:42683/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42683/tests/kraken/driver.html?testName=ai-astar) 00:35:20 INFO - PID 5695 | RSS: Main: 175034368 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | __start_tp_report 00:35:20 INFO - PID 5695 | _x_x_mozilla_page_load 00:35:20 INFO - PID 5695 | _x_x_mozilla_page_load_details 00:35:20 INFO - PID 5695 | |i|pagename|runs| 00:35:20 INFO - PID 5695 | |0;ai-astar;98;107;104;107;109;108;109;99;112;109 00:35:20 INFO - PID 5695 | |1;audio-beat-detection;144;124;144;166;121;147;141;118;177;124 00:35:20 INFO - PID 5695 | |2;audio-dft;166;162;162;163;161;162;164;166;168;163 00:35:20 INFO - PID 5695 | |3;audio-fft;76;74;75;170;75;76;74;80;153;76 00:35:20 INFO - PID 5695 | |4;audio-oscillator;78;78;127;80;79;80;144;79;79;134 00:35:20 INFO - PID 5695 | |5;imaging-gaussian-blur;117;114;114;114;114;115;114;113;114;115 00:35:20 INFO - PID 5695 | |6;imaging-darkroom;150;151;150;150;151;151;150;151;151;151 00:35:20 INFO - PID 5695 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;95;94 00:35:20 INFO - PID 5695 | |8;json-parse-financial;55;56;56;56;56;55;56;56;56;56 00:35:20 INFO - PID 5695 | |9;json-stringify-tinderbox;54;54;58;54;54;54;54;55;54;54 00:35:20 INFO - PID 5695 | |10;stanford-crypto-aes;80;80;89;79;81;80;80;80;79;80 00:35:20 INFO - PID 5695 | |11;stanford-crypto-ccm;130;133;144;131;126;127;125;141;131;174 00:35:20 INFO - PID 5695 | |12;stanford-crypto-pbkdf2;184;181;183;177;189;188;186;180;185;179 00:35:20 INFO - PID 5695 | |13;stanford-crypto-sha256-iterative;66;68;69;66;71;66;68;68;68;69 00:35:20 INFO - PID 5695 | __end_tp_report 00:35:20 INFO - PID 5695 | __start_cc_report 00:35:20 INFO - PID 5695 | _x_x_mozilla_cycle_collect,976 00:35:20 INFO - PID 5695 | __end_cc_report 00:35:20 INFO - PID 5695 | __startTimestamp1501659320590__endTimestamp 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | ------- Summary: start ------- 00:35:20 INFO - PID 5695 | Number of tests: 14 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#0] ai-astar Cycles:10 Average:106.20 Median:109.00 stddev:4.54 (4.2%) stddev-sans-first:3.72 00:35:20 INFO - PID 5695 | Values: 98.0 107.0 104.0 107.0 109.0 108.0 109.0 99.0 112.0 109.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#1] audio-beat-detection Cycles:10 Average:140.60 Median:144.00 stddev:19.66 (13.7%) stddev-sans-first:20.82 00:35:20 INFO - PID 5695 | Values: 144.0 124.0 144.0 166.0 121.0 147.0 141.0 118.0 177.0 124.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.50 stddev:2.26 (1.4%) stddev-sans-first:2.24 00:35:20 INFO - PID 5695 | Values: 166.0 162.0 162.0 163.0 161.0 162.0 164.0 166.0 168.0 163.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.50 stddev:36.42 (48.2%) stddev-sans-first:38.11 00:35:20 INFO - PID 5695 | Values: 76.0 74.0 75.0 170.0 75.0 76.0 74.0 80.0 153.0 76.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:27.36 (34.6%) stddev-sans-first:28.25 00:35:20 INFO - PID 5695 | Values: 78.0 78.0 127.0 80.0 79.0 80.0 144.0 79.0 79.0 134.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:0.60 00:35:20 INFO - PID 5695 | Values: 117.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 114.0 115.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 00:35:20 INFO - PID 5695 | Values: 150.0 151.0 150.0 150.0 151.0 151.0 150.0 151.0 151.0 151.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:35:20 INFO - PID 5695 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 00:35:20 INFO - PID 5695 | Values: 55.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 56.0 56.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.00 stddev:1.27 (2.4%) stddev-sans-first:1.33 00:35:20 INFO - PID 5695 | Values: 54.0 54.0 58.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:2.94 (3.7%) stddev-sans-first:3.10 00:35:20 INFO - PID 5695 | Values: 80.0 80.0 89.0 79.0 81.0 80.0 80.0 80.0 79.0 80.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:132.00 stddev:14.64 (11.1%) stddev-sans-first:15.36 00:35:20 INFO - PID 5695 | Values: 130.0 133.0 144.0 131.0 126.0 127.0 125.0 141.0 131.0 174.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:184.50 stddev:3.94 (2.1%) stddev-sans-first:4.17 00:35:20 INFO - PID 5695 | Values: 184.0 181.0 183.0 177.0 189.0 188.0 186.0 180.0 185.0 179.0 00:35:20 INFO - PID 5695 | 00:35:20 INFO - PID 5695 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.54 00:35:20 INFO - PID 5695 | Values: 66.0 68.0 69.0 66.0 71.0 66.0 68.0 68.0 68.0 69.0 00:35:20 INFO - PID 5695 | -------- Summary: end -------- 00:35:20 INFO - PID 5695 | 00:35:21 INFO - PID 5695 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:35:21 INFO - TEST-INFO | 5695: exit 0 00:35:21 INFO - TEST-OK | kraken | took 62977ms 00:35:21 INFO - SUITE-END | took 1177s 00:35:21 INFO - Completed test suite (00:19:37) 00:35:21 INFO - javascript benchmark 00:35:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8394.158817781663, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3138.639056508502, 3141.2461009357753, 3163.478026125689, 3172.349668317995, 3216.5979252593424, 6112.7860524881635, 6204.7518099276085, 6243.188385509883, 6267.122602835601, 6300.275468321144, 6189.938100618992, 6246.406591373823, 6262.561620686553, 6273.090401891723, 6276.215473065867, 5660.632058916178, 5696.629719068268, 5719.656820590757, 5719.8570035749235, 5729.484346408823, 5679.488846003859, 5686.3744988051285, 5733.971330143343, 5761.193432919374, 5792.82621521355, 5658.0, 5732.0255556555485, 5732.885342293152, 5733.971330143343, 5743.483086522212, 5564.1931919871795, 5615.073512870372, 5618.494335509783, 5754.367019627837, 5778.104393818965, 5605.990921634104, 5624.3531993820825, 5650.29371328584, 5663.980483512966, 5696.857578560528, 6088.726007329681, 6111.052786818051, 6137.41694539018, 6190.2571691397325, 6204.81385558434, 6472.0, 6585.341465853424, 6590.176227971504, 6597.835054123638, 6701.966490167567, 6681.5656982296, 6690.866182676368, 6693.297203793629, 6720.49596280276, 6724.83187920301, 6256.374362563707, 6278.654673992928, 6285.057241413824, 6288.591241569284, 6291.905621415683, 6730.528862979642, 6919.4464442844455, 6928.307169283032, 6935.583864968118, 6938.132733408324, 6482.319356467598, 6515.381038801306, 6577.80266592003, 6612.305707900601, 6623.503237257129, 6549.639769812611, 6655.0682904393425, 6669.7665581704405, 6758.42553382968, 6762.76330328446, 6561.507886908501, 6593.241777195588, 6603.504737144637, 6607.4053335199105, 6617.371349721769, 6638.601683898982, 6644.235912870082, 6650.767223147167, 6651.102101216371, 6659.034440006269, 5328.706921119376, 5336.786528538815, 5345.786168553214, 5356.276902618175, 5363.973180134074, 4370.8033138508845, 4580.702254353457, 4608.654350923694, 4614.192516309632, 4625.560571745679, 5666.34836993751, 5742.368339482654, 5745.482906538348, 5762.711864406763, 5884.823455296348, 6732.562383445061, 6752.324767523307, 6756.3919247266995, 6779.084823548857, 6784.3554862288, 5614.438556144353, 5773.336066352424, 5855.648661080349, 5856.209411729447, 5857.765689372377, 5776.624519406309, 5852.619579727304, 5868.2077919480325, 5869.031609784423, 5922.318933322723, 6390.904136437957, 6442.48460123189, 6442.903356449563, 6472.838179045561, 6477.1579694639395, 6657.234418041793, 6683.933160668331, 6781.525293229624, 6783.3555812197765, 6788.9660551696925, 6332.715027823667, 6465.77369792055, 6486.351364863476, 6577.539572230089, 6578.079068930258, 6479.287278399466, 6518.445932095636, 6584.341565843377, 6598.307177746459, 6638.50211234169, 6684.732610695518, 6704.463642908653, 6705.8994115087335, 6722.394984451423, 6780.525363224724, 6387.776427825004, 6480.773172938924, 6538.346165383424, 6580.539362244597, 6587.63767992765, 6436.227652681709, 6443.065755465525, 6474.560340349898, 6564.048213009182, 6569.343065693583, 6471.4822814175695, 6481.027845822976, 6486.351364863476, 6497.317781632861, 6501.317361677145, 6498.252700939453, 6558.475321974326, 6578.407943285128, 6579.276279609144, 6584.506162037962, 6284.8428789278805, 6332.810015699536, 6403.935960640334, 6423.678816059271, 6447.323031081856], "value": 6086.552944941455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.8761741930003, 880.3397451911067, 909.1862782809386, 1157.57748421826, 1186.0393081603895, 37378.81310593447, 41170.38244426336, 41198.382024269624, 41226.58773412269, 41279.174416511654, 41543.37684934728, 41885.790571047175, 41901.58098419015, 41964.16071678565, 42110.789446052804, 7169.713211471535, 7550.660220290087, 7669.118051424074, 7674.808129796744, 7684.154742978268, 7581.09026916768, 7676.0, 7681.385489160882, 7684.116326622454, 7687.269709377628, 7601.163871974106, 7636.312731854132, 7663.885041724378, 7695.192004839495, 7699.499532530368, 7616.6572504237165, 7642.159362470124, 7654.196309387517, 7655.119661238945, 7658.195889431641, 7534.321911028033, 7590.810229744246, 7594.430417718693, 7594.734184303523, 7595.506292091051, 37848.053798654975, 37922.62077379219, 38010.0, 38118.0, 38270.0, 3476.8261586920553, 3536.6816986471085, 3538.6461353864406, 3552.7335449841366, 3552.946705799415, 30378.54432183519, 30388.69611303903, 30473.847630761706, 30826.845865770527, 30970.380592388025, 4758.357621721093, 4814.374131362935, 4831.420229572439, 4831.734254615994, 4898.093852637237, 189706.0, 190126.0, 190465.0, 190708.9999999986, 191802.0, 48970.755146224044, 49132.75433622809, 49326.75336623294, 49401.0, 49428.50571494239, 51229.0, 51323.0, 51327.0, 51446.742766285926, 51483.48516514862, 16167.514974550782, 16408.0, 16423.0, 16468.83531164697, 16486.34054637801, 10694.625688101034, 10865.076468500109, 10865.728356791144, 13587.59237222885, 13613.795793063113, 14334.569962901129, 14393.28033598316, 14437.92781036109, 14478.203698796668, 14631.0, 5884.676342801187, 6019.337872833985, 6037.969810150921, 6136.0, 6146.78486252979, 964.7009427077488, 983.852422136671, 985.7880555680563, 997.9151772099308, 999.9700008999596, 21751.56496870054, 22589.322320330088, 22830.771692282866, 22976.885115574314, 23179.536409272056, 1091.2034215023077, 1095.3318475729798, 1112.7607564373698, 1129.3449799116493, 1132.0999805154922, 11829.52681892732, 11969.16215864881, 12045.698857528456, 12150.5139794409, 12163.14857959952, 219511.0, 221329.0, 222131.0, 223537.0, 223894.0, 51286.48713512892, 51593.742031290356, 51791.0, 51911.74044129755, 52003.0, 1447.8190226221723, 1473.7715654073636, 1504.2704288420107, 1508.7661412481084, 1512.3874830693587, 21671.241506547194, 21961.095279395366, 22256.554868902207, 22504.549909002057, 22921.0, 36557.817210913774, 36723.44914826333, 36813.63186368102, 36896.63103368932, 36938.26123477462, 189747.0, 190615.04692477002, 191250.0, 191637.0, 191823.0, 31384.37231255408, 32369.0, 32600.51099233466, 32915.50626740553, 32933.17667058343, 41247.0, 41623.16753664849, 41893.37159942542, 42018.36972445354, 42541.0, 27624.8618756913, 29528.0, 30058.549121762753, 30168.09495715132, 30296.09111726652, 31546.684533155294, 32146.839265803523, 32491.837540812143, 32496.512552311262, 32696.50955235721, 36534.0, 36647.26705465822, 36915.26169476542, 36953.815230923676, 37117.07207319839, 31071.0, 31824.204394890312, 32173.195670108435, 32382.676173237967, 32699.0, 23433.531329372978, 23748.0, 23753.04987800538, 23949.0, 23953.520929580962], "value": 17015.864120088463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.464872802833, 557.8716895114123, 560.3360018378221, 566.1507738392411, 579.2903692976104, 22031.889840550793, 22882.427939301524, 22902.198423055197, 23032.76967230327, 23036.769632303673, 25899.352516187104, 26724.331891702717, 26736.86631566844, 26749.19752407431, 26801.32996675084, 6464.8060558183215, 6636.50226233032, 6638.933610663904, 6640.867182656344, 6642.468602511787, 5902.468777809996, 6366.4588509976475, 6441.420272175504, 6451.225852897659, 6478.935210647904, 6424.646644434554, 6437.9678101609425, 6438.7746428875, 6439.613623182624, 6445.097686323918, 6414.422701956823, 6433.22801263849, 6441.742330306805, 6442.6778661066755, 6450.064740612632, 5994.940050599482, 5998.700064996733, 5999.880002399971, 6001.789937352171, 6010.128531362928, 28938.13185604435, 30315.242118947204, 30703.69296307053, 30858.228544286572, 31173.688263117307, 1957.07039156401, 1994.5711671990446, 1994.800519948008, 1997.1512107354317, 1999.0804230054193, 18655.0, 19168.424947251606, 19214.615707685767, 19329.613407731766, 19351.225950961943, 2220.11195521791, 2268.6937263469385, 2279.41874821921, 2320.3409562162965, 2443.0716327795503, 135667.32166339204, 141687.0, 141769.0, 141787.29106354507, 142182.0, 14411.78382324266, 14823.70352592942, 14860.256987150815, 15183.772243416357, 15793.49885282689, 23470.295891123293, 23585.88207058988, 23618.4095397613, 23701.525969480514, 23802.880985594962, 10324.225683073799, 10780.98684111876, 10798.190135739695, 10867.565297388015, 10958.123350131971, 8204.097549269576, 9998.100170984646, 10042.74893127663, 10094.348991955565, 10154.746131346628, 8663.436876603, 9366.718998430058, 9678.75803104914, 9795.412275263507, 9807.117359437685, 2784.930376740557, 2794.686497346244, 2796.4686709525126, 2802.8178168418985, 2915.854207289627, 952.6237136331249, 955.2356149574932, 967.3373738988815, 996.6063404955003, 1004.2919741582167, 19842.305519306756, 20194.192232310543, 20222.898885505772, 20482.0, 22709.432264193198, 990.5443495991781, 1013.4578000769553, 1021.9897801021895, 1028.89711028898, 1057.2704833664748, 11404.258723182966, 11598.246114002563, 11691.76616467666, 11700.765984680258, 11743.11926605508, 472933.0, 484900.0, 488454.0, 505425.0, 508940.0, 119729.0, 128904.0, 135110.32444837713, 136259.31870340585, 137564.0, 1197.5988044005182, 1243.9813402798966, 1255.0963306419364, 1271.0530654662336, 1277.0549793153186, 20265.69601456009, 20606.69089963682, 21547.245846395926, 21814.672779907996, 22408.439789005406, 59427.70286148541, 60671.69664151651, 60741.392586073576, 61735.691321543105, 62025.689871550356, 71572.28427715656, 72668.63665681849, 72933.635331823, 72941.0, 73481.6325918367, 15118.622034449227, 15226.086434813946, 15279.541613751606, 15342.923285383502, 15407.306671200047, 23840.40398990039, 23949.16177933764, 23984.52030959336, 24267.27198184057, 24400.75599243985, 17363.0, 18560.2575896968, 18910.338138165098, 19123.617527649647, 19146.13842377124, 15644.452444164855, 16587.0, 16655.75016374731, 16876.57808554747, 16939.32242710278, 18069.367572134914, 19101.0, 19570.51073723168, 19582.608347833248, 19618.50953726168, 15186.46847360337, 15204.847951520343, 15221.391144354102, 15258.389664413744, 15272.0, 18245.08774561293, 18629.72055419197, 18823.152958117193, 18876.150573224513, 18913.905430472758], "value": 12249.132414743373, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1342.6978929740806, 1384.1003347823914, 1386.750384930712, 1397.1267957526545, 1402.894782891283, 13460.46158153674, 14230.857691423096, 14238.216898070603, 14242.643933901658, 14244.21656808875, 13837.238951857644, 14292.142471451694, 14793.112413255212, 14797.704045919076, 14833.92583037086, 2611.294950363401, 2651.3371657085727, 2664.653595032643, 2664.7202043785414, 2666.7733242674394, 2519.143491212987, 2555.821092523515, 2593.15722390223, 2616.4113074558168, 2705.0, 2652.2573679369807, 2687.4625074985083, 2700.7704345130687, 2709.6612923384578, 2710.7018227994904, 2618.188361607898, 2644.775194108503, 2647.457271259387, 2652.416468376954, 2666.7466590673853, 2472.6538284639987, 2491.9626205606933, 2495.1142344467635, 2515.5472015037285, 2516.5344411283972, 13637.0, 13866.237356945365, 13887.861121388858, 13893.4442622295, 13914.234717090556, 7438.367738742213, 7793.376529877596, 7867.252611001945, 7886.566238856861, 7912.80217994549, 5104.923426148611, 5136.332276804029, 5215.478452154792, 5295.470452954673, 5327.413984461706, 1607.718649236379, 1630.9429169979112, 1639.7294446416327, 1676.8407001334976, 1678.2196278730328, 23088.884555577115, 23291.4177145571, 23298.53402931932, 23301.76698233013, 23327.0, 6358.205224346957, 6496.35036496356, 6674.499412544079, 6683.532152749261, 6702.061711360413, 15898.0, 15905.363785448684, 15941.521754347388, 15953.122578258308, 15954.0, 7852.5288482690075, 8045.718399856094, 8095.3523718102415, 8115.066767321833, 8124.63439145228, 7158.570485770871, 7223.422126229889, 7232.529885557527, 7249.746258880914, 7309.232530584319, 4944.554990050912, 5139.820106296262, 5168.9224661630105, 5174.97412512935, 5226.947730522722, 1432.885369170464, 1444.3139508733268, 1497.176552895903, 1498.730228558848, 1509.4037855047413, 835.7910522369408, 852.6674596907087, 859.1108203009854, 865.1435079271602, 865.1737590600961, 6922.480813938974, 7100.396466300423, 7123.536970096927, 7257.8911316330295, 7311.3785328247695, 922.4419226367951, 960.4525420510242, 962.9711108666751, 965.9130678238852, 1003.4982508745627, 4659.860204193879, 4668.486466488684, 4687.742174180385, 4706.388169537938, 4738.289256611536, 18806.717899231524, 18828.905855470908, 19818.0, 19855.900720496305, 20004.399868003984, 18901.905490472735, 19291.61416771657, 19717.309894153637, 19765.308214212433, 19792.70310945337, 10510.47447627631, 10703.46482675863, 10738.140948724084, 10752.19358548112, 10766.515506802212, 7210.0, 7590.468667193464, 7622.504537205064, 7687.11598166218, 7974.202579741979, 16421.0, 16726.33094676248, 16988.0, 17140.82859171442, 17217.82782172162, 16808.327666893187, 16956.66086678284, 17305.221265042852, 17331.65336693234, 17374.391896284076, 11677.0, 11859.407029648655, 11863.40682965831, 11870.703232419259, 11893.583724569598, 12992.0, 13008.869911301144, 13229.669258268621, 13232.206067635972, 13439.0, 9866.210703143875, 10318.122959548222, 10422.687319380431, 10433.895661043292, 10589.894101058891, 10034.548445319831, 10354.1198998086, 10508.579656813641, 10666.83999739989, 10678.038976491842, 8989.28085753125, 9161.816763664556, 9164.312676549418, 9170.082991700776, 9185.127412895765, 6212.1303017578475, 6496.870062598627, 6574.0, 6625.0, 6670.266270710315, 6243.594166379171, 6305.274893387135, 6322.715477803418, 6323.272823625342, 6439.195100612424], "value": 6283.022827554653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.61078388761484, 485.7182833956306, 489.7869426799345, 497.96532940997014, 516.8552805214539, 6016.548758843093, 6099.817005489836, 6117.103697853663, 6129.938700612993, 6230.781922632709, 5857.238558987337, 5931.466168044875, 5973.4623883850445, 6009.707912798747, 6071.0, 4838.225883858583, 4840.0, 4883.704658810353, 4897.853064408056, 4906.0, 4713.222318317474, 4852.684575502581, 4858.854234372974, 4887.584555312803, 4946.9752651236695, 4759.90480190396, 4862.756862156895, 4866.46468888422, 4868.488808675092, 4902.681325713835, 4804.759762011903, 4853.3690620219495, 4876.2685597160535, 4879.097366987084, 4893.46171921092, 4360.324149756792, 4373.803178856959, 4387.3857659927635, 4391.8682439526865, 4419.712718673276, 5924.348321684612, 5943.524518038546, 5955.940440595582, 5980.192673989043, 5988.431099045583, 5506.119020956668, 5530.834074977717, 5549.694766787825, 5618.887622247573, 5622.297212848394, 6329.177206963065, 6341.397567231105, 6359.332270111618, 6383.585066970632, 6421.454176395012, 4754.286856971447, 4781.976090119562, 4791.32921391002, 4792.562231330622, 4842.297866809293, 6771.729130834711, 6775.864482710318, 6794.898076528856, 6801.353871382211, 6854.588724676535, 4841.491643377465, 4845.41854977405, 4860.198067318924, 4863.683860549053, 4887.926681099786, 4821.0, 4910.631702622318, 4947.703137811743, 4959.231319145466, 4961.330220420269, 5586.642418913254, 5607.8878422432135, 5624.156376543469, 5644.379118296984, 5645.745941432645, 6546.18172728409, 6550.508711846631, 6554.442872355808, 6565.507586930999, 6591.769288074895, 1656.892302000366, 1698.3036954848699, 1699.7875265591802, 1721.7589537464764, 1723.482955113461, 1192.946317415701, 1203.5907791350983, 1207.082617210926, 1207.432506721857, 1211.878812118781, 5658.773649054074, 5691.601587888808, 5698.601097923106, 5699.829005129853, 5700.97149514258, 6476.514261430411, 6571.6057036577, 6598.505112116611, 6606.7026983785845, 6623.337666233435, 5663.638997971539, 5689.728406166388, 5696.458836410535, 5702.173184888168, 5723.54211663066, 3475.079104037432, 3504.7021003214504, 3506.8246587670515, 3510.613832478425, 3547.290541891632, 6328.71520781566, 6338.07039635429, 6431.163948686641, 6510.544261901716, 6530.673466326664, 6728.360805723449, 6764.391204791593, 6836.4530837532875, 6847.931520684829, 6898.172219333712, 6334.524910631813, 6394.424501794861, 6415.903761443582, 6457.386548277812, 6461.353864613595, 6502.902456463252, 6542.607443553402, 6601.702923368556, 6602.29305984544, 6708.886700689267, 6487.0, 6520.836979075561, 6593.604383736991, 6618.172728408949, 6636.402723754885, 6356.555041147075, 6430.64631445275, 6435.903461448176, 6468.223813142453, 6477.578957367756, 4924.9507504924495, 4954.826581069645, 4962.230854217602, 4963.429205641398, 4964.429090654621, 6732.3267673232285, 6747.359000894907, 6754.290799465985, 6756.223034351113, 6769.559978601572, 6461.256955450183, 6483.351664833479, 6485.740570377132, 6529.216494020748, 6537.738490460329, 6455.322191169859, 6469.741210351722, 6472.15861937945, 6490.943160524672, 6506.869862602816, 6061.242344706911, 6306.180196574416, 6308.558400911892, 6361.300256971822, 6406.519511036784, 6225.533085018551, 6395.616263024233, 6458.451031662174, 6493.415592596689, 6526.608403495616, 6149.877002460015, 6217.844553886189, 6239.188905442264, 6273.905891411724, 6296.275928268308], "value": 4965.23172326532, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.0759202837015, 894.4275663575313, 905.5155491811882, 910.2263076385074, 913.5843191347935, 17456.38902638408, 18246.726299105525, 18274.0, 18312.359067432626, 20521.179152833905, 19794.812311261336, 20104.49738756532, 20201.292954746586, 20298.594028119427, 20368.592628147428, 988.5353883674661, 1004.8844382895951, 1016.065219997604, 1016.1616666250336, 1017.1303535477172, 939.5631031570318, 988.0860204311019, 1045.4511381524721, 1047.8323468245082, 1053.6101642392325, 1094.1028356747431, 1106.9280496767724, 1110.4669758515918, 1111.794318051159, 1112.054753459561, 1098.6319582939725, 1101.5979167603848, 1102.873169585492, 1107.1198397274145, 1107.7839821234863, 800.995995020027, 804.6580203413585, 810.6595230003413, 811.9269265766051, 812.2486699802718, 18229.270829166817, 18503.167357468945, 18732.719009214874, 18803.341883034165, 19016.61966760671, 20328.186872525082, 20765.58468830615, 20911.581768364547, 21019.159233630635, 21142.0, 15620.531384058497, 15797.92101039499, 15827.841721582752, 15837.683246335124, 16129.354825806953, 3563.572371315433, 3567.4292113262013, 3573.0888623401124, 3573.94639080414, 3580.874669386585, 112640.0, 116454.0, 117212.0, 118719.40640296743, 119480.40259798645, 14836.777448338284, 15447.150406727738, 15554.144522051169, 15577.299021544057, 15578.298976546082, 29116.41767164645, 29347.85326073356, 29426.411471770443, 29427.558586621217, 29658.110256692333, 7614.923850761532, 8038.356931445471, 8115.594220288962, 8226.341892648574, 9107.271418286522, 4229.2175947449205, 4390.0, 4394.231009573312, 4396.450443694538, 4397.8240870364825, 5147.485251474823, 5169.405518365361, 5276.314079169761, 5284.762185701653, 5302.469753024744, 1015.8679371681634, 1025.738436698637, 1035.1304903880775, 1042.093378760468, 1045.0803293102022, 640.270092095012, 662.6819126819154, 676.0636518422021, 688.2360579756466, 698.6436917172177, 10823.350598964087, 11575.652730418102, 12318.384080795924, 12350.44423000967, 12611.810822837664, 662.2384258103124, 663.6117871045396, 685.8388278754488, 709.0604948443333, 713.9036230108869, 4917.286993385939, 5467.781288748405, 5631.436856314336, 5778.335491418541, 6161.507079433634, 93361.0, 101712.0, 102215.0, 102549.48725256475, 103277.48361258296, 86249.56875215584, 88245.55877220572, 88589.55705221562, 90647.0, 94173.0, 76218.6189069051, 76948.2305176941, 83112.58443707864, 83801.58099209465, 85612.57193713992, 11456.0, 12186.75626487483, 12335.198212116184, 12405.565805196775, 12743.808842867178, 33114.834425827714, 35216.0, 35559.11102222465, 35955.30335224921, 36569.9886506234, 41987.580124198365, 43389.349159761994, 44381.778091109336, 45041.0, 45334.0, 17379.913100434416, 17444.47666570005, 17847.286108555512, 18002.819971800116, 18037.63924721472, 17697.938123712618, 17965.281388744304, 18015.369462068764, 18175.818241817942, 19910.800891990893, 17989.640207196044, 18104.456866294033, 18365.632687346446, 18366.357177498725, 18971.24115035383, 16542.503724888273, 16765.664686705953, 16789.74815377746, 18077.728834067762, 18337.08314584239, 17361.131943402528, 17385.391511297043, 17782.110894454967, 17961.910190448965, 18128.18423170934, 12131.332776697367, 13346.866531334563, 13385.263810490516, 13638.659033523845, 13698.246596437291, 13940.372683229076, 14623.41506339777, 14693.265336732908, 14829.777553336924, 14844.0], "value": 8838.866357078698, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 104.0, 107.0, 109.0, 108.0, 109.0, 99.0, 112.0, 109.0], "value": 106.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 124.0, 144.0, 166.0, 121.0, 147.0, 141.0, 118.0, 177.0, 124.0], "value": 140.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 163.0, 161.0, 162.0, 164.0, 166.0, 168.0, 163.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 170.0, 75.0, 76.0, 74.0, 80.0, 153.0, 76.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 127.0, 80.0, 79.0, 80.0, 144.0, 79.0, 79.0, 134.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 150.0, 151.0, 151.0, 150.0, 151.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 58.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 89.0, 79.0, 81.0, 80.0, 80.0, 80.0, 79.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 133.0, 144.0, 131.0, 126.0, 127.0, 125.0, 141.0, 131.0, 174.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 183.0, 177.0, 189.0, 188.0, 186.0, 180.0, 185.0, 179.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 66.0, 71.0, 66.0, 68.0, 68.0, 68.0, 69.0], "value": 67.9, "unit": "score"}]}]} 00:35:21 INFO - Return code: 0 00:35:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:35:21 INFO - # TBPL SUCCESS # 00:35:21 INFO - Running post-action listener: _package_coverage_data 00:35:21 INFO - Running post-action listener: _resource_record_post_action 00:35:21 INFO - [mozharness: 2017-08-02 07:35:21.889583Z] Finished run-tests step (success) 00:35:21 INFO - Running post-run listener: _resource_record_post_run 00:35:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 428515328; Read time: 20; Write time: 895052 00:35:21 INFO - TinderboxPrint: CPU usage
13.2% 00:35:21 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 00:35:21 INFO - TinderboxPrint: I/O write bytes / time
428,515,328 / 895,052 00:35:21 INFO - TinderboxPrint: CPU idle
8,276.6 (86.8%) 00:35:21 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 00:35:21 INFO - TinderboxPrint: Swap in / out
0 / 0 00:35:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107745280; Read time: 0; Write time: 235980 00:35:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:35:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 320770048; Read time: 0; Write time: 659072 00:35:22 INFO - Running post-run listener: _upload_blobber_files 00:35:22 INFO - Blob upload gear active. 00:35:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:35:22 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 00:35:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:35:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:35:22 INFO - (blobuploader) - INFO - Open directory for files ... 00:35:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:35:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:35:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:23 INFO - (blobuploader) - INFO - Done attempting. 00:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:35:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:29 INFO - (blobuploader) - INFO - Done attempting. 00:35:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:35:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:30 INFO - (blobuploader) - INFO - Done attempting. 00:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:35:31 INFO - (blobuploader) - INFO - Done attempting. 00:35:31 INFO - (blobuploader) - INFO - Iteration through files over. 00:35:31 INFO - Return code: 0 00:35:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:35:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:35:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a45b53fc2372ef2902b4fb195a884911e938e4c386bf49858b6268749d6b03615a36c9a2e8888ebaea5f96f1cd618b31c7f8f11e609b8a611b6f753214df6244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbe76c555895c61e7caeb1cf57c151c5375bc3eabf26d3e420d050e7b149b8842beaef7e18171346e46b040eb685be905c698cde0739ab95ff78d094981489e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e053bfc10618476c207f516c86f9dab48ec187e4ef7a6be74e9eb5fceb80899b70c347ce2a6eb091f68b68e87e22b2d2c0e979a992fea5a9ca88ef290d83e8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c78c2c0c9710643d8baecf87dd084a80f95afdad99f50a259df13d4c02a4e7247d1402d84c4474746235aae780da376e0982a92b4e69f3223623d06d0ba92aa9"} 00:35:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:35:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:35:31 INFO - Contents: 00:35:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a45b53fc2372ef2902b4fb195a884911e938e4c386bf49858b6268749d6b03615a36c9a2e8888ebaea5f96f1cd618b31c7f8f11e609b8a611b6f753214df6244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbe76c555895c61e7caeb1cf57c151c5375bc3eabf26d3e420d050e7b149b8842beaef7e18171346e46b040eb685be905c698cde0739ab95ff78d094981489e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e053bfc10618476c207f516c86f9dab48ec187e4ef7a6be74e9eb5fceb80899b70c347ce2a6eb091f68b68e87e22b2d2c0e979a992fea5a9ca88ef290d83e8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c78c2c0c9710643d8baecf87dd084a80f95afdad99f50a259df13d4c02a4e7247d1402d84c4474746235aae780da376e0982a92b4e69f3223623d06d0ba92aa9"} 00:35:31 INFO - Running post-run listener: copy_logs_to_upload_dir 00:35:31 INFO - Copying logs to upload dir... 00:35:31 INFO - mkdir: /builds/slave/test/build/upload/logs 00:35:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.869892 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-02 00:35:31.346125) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:31.349693) ========= 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=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 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-Non-PGO/sha512/a45b53fc2372ef2902b4fb195a884911e938e4c386bf49858b6268749d6b03615a36c9a2e8888ebaea5f96f1cd618b31c7f8f11e609b8a611b6f753214df6244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbe76c555895c61e7caeb1cf57c151c5375bc3eabf26d3e420d050e7b149b8842beaef7e18171346e46b040eb685be905c698cde0739ab95ff78d094981489e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e053bfc10618476c207f516c86f9dab48ec187e4ef7a6be74e9eb5fceb80899b70c347ce2a6eb091f68b68e87e22b2d2c0e979a992fea5a9ca88ef290d83e8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c78c2c0c9710643d8baecf87dd084a80f95afdad99f50a259df13d4c02a4e7247d1402d84c4474746235aae780da376e0982a92b4e69f3223623d06d0ba92aa9"} build_url:https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/JhuDbI3YQeS1KwM6F3P5lg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a45b53fc2372ef2902b4fb195a884911e938e4c386bf49858b6268749d6b03615a36c9a2e8888ebaea5f96f1cd618b31c7f8f11e609b8a611b6f753214df6244", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/abbe76c555895c61e7caeb1cf57c151c5375bc3eabf26d3e420d050e7b149b8842beaef7e18171346e46b040eb685be905c698cde0739ab95ff78d094981489e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3e053bfc10618476c207f516c86f9dab48ec187e4ef7a6be74e9eb5fceb80899b70c347ce2a6eb091f68b68e87e22b2d2c0e979a992fea5a9ca88ef290d83e8d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c78c2c0c9710643d8baecf87dd084a80f95afdad99f50a259df13d4c02a4e7247d1402d84c4474746235aae780da376e0982a92b4e69f3223623d06d0ba92aa9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:31.381125) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:31.393933) ========= 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=8783db0840cc980e80bb0bd400000236-1501654902.718052-1109968166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-02 00:35:31.443199) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:35:31.443529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-02 00:35:31.443817) ========= ========= Total master_lag: 0.11 =========