builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1502107672.79 results: success (0) revision: 47248637eafa9a38dade8dc3aa6c4736177c8d8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.786735) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.787182) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.787460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.803400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.803763) ========= 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=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 05:07:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.4M=0s 2017-08-07 05:07:53 (37.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159972 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.980802) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:52.981192) ========= 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=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016490 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.033570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.036921) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47248637eafa9a38dade8dc3aa6c4736177c8d8d --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 47248637eafa9a38dade8dc3aa6c4736177c8d8d --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=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 05:07:53,680 truncating revision to first 12 chars 2017-08-07 05:07:53,680 Setting DEBUG logging. 2017-08-07 05:07:53,680 attempt 1/10 2017-08-07 05:07:53,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47248637eafa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-07 05:07:54,135 unpacking tar archive at: mozilla-central-47248637eafa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.766371 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.818935) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.819248) ========= script_repo_revision: 47248637eafa9a38dade8dc3aa6c4736177c8d8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.819615) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.819885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:07:53.828499) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-07 05:07:53.828788) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:07:54 INFO - MultiFileLogger online at 20170807 05:07:54 in /builds/slave/test 05:07:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:07:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:07:54 INFO - {'append_to_log': False, 05:07:54 INFO - 'base_work_dir': '/builds/slave/test', 05:07:54 INFO - 'blob_upload_branch': 'Firefox', 05:07:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:07:54 INFO - 'branch': 'Firefox', 05:07:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:07:54 INFO - 'code_coverage': False, 05:07:54 INFO - 'config_files': ('talos/linux_config.py',), 05:07:54 INFO - 'default_actions': ('clobber', 05:07:54 INFO - 'read-buildbot-config', 05:07:54 INFO - 'download-and-extract', 05:07:54 INFO - 'populate-webroot', 05:07:54 INFO - 'create-virtualenv', 05:07:54 INFO - 'install', 05:07:54 INFO - 'setup-mitmproxy', 05:07:54 INFO - 'run-tests'), 05:07:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:07:54 INFO - 'disable_ccov_upload': False, 05:07:54 INFO - 'download_minidump_stackwalk': True, 05:07:54 INFO - 'download_symbols': 'ondemand', 05:07:54 INFO - 'enable_stylo': False, 05:07:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:07:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:07:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:07:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:07:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:07:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:07:54 INFO - 'gecko_profile': False, 05:07:54 INFO - 'gecko_profile_interval': 0, 05:07:54 INFO - 'installer_path': 'installer.exe', 05:07:54 INFO - 'log_level': 'info', 05:07:54 INFO - 'log_name': 'talos', 05:07:54 INFO - 'log_to_console': True, 05:07:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:07:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:07:54 INFO - 'opt_config_files': (), 05:07:54 INFO - 'pip_index': False, 05:07:54 INFO - 'suite': 'dromaeojs-e10s', 05:07:54 INFO - 'system_bits': '32', 05:07:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:07:54 INFO - 'title': 'talos-linux64-ix-049', 05:07:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:07:54 INFO - 'use_talos_json': True, 05:07:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:07:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:07:54 INFO - 'work_dir': 'build'} 05:07:54 INFO - [mozharness: 2017-08-07 12:07:54.573906Z] Running clobber step. 05:07:54 INFO - Running pre-action listener: _resource_record_pre_action 05:07:54 INFO - Running main action method: clobber 05:07:54 INFO - rmtree: /builds/slave/test/build 05:07:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:07:56 INFO - Running post-action listener: _resource_record_post_action 05:07:56 INFO - [mozharness: 2017-08-07 12:07:56.285597Z] Finished clobber step (success) 05:07:56 INFO - [mozharness: 2017-08-07 12:07:56.285699Z] Running read-buildbot-config step. 05:07:56 INFO - Running pre-action listener: _resource_record_pre_action 05:07:56 INFO - Running main action method: read_buildbot_config 05:07:56 INFO - Using buildbot properties: 05:07:56 INFO - { 05:07:56 INFO - "project": "", 05:07:56 INFO - "product": "firefox", 05:07:56 INFO - "who": "cbook@mozilla.com", 05:07:56 INFO - "installer_path": "public/build/target.tar.bz2", 05:07:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 05:07:56 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:07:56 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 05:07:56 INFO - "stage_platform": "linux64-stylo", 05:07:56 INFO - "basedir": "/builds/slave/test", 05:07:56 INFO - "buildnumber": 17, 05:07:56 INFO - "platform": "ubuntu64_hw_stylo", 05:07:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:07:56 INFO - "slavebuilddir": "test", 05:07:56 INFO - "taskId": "OYuBrxENS7SUfHM11_4jWQ", 05:07:56 INFO - "branch": "mozilla-central", 05:07:56 INFO - "script_repo_revision": "production", 05:07:56 INFO - "revision": "47248637eafa9a38dade8dc3aa6c4736177c8d8d", 05:07:56 INFO - "slavename": "talos-linux64-ix-049", 05:07:56 INFO - "repo_path": "mozilla-central" 05:07:56 INFO - } 05:07:56 INFO - Finding installer, test and symbols from parent task. 05:07:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYuBrxENS7SUfHM11_4jWQ'}, attempt #1 05:07:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OYuBrxENS7SUfHM11_4jWQ'}, attempt #1 05:07:57 INFO - Task dependencies: FK6Vw9RDTvi4Ea5oCnVSGw 05:07:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw'}, attempt #1 05:07:57 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:07:57 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json 05:07:57 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.crashreporter-symbols.zip 05:07:57 INFO - Running post-action listener: _resource_record_post_action 05:07:57 INFO - [mozharness: 2017-08-07 12:07:57.667818Z] Finished read-buildbot-config step (success) 05:07:57 INFO - [mozharness: 2017-08-07 12:07:57.668043Z] Running download-and-extract step. 05:07:57 INFO - Running pre-action listener: _resource_record_pre_action 05:07:57 INFO - Running main action method: download_and_extract 05:07:57 INFO - mkdir: /builds/slave/test/build/tests 05:07:57 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')]} 05:07:57 INFO - trying https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json 05:07:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:07:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:07:59 INFO - Downloaded 989 bytes. 05:07:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:07:59 INFO - Using the following test package requirements: 05:07:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:07:59 INFO - u'common': [u'target.common.tests.zip'], 05:07:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:07:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:07:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:07:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:07:59 INFO - u'mozbase': [u'target.common.tests.zip'], 05:07:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:07:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:07:59 INFO - u'web-platform': [u'target.common.tests.zip', 05:07:59 INFO - u'target.web-platform.tests.tar.gz'], 05:07:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:07:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:07:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip 05:07:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:07:59 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip into memory 05:08:00 INFO - Content-Length response header: 54284838 05:08:00 INFO - Bytes received: 54284838 05:08:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:08:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip 05:08:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:08:11 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip into memory 05:08:12 INFO - Content-Length response header: 54284838 05:08:12 INFO - Bytes received: 54284838 05:08:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.talos.tests.zip 05:08:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:08:24 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.talos.tests.zip into memory 05:08:25 INFO - Content-Length response header: 14496008 05:08:25 INFO - Bytes received: 14496008 05:08: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')]} 05:08:25 INFO - trying https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:08:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:08:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:08:26 INFO - Downloaded 61707857 bytes. 05:08:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:08:26 INFO - mkdir: /builds/slave/test/properties 05:08:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:26 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:26 INFO - Contents: 05:08:26 INFO - build_url:https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:08:26 INFO - Running post-action listener: _resource_record_post_action 05:08:26 INFO - Running post-action listener: set_extra_try_arguments 05:08:26 INFO - [mozharness: 2017-08-07 12:08:26.851125Z] Finished download-and-extract step (success) 05:08:26 INFO - [mozharness: 2017-08-07 12:08:26.851225Z] Running populate-webroot step. 05:08:26 INFO - Running pre-action listener: _resource_record_pre_action 05:08:26 INFO - Running main action method: populate_webroot 05:08:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:08:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:08:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:08:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:08:26 INFO - 'tests': ['damp', 'tps']}, 05:08:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:08:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:08:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:08:26 INFO - 'other-e10s': {'tests': ['a11yr', 05:08:26 INFO - 'ts_paint', 05:08:26 INFO - 'tpaint', 05:08:26 INFO - 'sessionrestore', 05:08:26 INFO - 'sessionrestore_many_windows', 05:08:26 INFO - 'sessionrestore_no_auto_restore', 05:08:26 INFO - 'tabpaint']}, 05:08:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:08:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:08:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:08:26 INFO - 'tsvgr_opacity', 05:08:26 INFO - 'tart', 05:08:26 INFO - 'tscrollx', 05:08:26 INFO - 'tsvg_static']}, 05:08:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:08:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:08:26 INFO - 'talos_options': ['--mitmproxy', 05:08:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:08:26 INFO - '--firstNonBlankPaint'], 05:08:26 INFO - 'tests': ['tp6_google', 05:08:26 INFO - 'tp6_youtube', 05:08:26 INFO - 'tp6_amazon', 05:08:26 INFO - 'tp6_facebook']}, 05:08:26 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:08:26 INFO - 'talos_options': ['--stylo', 05:08:26 INFO - '--mitmproxy', 05:08:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:08:26 INFO - '--firstNonBlankPaint'], 05:08:26 INFO - 'tests': ['tp6_google', 05:08:26 INFO - 'tp6_youtube', 05:08:26 INFO - 'tp6_amazon', 05:08:26 INFO - 'tp6_facebook']}, 05:08:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:08:26 INFO - 'talos_options': ['--stylo', 05:08:26 INFO - '--stylo-threads=1', 05:08:26 INFO - '--mitmproxy', 05:08:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:08:26 INFO - '--firstNonBlankPaint'], 05:08:26 INFO - 'tests': ['tp6_google', 05:08:26 INFO - 'tp6_youtube', 05:08:26 INFO - 'tp6_amazon', 05:08:26 INFO - 'tp6_facebook']}, 05:08:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:08:26 INFO - 'talos_options': ['--xperf_path', 05:08:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:26 INFO - 'tests': ['tp5n']}}} 05:08:26 INFO - Running post-action listener: _resource_record_post_action 05:08:26 INFO - [mozharness: 2017-08-07 12:08:26.859785Z] Finished populate-webroot step (success) 05:08:26 INFO - [mozharness: 2017-08-07 12:08:26.859876Z] Running create-virtualenv step. 05:08:26 INFO - Running pre-action listener: _resource_record_pre_action 05:08:26 INFO - Running main action method: create_virtualenv 05:08:26 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:26 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 05:08:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:08:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:26 INFO - Using real prefix '/usr' 05:08:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:27 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:29 INFO - Installing pip.................done. 05:08:29 INFO - Return code: 0 05:08:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:08:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:08:29 INFO - Reading from file tmpfile_stdout 05:08:29 INFO - Output received: 05:08:29 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) 05:08:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:29 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:29 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 05:08:29 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 05:08:29 INFO - Using env: {'DISPLAY': ':0', 05:08:29 INFO - 'HOME': '/home/cltbld', 05:08:29 INFO - 'LANG': 'en_US.UTF-8', 05:08:29 INFO - 'LANGUAGE': 'en_US:en', 05:08:29 INFO - 'LOGNAME': 'cltbld', 05:08:29 INFO - 'MAIL': '/var/mail/cltbld', 05:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:29 INFO - 'MOZ_NO_REMOTE': '1', 05:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:29 INFO - 'NO_EM_RESTART': '1', 05:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:29 INFO - 'PWD': '/builds/slave/test', 05:08:29 INFO - 'SHELL': '/bin/bash', 05:08:29 INFO - 'SHLVL': '1', 05:08:29 INFO - 'TERM': 'linux', 05:08:29 INFO - 'TMOUT': '86400', 05:08:29 INFO - 'USER': 'cltbld', 05:08:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:29 INFO - '_': '/tools/buildbot/bin/python'} 05:08:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:29 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 05:08:29 INFO - Cleaning up... 05:08:29 INFO - Return code: 0 05:08:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:29 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:29 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 05:08:29 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 05:08:29 INFO - Using env: {'DISPLAY': ':0', 05:08:29 INFO - 'HOME': '/home/cltbld', 05:08:29 INFO - 'LANG': 'en_US.UTF-8', 05:08:29 INFO - 'LANGUAGE': 'en_US:en', 05:08:29 INFO - 'LOGNAME': 'cltbld', 05:08:29 INFO - 'MAIL': '/var/mail/cltbld', 05:08:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:29 INFO - 'MOZ_NO_REMOTE': '1', 05:08:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:29 INFO - 'NO_EM_RESTART': '1', 05:08:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:29 INFO - 'PWD': '/builds/slave/test', 05:08:29 INFO - 'SHELL': '/bin/bash', 05:08:29 INFO - 'SHLVL': '1', 05:08:29 INFO - 'TERM': 'linux', 05:08:29 INFO - 'TMOUT': '86400', 05:08:29 INFO - 'USER': 'cltbld', 05:08:29 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:29 INFO - '_': '/tools/buildbot/bin/python'} 05:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:30 INFO - Downloading/unpacking psutil>=3.1.1 05:08:30 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 05:08:30 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 05:08:30 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 05:08:30 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 05:08:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:31 INFO - Installing collected packages: psutil 05:08:31 INFO - Running setup.py install for psutil 05:08:31 INFO - building 'psutil._psutil_linux' extension 05:08:31 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 05:08:31 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 05:08:31 INFO - building 'psutil._psutil_posix' extension 05:08:31 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 05:08:31 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 05:08:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:31 INFO - Successfully installed psutil 05:08:31 INFO - Cleaning up... 05:08:31 INFO - Return code: 0 05:08:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:08:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:08:31 INFO - Using env: {'DISPLAY': ':0', 05:08:31 INFO - 'HOME': '/home/cltbld', 05:08:31 INFO - 'LANG': 'en_US.UTF-8', 05:08:31 INFO - 'LANGUAGE': 'en_US:en', 05:08:31 INFO - 'LOGNAME': 'cltbld', 05:08:31 INFO - 'MAIL': '/var/mail/cltbld', 05:08:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:31 INFO - 'MOZ_NO_REMOTE': '1', 05:08:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:31 INFO - 'NO_EM_RESTART': '1', 05:08:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:31 INFO - 'PWD': '/builds/slave/test', 05:08:31 INFO - 'SHELL': '/bin/bash', 05:08:31 INFO - 'SHLVL': '1', 05:08:31 INFO - 'TERM': 'linux', 05:08:31 INFO - 'TMOUT': '86400', 05:08:31 INFO - 'USER': 'cltbld', 05:08:31 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:31 INFO - '_': '/tools/buildbot/bin/python'} 05:08:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:08:33 INFO - Installing collected packages: mozsystemmonitor 05:08:33 INFO - Running setup.py install for mozsystemmonitor 05:08:33 INFO - Successfully installed mozsystemmonitor 05:08:33 INFO - Cleaning up... 05:08:33 INFO - Return code: 0 05:08:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:08:33 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')]} 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:33 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')]} 05:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:33 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:33 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 05:08:33 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 05:08:33 INFO - Using env: {'DISPLAY': ':0', 05:08:33 INFO - 'HOME': '/home/cltbld', 05:08:33 INFO - 'LANG': 'en_US.UTF-8', 05:08:33 INFO - 'LANGUAGE': 'en_US:en', 05:08:33 INFO - 'LOGNAME': 'cltbld', 05:08:33 INFO - 'MAIL': '/var/mail/cltbld', 05:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:33 INFO - 'MOZ_NO_REMOTE': '1', 05:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:33 INFO - 'NO_EM_RESTART': '1', 05:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:33 INFO - 'PWD': '/builds/slave/test', 05:08:33 INFO - 'SHELL': '/bin/bash', 05:08:33 INFO - 'SHLVL': '1', 05:08:33 INFO - 'TERM': 'linux', 05:08:33 INFO - 'TMOUT': '86400', 05:08:33 INFO - 'USER': 'cltbld', 05:08:33 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:33 INFO - '_': '/tools/buildbot/bin/python'} 05:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:33 INFO - Downloading/unpacking jsonschema==2.5.1 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:08:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:34 INFO - Downloading functools32-3.2.3-2.tar.gz 05:08:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:08:34 INFO - warning: no files found matching '*.txt' 05:08:34 INFO - no previously-included directories found matching 'build' 05:08:34 INFO - no previously-included directories found matching 'dist' 05:08:34 INFO - no previously-included directories found matching '.git*' 05:08:34 INFO - Installing collected packages: jsonschema, functools32 05:08:34 INFO - Running setup.py install for functools32 05:08:34 INFO - warning: no files found matching '*.txt' 05:08:34 INFO - no previously-included directories found matching 'build' 05:08:34 INFO - no previously-included directories found matching 'dist' 05:08:34 INFO - no previously-included directories found matching '.git*' 05:08:34 INFO - Successfully installed jsonschema functools32 05:08:34 INFO - Cleaning up... 05:08:35 INFO - Return code: 0 05:08:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:35 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:35 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 05:08:35 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 05:08:35 INFO - Using env: {'DISPLAY': ':0', 05:08:35 INFO - 'HOME': '/home/cltbld', 05:08:35 INFO - 'LANG': 'en_US.UTF-8', 05:08:35 INFO - 'LANGUAGE': 'en_US:en', 05:08:35 INFO - 'LOGNAME': 'cltbld', 05:08:35 INFO - 'MAIL': '/var/mail/cltbld', 05:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:35 INFO - 'MOZ_NO_REMOTE': '1', 05:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:35 INFO - 'NO_EM_RESTART': '1', 05:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:35 INFO - 'PWD': '/builds/slave/test', 05:08:35 INFO - 'SHELL': '/bin/bash', 05:08:35 INFO - 'SHLVL': '1', 05:08:35 INFO - 'TERM': 'linux', 05:08:35 INFO - 'TMOUT': '86400', 05:08:35 INFO - 'USER': 'cltbld', 05:08:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:35 INFO - '_': '/tools/buildbot/bin/python'} 05:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:08:35 INFO - Cleaning up... 05:08:35 INFO - Return code: 0 05:08:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:35 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:35 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 05:08:35 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 05:08:35 INFO - Using env: {'DISPLAY': ':0', 05:08:35 INFO - 'HOME': '/home/cltbld', 05:08:35 INFO - 'LANG': 'en_US.UTF-8', 05:08:35 INFO - 'LANGUAGE': 'en_US:en', 05:08:35 INFO - 'LOGNAME': 'cltbld', 05:08:35 INFO - 'MAIL': '/var/mail/cltbld', 05:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:35 INFO - 'MOZ_NO_REMOTE': '1', 05:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:35 INFO - 'NO_EM_RESTART': '1', 05:08:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:35 INFO - 'PWD': '/builds/slave/test', 05:08:35 INFO - 'SHELL': '/bin/bash', 05:08:35 INFO - 'SHLVL': '1', 05:08:35 INFO - 'TERM': 'linux', 05:08:35 INFO - 'TMOUT': '86400', 05:08:35 INFO - 'USER': 'cltbld', 05:08:35 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:35 INFO - '_': '/tools/buildbot/bin/python'} 05:08:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:35 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:37 INFO - Downloading docopt-0.6.1.tar.gz 05:08:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:37 INFO - Running setup.py install for blobuploader 05:08:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:37 INFO - Running setup.py install for requests 05:08:37 INFO - Running setup.py install for docopt 05:08:37 INFO - Successfully installed blobuploader requests docopt 05:08:37 INFO - Cleaning up... 05:08:37 INFO - Return code: 0 05:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:37 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:37 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 05:08:37 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 05:08:37 INFO - Using env: {'DISPLAY': ':0', 05:08:37 INFO - 'HOME': '/home/cltbld', 05:08:37 INFO - 'LANG': 'en_US.UTF-8', 05:08:37 INFO - 'LANGUAGE': 'en_US:en', 05:08:37 INFO - 'LOGNAME': 'cltbld', 05:08:37 INFO - 'MAIL': '/var/mail/cltbld', 05:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:37 INFO - 'MOZ_NO_REMOTE': '1', 05:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:37 INFO - 'NO_EM_RESTART': '1', 05:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:37 INFO - 'PWD': '/builds/slave/test', 05:08:37 INFO - 'SHELL': '/bin/bash', 05:08:37 INFO - 'SHLVL': '1', 05:08:37 INFO - 'TERM': 'linux', 05:08:37 INFO - 'TMOUT': '86400', 05:08:37 INFO - 'USER': 'cltbld', 05:08:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:37 INFO - '_': '/tools/buildbot/bin/python'} 05:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:37 INFO - Running setup.py (path:/tmp/pip-KuAGWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:38 INFO - Running setup.py (path:/tmp/pip-KhMpIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:38 INFO - Running setup.py (path:/tmp/pip-Yg0Zhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:38 INFO - Running setup.py (path:/tmp/pip-9PlKc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:38 INFO - Running setup.py (path:/tmp/pip-2yOswL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:38 INFO - Running setup.py (path:/tmp/pip-URXvS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:38 INFO - Running setup.py (path:/tmp/pip-El3Hcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:38 INFO - Running setup.py (path:/tmp/pip-l18CRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:38 INFO - Running setup.py (path:/tmp/pip-XA6t4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:38 INFO - Running setup.py (path:/tmp/pip-FwLICK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:38 INFO - Running setup.py (path:/tmp/pip-33Cg3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:38 INFO - Running setup.py (path:/tmp/pip-t1hYDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:38 INFO - Running setup.py (path:/tmp/pip-gqJbqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:38 INFO - Running setup.py (path:/tmp/pip-DUS_X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:38 INFO - Running setup.py (path:/tmp/pip-JCbMJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:39 INFO - Running setup.py (path:/tmp/pip-Hz2SjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:39 INFO - Running setup.py (path:/tmp/pip-EwCqTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:39 INFO - Running setup.py install for manifestparser 05:08:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozcrash 05:08:39 INFO - Running setup.py install for mozdebug 05:08:39 INFO - Running setup.py install for mozdevice 05:08:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozfile 05:08:39 INFO - Running setup.py install for mozhttpd 05:08:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozinfo 05:08:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozInstall 05:08:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:39 INFO - Running setup.py install for mozleak 05:08:40 INFO - Running setup.py install for mozlog 05:08:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for moznetwork 05:08:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozprocess 05:08:40 INFO - Running setup.py install for mozprofile 05:08:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozrunner 05:08:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Running setup.py install for mozscreenshot 05:08:40 INFO - Running setup.py install for moztest 05:08:40 INFO - Running setup.py install for mozversion 05:08:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:40 INFO - Cleaning up... 05:08:40 INFO - Return code: 0 05:08:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:40 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')]} 05:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:40 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')]} 05:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:40 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:40 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 05:08:40 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 05:08:40 INFO - Using env: {'DISPLAY': ':0', 05:08:40 INFO - 'HOME': '/home/cltbld', 05:08:40 INFO - 'LANG': 'en_US.UTF-8', 05:08:40 INFO - 'LANGUAGE': 'en_US:en', 05:08:40 INFO - 'LOGNAME': 'cltbld', 05:08:40 INFO - 'MAIL': '/var/mail/cltbld', 05:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:40 INFO - 'MOZ_NO_REMOTE': '1', 05:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:40 INFO - 'NO_EM_RESTART': '1', 05:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:40 INFO - 'PWD': '/builds/slave/test', 05:08:40 INFO - 'SHELL': '/bin/bash', 05:08:40 INFO - 'SHLVL': '1', 05:08:40 INFO - 'TERM': 'linux', 05:08:40 INFO - 'TMOUT': '86400', 05:08:40 INFO - 'USER': 'cltbld', 05:08:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:40 INFO - '_': '/tools/buildbot/bin/python'} 05:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:41 INFO - Running setup.py (path:/tmp/pip-ZxsYnj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:41 INFO - Running setup.py (path:/tmp/pip-21wJhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:41 INFO - Running setup.py (path:/tmp/pip-9gP0Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:41 INFO - Running setup.py (path:/tmp/pip-hK5JyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:41 INFO - Running setup.py (path:/tmp/pip-3QXTls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:41 INFO - Running setup.py (path:/tmp/pip-4yEuXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:41 INFO - Running setup.py (path:/tmp/pip-HQ9xWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:41 INFO - Running setup.py (path:/tmp/pip-avtOUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:41 INFO - Running setup.py (path:/tmp/pip-T1fpqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:41 INFO - Running setup.py (path:/tmp/pip-Taenkj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:41 INFO - Running setup.py (path:/tmp/pip-KDGenF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:41 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)) 05:08:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:41 INFO - Running setup.py (path:/tmp/pip-z2BTU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:42 INFO - Running setup.py (path:/tmp/pip-u2Rvhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:42 INFO - Running setup.py (path:/tmp/pip-_a5d5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:42 INFO - Running setup.py (path:/tmp/pip-E6yq69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:42 INFO - Running setup.py (path:/tmp/pip-exmJli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:42 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)) 05:08:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:42 INFO - Running setup.py (path:/tmp/pip-2Dh0pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:42 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)) 05:08:42 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)) 05:08:42 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)) 05:08:42 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)) 05:08:42 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)) 05:08:42 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)) 05:08:42 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)) 05:08:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:42 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 05:08:42 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 05:08:42 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 05:08:42 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 05:08:43 INFO - Downloading blessings-1.6.tar.gz 05:08:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:08:43 INFO - Installing collected packages: blessings 05:08:43 INFO - Running setup.py install for blessings 05:08:43 INFO - Successfully installed blessings 05:08:43 INFO - Cleaning up... 05:08:43 INFO - Return code: 0 05:08:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:08:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:43 INFO - Reading from file tmpfile_stdout 05:08:43 INFO - Current package versions: 05:08:43 INFO - argparse == 1.2.1 05:08:43 INFO - blessings == 1.6 05:08:43 INFO - blobuploader == 1.2.4 05:08:43 INFO - docopt == 0.6.1 05:08:43 INFO - functools32 == 3.2.3-2 05:08:43 INFO - jsonschema == 2.5.1 05:08:43 INFO - manifestparser == 1.1 05:08:43 INFO - mozInstall == 1.13 05:08:43 INFO - mozcrash == 1.0 05:08:43 INFO - mozdebug == 0.1 05:08:43 INFO - mozdevice == 0.51 05:08:43 INFO - mozfile == 1.2 05:08:43 INFO - mozhttpd == 0.7 05:08:43 INFO - mozinfo == 0.10 05:08:43 INFO - mozleak == 0.1 05:08:43 INFO - mozlog == 3.5 05:08:43 INFO - moznetwork == 0.27 05:08:43 INFO - mozprocess == 0.25 05:08:43 INFO - mozprofile == 0.28 05:08:43 INFO - mozrunner == 6.13 05:08:43 INFO - mozscreenshot == 0.1 05:08:43 INFO - mozsystemmonitor == 0.3 05:08:43 INFO - moztest == 0.8 05:08:43 INFO - mozversion == 1.4 05:08:43 INFO - psutil == 3.1.1 05:08:43 INFO - requests == 1.2.3 05:08:43 INFO - wsgiref == 0.1.2 05:08:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08: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')]} 05:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:43 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:43 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 05:08:43 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 05:08:43 INFO - Using env: {'DISPLAY': ':0', 05:08:43 INFO - 'HOME': '/home/cltbld', 05:08:43 INFO - 'LANG': 'en_US.UTF-8', 05:08:43 INFO - 'LANGUAGE': 'en_US:en', 05:08:43 INFO - 'LOGNAME': 'cltbld', 05:08:43 INFO - 'MAIL': '/var/mail/cltbld', 05:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:43 INFO - 'MOZ_NO_REMOTE': '1', 05:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:43 INFO - 'NO_EM_RESTART': '1', 05:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:43 INFO - 'PWD': '/builds/slave/test', 05:08:43 INFO - 'SHELL': '/bin/bash', 05:08:43 INFO - 'SHLVL': '1', 05:08:43 INFO - 'TERM': 'linux', 05:08:43 INFO - 'TMOUT': '86400', 05:08:43 INFO - 'USER': 'cltbld', 05:08:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:43 INFO - '_': '/tools/buildbot/bin/python'} 05:08:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 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)) 05:08:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:08:44 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 05:08:44 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 05:08:44 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 05:08:44 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 05:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:08:45 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)) 05:08:45 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)) 05:08:45 INFO - Installing collected packages: simplejson 05:08:45 INFO - Running setup.py install for simplejson 05:08:45 INFO - building 'simplejson._speedups' extension 05:08:45 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 05:08:46 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 05:08:46 INFO - Successfully installed simplejson 05:08:46 INFO - Cleaning up... 05:08:46 INFO - Return code: 0 05:08:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:08:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:46 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 0x179a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1966a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b09d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, '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': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', '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 05:08:46 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 05:08:46 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 05:08:46 INFO - Using env: {'DISPLAY': ':0', 05:08:46 INFO - 'HOME': '/home/cltbld', 05:08:46 INFO - 'LANG': 'en_US.UTF-8', 05:08:46 INFO - 'LANGUAGE': 'en_US:en', 05:08:46 INFO - 'LOGNAME': 'cltbld', 05:08:46 INFO - 'MAIL': '/var/mail/cltbld', 05:08:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:46 INFO - 'MOZ_NO_REMOTE': '1', 05:08:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:08:46 INFO - 'NO_EM_RESTART': '1', 05:08:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:08:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:46 INFO - 'PWD': '/builds/slave/test', 05:08:46 INFO - 'SHELL': '/bin/bash', 05:08:46 INFO - 'SHLVL': '1', 05:08:46 INFO - 'TERM': 'linux', 05:08:46 INFO - 'TMOUT': '86400', 05:08:46 INFO - 'USER': 'cltbld', 05:08:46 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:08:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:46 INFO - '_': '/tools/buildbot/bin/python'} 05:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:08:46 INFO - Cleaning up... 05:08:46 INFO - Return code: 0 05:08:46 INFO - Running post-action listener: _resource_record_post_action 05:08:46 INFO - Running post-action listener: _start_resource_monitoring 05:08:46 INFO - Starting resource monitoring. 05:08:46 INFO - [mozharness: 2017-08-07 12:08:46.676962Z] Finished create-virtualenv step (success) 05:08:46 INFO - [mozharness: 2017-08-07 12:08:46.677479Z] Running install step. 05:08:46 INFO - Running pre-action listener: _resource_record_pre_action 05:08:46 INFO - Running main action method: install 05:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:08:46 INFO - Reading from file tmpfile_stdout 05:08:46 INFO - Detecting whether we're running mozinstall >=1.0... 05:08:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:08:47 INFO - Reading from file tmpfile_stdout 05:08:47 INFO - Output received: 05:08:47 INFO - Usage: mozinstall [options] installer 05:08:47 INFO - Options: 05:08:47 INFO - -h, --help show this help message and exit 05:08:47 INFO - -d DEST, --destination=DEST 05:08:47 INFO - Directory to install application into. [default: 05:08:47 INFO - "/builds/slave/test"] 05:08:47 INFO - --app=APP Application being installed. [default: firefox] 05:08:47 INFO - mkdir: /builds/slave/test/build/application 05:08:47 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'] 05:08:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:09:04 INFO - Reading from file tmpfile_stdout 05:09:04 INFO - Output received: 05:09:04 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:04 INFO - Running post-action listener: _resource_record_post_action 05:09:04 INFO - [mozharness: 2017-08-07 12:09:04.995429Z] Finished install step (success) 05:09:04 INFO - [mozharness: 2017-08-07 12:09:04.995779Z] Running setup-mitmproxy step. 05:09:04 INFO - Running pre-action listener: _resource_record_pre_action 05:09:04 INFO - Running main action method: setup_mitmproxy 05:09:04 INFO - Skipping: mitmproxy is not required 05:09:04 INFO - Running post-action listener: _resource_record_post_action 05:09:04 INFO - [mozharness: 2017-08-07 12:09:04.997413Z] Finished setup-mitmproxy step (success) 05:09:04 INFO - [mozharness: 2017-08-07 12:09:04.997725Z] Running run-tests step. 05:09:04 INFO - Running pre-action listener: _resource_record_pre_action 05:09:04 INFO - Running pre-action listener: _set_gcov_prefix 05:09:04 INFO - Running main action method: run_tests 05:09:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:05 INFO - Python 2.7.3 05:09:05 INFO - Return code: 0 05:09:05 INFO - grabbing minidump binary from tooltool 05:09:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:05 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 0x1b06eb0>, '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 0x1b07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b08240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:05 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 05:09:05 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 05:09:05 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 05:09:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:05 INFO - Return code: 0 05:09:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:05 INFO - ENV: RUST_BACKTRACE is now 1 05:09:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:09:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 05:09:05 INFO - Using env: {'DISPLAY': ':0', 05:09:05 INFO - 'HOME': '/home/cltbld', 05:09:05 INFO - 'LANG': 'en_US.UTF-8', 05:09:05 INFO - 'LANGUAGE': 'en_US:en', 05:09:05 INFO - 'LOGNAME': 'cltbld', 05:09:05 INFO - 'MAIL': '/var/mail/cltbld', 05:09:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:05 INFO - 'MOZ_NO_REMOTE': '1', 05:09:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:05 INFO - 'NO_EM_RESTART': '1', 05:09:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:05 INFO - 'PWD': '/builds/slave/test', 05:09:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:05 INFO - 'RUST_BACKTRACE': '1', 05:09:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:09:05 INFO - 'SHELL': '/bin/bash', 05:09:05 INFO - 'SHLVL': '1', 05:09:05 INFO - 'STYLO_FORCE_ENABLED': '1', 05:09:05 INFO - 'TERM': 'linux', 05:09:05 INFO - 'TMOUT': '86400', 05:09:05 INFO - 'USER': 'cltbld', 05:09:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010', 05:09:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:05 INFO - '_': '/tools/buildbot/bin/python'} 05:09:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:09:05 INFO - mozversion application_buildid: 20170807112422 05:09:05 INFO - mozversion application_changeset: 47248637eafa9a38dade8dc3aa6c4736177c8d8d 05:09:05 INFO - mozversion application_display_name: Nightly 05:09:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:05 INFO - mozversion application_name: Firefox 05:09:05 INFO - mozversion application_remotingname: firefox 05:09:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:09:05 INFO - mozversion application_vendor: Mozilla 05:09:05 INFO - mozversion application_version: 57.0a1 05:09:05 INFO - mozversion platform_buildid: 20170807112422 05:09:05 INFO - mozversion platform_changeset: 47248637eafa9a38dade8dc3aa6c4736177c8d8d 05:09:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:09:05 INFO - mozversion platform_version: 57.0a1 05:09:05 INFO - using testdate: 1502107745 05:09:05 INFO - actual date: 1502107745 05:09:05 INFO - starting webserver on 'localhost:48987' 05:09:05 INFO - SUITE-START | Running 2 tests 05:09:05 INFO - TEST-START | dromaeo_css 05:09:05 INFO - Initialising browser for dromaeo_css test... 05:09:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48987/getInfo.html -profile /tmp/tmpRHgnb_/profile 05:09:05 INFO - TEST-INFO | started process 12430 (/builds/slave/test/build/application/firefox/firefox http://localhost:48987/getInfo.html) 05:09:11 INFO - TEST-INFO | 12430: exit 0 05:09:11 INFO - Browser initialized. 05:09:11 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:11 INFO - TEST-INFO | started process 12658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRHgnb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:12 INFO - PID 12658 | 05:09:12 INFO - PID 12658 | (/builds/slave/test/build/application/firefox/firefox:12712): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:09:12 INFO - PID 12658 | 05:09:22 INFO - PID 12658 | RSS: Main: 173375488 05:09:22 INFO - PID 12658 | 05:09:22 INFO - PID 12658 | serialization: Helvetica 05:09:22 INFO - PID 12658 | serialization: Arial 05:12:22 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48987/tests/dromaeo/cssquery-ext.html) 05:12:23 INFO - PID 12658 | RSS: Main: 175521792 05:12:23 INFO - PID 12658 | 05:12:23 INFO - PID 12658 | serialization: Helvetica 05:12:23 INFO - PID 12658 | serialization: Arial 05:15:25 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-ext.html (next: http://localhost:48987/tests/dromaeo/cssquery-jquery.html) 05:15:26 INFO - PID 12658 | RSS: Main: 172851200 05:15:26 INFO - PID 12658 | 05:15:26 INFO - PID 12658 | serialization: Helvetica 05:15:26 INFO - PID 12658 | serialization: Arial 05:18:27 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48987/tests/dromaeo/cssquery-mootools.html) 05:18:28 INFO - PID 12658 | RSS: Main: 174485504 05:18:28 INFO - PID 12658 | 05:18:28 INFO - PID 12658 | serialization: Helvetica 05:18:28 INFO - PID 12658 | serialization: Arial 05:21:30 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48987/tests/dromaeo/cssquery-prototype.html) 05:21:31 INFO - PID 12658 | RSS: Main: 172957696 05:21:31 INFO - PID 12658 | 05:21:31 INFO - PID 12658 | serialization: Helvetica 05:21:31 INFO - PID 12658 | serialization: Arial 05:24:34 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48987/tests/dromaeo/cssquery-yui.html) 05:24:35 INFO - PID 12658 | RSS: Main: 176615424 05:24:35 INFO - PID 12658 | 05:24:35 INFO - PID 12658 | serialization: Helvetica 05:24:35 INFO - PID 12658 | serialization: Arial 05:27:37 INFO - PID 12658 | Cycle 1(1): loaded http://localhost:48987/tests/dromaeo/cssquery-yui.html (next: http://localhost:48987/tests/dromaeo/cssquery-dojo.html) 05:27:37 INFO - PID 12658 | RSS: Main: 177647616 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | __start_tp_report 05:27:37 INFO - PID 12658 | _x_x_mozilla_page_load 05:27:37 INFO - PID 12658 | _x_x_mozilla_page_load_details 05:27:37 INFO - PID 12658 | |i|pagename|runs| 05:27:37 INFO - PID 12658 | |0;dojo.html;3122.1570176052483;3157.652658207598;3167.7149056584904;3190.090824115128;3195.169255993441;6150.8154755357355;6167.074938759189;6213.751449941997;6215.347388524202;6227.252729672446;6179.66011869347;6193.442590166884;6213.378662133784;6229.968850155743;6305.337939516354;5685.204071430003;5790.420957904207;5805.448482394166;5827.970860145693;5835.35811060783;5614.438556144394;5729.341125770548;5742.39704830993;5816.796412125576;5825.359210486864;5589.441055894398;5655.575831812631;5667.866426714632;5691.260136182291;5732.856678583027;5586.106223004341;5597.720113994284;5627.577931655102;5696.572757043197;5716.542676585905;5587.636803607753;5702.2301989231755;5702.372738998707;5763.3948435414095;5766.135079738073;6098.1157732128595;6104.359042300539;6121;6197.845053873644;6218.22272215973;6490.3509649035195;6589.505787065989;6614.437772789319;6644.302348253412;6690.197176338822;6752.561083529555;6768.796936091925;6773.4242589379965;6789.083473731032;6801.795946121575;6193.473554747807;6203.2866220384785;6278.215223097113;6284.685765711742;6302.810915672537;6845.383915447534;6872.896906546406;6903.0680858083515;6979.790606281819;7000.439964802804;6440.677966101676;6496.610203387811;6544.640044797582;6591.176102987127;6612.206535215805;6714.664266786739;6758.42553382968;6763.458923286125;6764.695588698422;6772.255051944282;6616.834579135464;6631.734730610818;6654.334566543307;6733.69698363565;6736.360045795642;6552.967235163794;6686.665666716644;6692.564983276169;6754.493412994045;6783.525153239325;5398.13629819227;5424.891502169935;5435.347758268954;5446.428125046892;5449.346078470529;4640.628749700016;4655.2784318430695;4657.184992626277;4730.952690473051;4753.310769938409;5799.88400231993;5815.592908496449;5846.649201047951;5873.676947767914;5876.500497457764;6644.202695676549;6677.565958212701;6762.69567869447;6765.255821859591;6780.423663988616;5696.344920334214;5779.3642699303045;5798.536117110621;5831.591788574759;5845.590808643354;5841.620294680833;5894.793682221101;5915.260592425947;5929.169916211734;5936.495397891142;6440.098386225932;6494.155759751202;6497.317781632955;6498.415142637091;6526.738930442729;6721.563098398588;6725.9663701681175;6733.3939945405145;6734.124563806869;6748.257691654012;6417;6442.484601231797;6468.126802881551;6487.18910136233;6495.870082598416;6479.287278399466;6526.412622863965;6572.539922205399;6661.966690166518;6671.733130674718;6649.301823308677;6680.699368528525;6701.832454188684;6727.2263689674355;6775.593464392152;6532.804015879531;6541.836454088496;6613.074169616161;6629.46964242869;6644;6361.395667411589;6481.287058423664;6494.967525162533;6570.441512471493;6605.966970165118;6386.297507274103;6423.29343772194;6469.5794773339585;6473.8705225896165;6477.060826180272;6515.02274658805;6526.118973938647;6550.967245163743;6573.638449885302;6587.9670601646685;6367.490600751836;6377.808665740035;6430.710618022106;6440.227172739301;6464.5151613630105 05:27:37 INFO - PID 12658 | |1;ext.html;719.5970256656273;764.6253335865425;780.7501599488163;786.4259090863673;1173.5423184957863;31460.842695786516;32222;42386.57613423865;43214.567854321445;43244.56755432452;43694.56305436945;43881.780591097;43885.78057109718;43888.780556097256;44169.55830441695;7284;7766.883496747553;7818.530888146701;7903.920960790405;7922.881156782653;7728.845423091535;7852.489588176779;7856.450048496607;7861.646225919819;7862;7827.608619568999;7841.451098423084;7894.842103157934;7895.8420831583335;7900.604969751518;7794.259545343183;7820.76537703867;7844.646990885424;7851.4111441641535;7854.489458185229;7546.584937828417;7708.229177082303;7716.6913323467;7720.15078341382;7726.459147859652;38884.611153888385;39167.21665566673;39242;39518.20963580741;39534.80232598819;3505.263894582141;3538.575370955476;3547.8580856765698;3548.254866478043;3554.626764189749;31027.689723102707;31088.844555777076;31157.37685246305;31180.376392472022;31272.843635781675;4561.703489273186;4782.7130372177435;4785.784639691222;4792.113459010095;4830.468648448667;200773;201322;202764;202928;203440.99999999852;47460.5253947463;47752.28371574429;48046.75976620094;48063;48082.27876581854;50389.24416133761;50455.747721261156;50723;50783.49216507861;50791.23813142806;15700.68598628044;15787.842121578868;15934.760978585331;15952.92023539898;15962.521124366056;12037.217580857216;12364.752704945851;13742.381592828347;14030.088044277294;14087.577372678836;14332.49836255726;14334.354954027094;14359.353829077716;14400.279986000658;14572;5915.958994147012;5980.880382392328;6080.179175811298;6083.482903953213;6119.296280927661;984.9556769945369;1017.9491025448698;1027.8817935937464;1028.2442404832443;1056.5034433816095;23257.7674223259;23465;23818.761812382;24127.78352344004;24174.87912560426;1092.63396762084;1123.9269447485888;1124.606387764276;1125.3023125662141;1125.3304283951036;12463.501459941683;12654.87345126537;12687;12711.300878451773;12736.554220602235;236979;237344;238577;238838;239029;53102.468975309755;53407.19889201665;53452.99999999922;53468.19797703037;53665.46334536605;1472.690734945652;1486.2642991718951;1514.681916797463;1517.7351641886335;1519.1037288000132;22687.546249075258;22771.31686049421;22817.31548053561;22822.31533054011;22831.657525137467;38143.80928095342;38148.80925595354;38253.61746382501;38475.230495389376;38512.22975540417;212084;212577;213507;215930;216049;33926;34863.47704784481;37009.259814803016;38644.80677596594;39051.41422878602;46216.30675539802;47420;47730.28404573865;47877.28184077172;48188.277175841686;34832.47751283682;34920.82539587286;34943.475847862814;34967;35241.64758352384;34233.82883085569;34369.82815085909;34544.30911381808;34614.13464663403;34624.65375346315;37819.81090094642;37987.620123798406;38078.428823568225;38150.427743583314;38177.809110954266;32957;33278.5008224872;33551.49672754862;33853.49219761755;34005;24475.510489789747;24488.387790305384;24569.754302456746;24995.375115622253;25477.3630659235 05:27:37 INFO - PID 12658 | |2;jquery.html;586.9618474799138;587.2160665511542;598.6079118177595;601.4016054026245;602.3705228036702;16521.586960325996;22723.886380568114;23574.646380304308;23778.16776412826;23780.762192378093;19656.115474803668;20037;20060.996950152472;22411.822581767203;25823.483530329384;6190.84522886927;6360.395762402564;6360.936390636104;6361.2048493938255;6362;6252.155958945529;6303.810885673437;6346.111544383767;6359.936400635981;6388.361163883597;6115.480184184327;6368.458681012119;6401.295857455676;6415.1981002374705;6415.903761443582;6338.936610633904;6341.8414539636415;6359.300476947532;6362.522810789209;6390.872182556346;5932.822015339547;5963.493103086243;5963.582549221556;5969.910451343233;5973.223480947492;28098.859505702545;28997.13008609745;29401;29625.259368515744;29722.256943576584;1952.6582848001542;2009.9095540700703;2010.58782949495;2013.5268211970176;2013.818756311939;18538.814611853977;19143.042847857552;19242.90378548112;19268.710969335472;19273.4217973461;2323.604987152188;2345.5074434368803;2345.5543446745064;2377.738448770634;2427.9878600606885;122841;130849;138602.30698846543;142272.2886385572;147524.52475475214;14229.275802968887;14753.409863605335;14905.552833414798;15036.473723419627;15226;23339.533209335717;23357.41606459852;23382;23459.178928737412;23460.53078938446;10413.635522756667;10431.21765867563;10507.369557826554;10588.258821882548;10721.142308615292;9676.951615241878;9817.312788104908;9864.802703946025;9866.753331166634;9874.160696340748;9191;9324.766880828034;9345.532723363805;9370.859437108313;9376.765580860532;2810.578413238031;2827.787915906274;2833.617461642693;2844.8293102413922;2933.750631196372;964.1611797735875;990.1732053735212;992.7270000749852;994.8457989011715;1005.6982905128432;18797.54380889187;19488.415347539598;19523.299544220397;19775.703364449546;20090.598188036158;1050.894910508943;1055.3351388625117;1055.767731099157;1065.2197763836382;1067.7971185474735;10913.890861091288;10968.067714244218;11068.944655276833;11081.279716818543;11142.554297827995;476503;488875;494937;497764;506875;114392.42803786094;115458;115729.42135289269;116396;117542;1090.5637744901944;1133.6825688807148;1195.2708847602955;1221.7190046289404;1265.5001274496522;19850.404487865388;19861;19982.30061947825;20033.398998030083;20370.694439583123;54139.72930135324;54311;54729;56095.43904560902;56830.43169568251;68689.65655171892;69771.30228697648;69867.30132698608;69919.25201869995;70861;14347.497837575635;14427.35076921562;14956.476523321631;15099;15115.31981060877;22950.770492294865;23461.88269058712;23598;23751.168709095098;23829.761702383446;18178.545536361697;18620.16209270613;18812.24751009944;18848.151833167816;18889.394401475478;15725.921370393533;16042.598935026717;16270.186490675656;16330.918345408198;17099.974001559945;17413.968723161954;19201.807981920003;19574.8042519573;19580.510487237934;19603.901980490005;14814.703705926036;14867;14876.181810000553;14918.925405372904;14928.10431374121;18108.72836907474;18251.178696958403;18513.81486185121;18540.165692543596;18558 05:27:37 INFO - PID 12658 | |3;mootools.html;1361.2853252042676;1424.9002569820116;1427.0296198584965;1430.8998370114089;1441.2721575604319;13300.866991330084;13695.452181912724;14275.500357487477;14295.928520357396;14314.928425357884;14420.278986050682;14659.853401465982;14661.633459163526;14670.559883203521;14677.045992010511;2761.295869553266;2813.85930703465;2818.1263808219414;2822.2379957411486;2823.237725814029;2617.803664725144;2752.9587056194173;2772.1406364027116;2775.0287399410145;2781.721827817212;2667.6932152802383;2685.9462810743776;2706.2557796605993;2733.0570953021174;2735.261479400561;2668.7731542818883;2693.8114331996767;2701.75684188423;2717.8641067946523;2721.71422000691;2594.3773494361217;2613.8693065346847;2628.4348864993926;2631.0659715800807;2652.7082020977678;13784.517541885985;14117.858821411757;14128.152310861382;14154.433822647185;14160.575182744535;7640.617969101579;7944.721934732314;7952.761417157494;7965.482243654202;7966.163552826928;4894.926576101326;5103.055934652064;5198.532132108091;5204.895902081975;5214.478552144793;1746.8253174682557;1791.6595846789069;1809.972850407245;1844.4097888675628;1850.6483768084022;23693.407664808346;23795.762042379527;23856.045758169654;23918.402039949142;23949.76050239493;6619.271880093186;7117;7139.39315158207;7387.704491820375;7458.0304560407885;16110.355585776671;16262.512124636043;16263.349466021464;16269.105199214157;16281.59296017609;7679.155292917774;7838.764837054898;7839.84320313602;7840.921590784019;7846.568438735811;7195.2444993276;7235.3488186063505;7342.3758980487255;7368.300011498899;7410.333070023724;5153.304303918923;5244;5263.657862239019;5290.444503327095;5332.226827110125;1533.4249656378859;1534.9539513814605;1546.5824227458747;1576.4718819195468;1599.2323684631442;870.851955167623;885.9069797671152;899.869518919766;905.9310014183195;905.968291109808;7332.853342933112;7396.038514993016;7411.110666720028;7427.888581671171;7447.702091916262;688.9311068893071;704.4505285877024;740.7555506682781;742.109468637637;756.9697212111564;5210.21846722987;5257.710825904535;5281;5317.1492561190025;5346.518813306821;18589.628207436046;19068.14193361302;19354.903225483784;19506.609867802563;19609.019549022778;18868.811311886704;18983.240670373307;19595;19708.40874773759;19770.40688779339;11108.055815255631;11109.166812489095;11160.0513956313;11248.775024499628;11304.321740695748;8154.673813047649;8182.7954301142945;8216.34269258446;8219.86084252084;8334.333253339839;17205.876490052906;17501.38745143914;17531;17823.554411139827;17906.28374864991;17134.571635708708;17385;17673.911630441766;17806.46580602532;17871.374501892373;10424.68725938223;10531.789364212826;10540.525676344736;10551.472426378803;10563.471826408495;12756.681082973;12972.416241268977;13004.154729942524;13076.738465230832;13079.346032698137;10305.124064454305;10382.377057376581;10395.532201051123;10408.219383546113;10500.474976251004;10525.684229473129;10607.522661480407;10660.733481663021;10791.460426978776;10822.621208257673;8998.370114092213;9090.863637045317;9114.954425227832;9117.863232051392;9120.361574689974;6941.722331106901;6948.756793512202;7025;7026.1217347831525;7050.858982820212;7097.325754053357;7179;7198.604076775828;7216.71133154689;7326.6702998364135 05:27:37 INFO - PID 12658 | |4;prototype.html;467.0798526902006;481.99277010844844;498.36707381625325;502.30932467856695;506.0663076623628;6084.72618732157;6105.1452796608455;6192.164057852195;6235.532335074865;6341.239051313843;5889.61717488363;5979.970100149504;6072.757089716406;6084;6117.5717699761035;4934.4572097069295;4937.7777999990085;4938.975305123469;4947.455779864212;4972.925406118911;4936.111499930011;4956.1822299320565;4960.801567937278;4972.353594032771;4991.176455884774;4812.831550895719;4895.534924182197;4899.534544218312;4902.65681402302;4932.654714170009;4883.145449546315;4895.926561101604;4909.165441874889;4931.432885218174;4973.229149481836;4342.478902531685;4382.583654552813;4392;4428.601425871655;4439.511653718088;5980.551458640576;6006.249218847644;6022.879542409171;6029.442628849;6061.727222275008;5560.443955604448;5606.6636001840025;5652.321721393418;5655.550114430194;5672.574556908248;6455.7740479083;6491.188601424822;6513;6567.507436942201;6590.604563726144;4776.4268287805335;4795.592374648124;4803.9039219215765;4813.711177329336;4845;6773.06967514256;6823.147106611624;6874.243833178346;6892.448604111659;6923.653817309165;4866.9292755593715;4926.852194434173;4930.630202734809;4931.767058235441;4931.950680493149;4948.282499037619;4955.488575984287;5046.142155833444;5054.292399064134;5060.165072762953;5607.719614019283;5653.632513886584;5669.886602268014;5676.602637815396;5712.257406537124;6464;6466.997615369625;6508.9349106508325;6509.1863517060365;6566.752317059743;1650.1419261983701;1712.2380540659287;1722.3110755697571;1742.8671363613498;1757.8769486135848;1167.4104577188634;1183.721825371037;1230.366361323919;1240.8883200511998;1251.1554700577074;5654.604177707603;5704.572157088235;5727.255456790674;5749.8787736391005;5804.100364443518;6537.823191825517;6575.572587781779;6612;6631.204255489372;6673.599584024974;5746.396628353963;5750.6837123958585;5773.826785196451;5780.797672081541;5786.652800831964;3533.9293214136087;3573.714102871764;3602.4776407420777;3607.9458808117897;3631.727620428426;6440;6463.6768161591735;6468.353164683494;6541.215054193527;6541.738330466823;6731.057651928734;6800.353966373186;6861.931380686229;6907.861842763116;6959.6868140933775;6493.870122597522;6494.350564943468;6502.349765023459;6535.183102112236;6573.3426657333885;6635.734570617315;6696.665166741741;6716.764913228014;6738;6825.726970921306;6636.469082473294;6692.83267918306;6707.966460167668;6727.394534491919;6740.764073257413;6539.444147247537;6543.873241196726;6592.24189218246;6619.602823830585;6636.435902948304;4927.852164435073;4932.901341973212;4938.333325001223;4953.777080031336;4986.426560945392;6715.1941766988275;6761.560498567577;6803.557768745016;6823.658817059028;6851.122528538126;6536.705848236746;6572.244191917991;6630.668466576748;6634.535582509178;6668.3326669332655;6511.804645860631;6553.606783593;6585.20977482686;6598.030886101178;6627.436667883284;6287.71705273273;6461.321561236003;6464.127342808849;6488.221413430419;6522.184726909137;6423.486121110206;6483.222013358427;6571.967140164268;6605.834854128685;6640.701168447335;6275.278342990615;6335.144755458138;6370.55406121567;6394.616323020634;6416.294207637249 05:27:37 INFO - PID 12658 | |5;yui.html;892.8125093730316;919.4896832258096;928.6749637626828;933.561226223675;949.0651708067552;18703;19636.214551417943;19647.60704785905;19696.9015154924;19769.802301976975;21630.3510894673;22359.664605030895;22458.663120053214;22487.77512224877;22523.32430027102;1025.2054657640333;1062.9734256643608;1063.1282348474253;1063.744701271697;1063.8244689626201;1007.0584003956287;1047.7014050995467;1048.3395460859647;1050.422267752733;1050.5220124843179;1106.33066994468;1114.025227925565;1119.3787447966376;1119.7088756923176;1120.199057673763;1112.0491979357694;1112.9054030407426;1116.1238427834191;1116.4417791104488;1117.7317443813508;814.1085511365046;814.2386868278179;814.5519964019766;815.1725998111921;819.3731795176694;19869.20523179071;19974.800251997585;20187.091580878896;20299.79700202994;20339.593208135753;21863.234786782545;22094.447638808997;22243.11027558896;22473.988670509865;22800.31599052031;16191.514254572381;16351.754723679154;16368.836311636851;16484.505464835955;17712.91143544274;3721.79530125843;3725.720570957189;3741.5323084614424;3741.8690345838036;3742.644448777362;117481;120882.39558802238;127369;128688;129013;16666.6666666666;17929.282828686966;18007.639847202983;18105;18204.36284730028;31200.68799312023;31296.53055204174;31411.37177256442;31856;31878.521822172686;7802.882956755653;8253.752387428387;8540.402171848034;9033.864492032624;9357.06429357059;4338.566143385636;4406.20688276107;4432.113577284556;4443.600075993176;4461.486929003141;5240.9475905241225;5320.228566857784;5385.865353366197;5391.676499409969;5406.729663516809;1062.3997441445558;1081.567373050786;1088.7985722641338;1099.5821587796586;1101.5263436722125;643.3566433566433;654.3848782144769;667.4260136282793;672.0658284983876;685.9211190713032;11593.130515211393;12503.74992500145;12931;13018;13022.544210952572;693.0089971341031;698.7554355975368;709.042792230495;715.4348065028569;715.7530651925077;5700.315962084576;5710.514606258432;5735.369109397963;5735.741891614887;5824.3302020267365;106203;107785;108575.45712271388;108889;110119;94534;95264.52367738116;96914;97449;98512.50743746235;82032;82449.17550824535;83292;84810.57594711987;87471;11156.665300041012;11269;11493.82759258595;11519;11590.304581725124;37394.43908341431;38879.6112038876;38887.8333649991;39586.40620390639;39690.40464393094;48503.27245091397;48880.75559622179;48942.51057489379;49073.75463122661;50149.74925125351;15578.221088945735;16070.758938616164;16440.588985274986;16525.66948660996;16557.66884662324;17660.558486037953;18122.184501697193;18395.356162534783;18490.722639160154;18659.81340186581;18942.242310307432;19101;19127.808721912603;19198.13608387598;19248.518787030436;18568.164432600297;18746.343877964206;19457.51356216106;19631.803681962996;19876.801231988073;17953.461396158134;18037.819621803614;18105.185266663295;18298.085095745424;18472.445826625222;13255.403506842407;13823.377947992565;13867.930660347038;14160.716785664436;14244.928775356057;14261.572152835432;14303.64240893986;14343.784843227151;14384.136951782926;14435.855641443452 05:27:37 INFO - PID 12658 | __end_tp_report 05:27:37 INFO - PID 12658 | __start_cc_report 05:27:37 INFO - PID 12658 | _x_x_mozilla_cycle_collect,363 05:27:37 INFO - PID 12658 | __end_cc_report 05:27:37 INFO - PID 12658 | __startTimestamp1502108857563__endTimestamp 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | ------- Summary: start ------- 05:27:37 INFO - PID 12658 | Number of tests: 6 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#0] dojo.html Cycles:165 Average:6162.57 Median:6440.10 stddev:724.52 (11.3%) stddev-sans-first:686.36 05:27:37 INFO - PID 12658 | Values: 3122.2 3157.7 3167.7 3190.1 3195.2 6150.8 6167.1 6213.8 6215.3 6227.3 6179.7 6193.4 6213.4 6230.0 6305.3 5685.2 5790.4 5805.4 5828.0 5835.4 5614.4 5729.3 5742.4 5816.8 5825.4 5589.4 5655.6 5667.9 5691.3 5732.9 5586.1 5597.7 5627.6 5696.6 5716.5 5587.6 5702.2 5702.4 5763.4 5766.1 6098.1 6104.4 6121.0 6197.8 6218.2 6490.4 6589.5 6614.4 6644.3 6690.2 6752.6 6768.8 6773.4 6789.1 6801.8 6193.5 6203.3 6278.2 6284.7 6302.8 6845.4 6872.9 6903.1 6979.8 7000.4 6440.7 6496.6 6544.6 6591.2 6612.2 6714.7 6758.4 6763.5 6764.7 6772.3 6616.8 6631.7 6654.3 6733.7 6736.4 6553.0 6686.7 6692.6 6754.5 6783.5 5398.1 5424.9 5435.3 5446.4 5449.3 4640.6 4655.3 4657.2 4731.0 4753.3 5799.9 5815.6 5846.6 5873.7 5876.5 6644.2 6677.6 6762.7 6765.3 6780.4 5696.3 5779.4 5798.5 5831.6 5845.6 5841.6 5894.8 5915.3 5929.2 5936.5 6440.1 6494.2 6497.3 6498.4 6526.7 6721.6 6726.0 6733.4 6734.1 6748.3 6417.0 6442.5 6468.1 6487.2 6495.9 6479.3 6526.4 6572.5 6662.0 6671.7 6649.3 6680.7 6701.8 6727.2 6775.6 6532.8 6541.8 6613.1 6629.5 6644.0 6361.4 6481.3 6495.0 6570.4 6606.0 6386.3 6423.3 6469.6 6473.9 6477.1 6515.0 6526.1 6551.0 6573.6 6588.0 6367.5 6377.8 6430.7 6440.2 6464.5 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#1] ext.html Cycles:180 Average:39111.26 Median:3543.22 stddev:56667.16 (1599.3%) stddev-sans-first:56752.81 05:27:37 INFO - PID 12658 | Values: 719.6 764.6 780.8 786.4 1173.5 31460.8 32222.0 42386.6 43214.6 43244.6 43694.6 43881.8 43885.8 43888.8 44169.6 7284.0 7766.9 7818.5 7903.9 7922.9 7728.8 7852.5 7856.5 7861.6 7862.0 7827.6 7841.5 7894.8 7895.8 7900.6 7794.3 7820.8 7844.6 7851.4 7854.5 7546.6 7708.2 7716.7 7720.2 7726.5 38884.6 39167.2 39242.0 39518.2 39534.8 3505.3 3538.6 3547.9 3548.3 3554.6 31027.7 31088.8 31157.4 31180.4 31272.8 4561.7 4782.7 4785.8 4792.1 4830.5 200773.0 201322.0 202764.0 202928.0 203441.0 47460.5 47752.3 48046.8 48063.0 48082.3 50389.2 50455.7 50723.0 50783.5 50791.2 15700.7 15787.8 15934.8 15952.9 15962.5 12037.2 12364.8 13742.4 14030.1 14087.6 14332.5 14334.4 14359.4 14400.3 14572.0 5916.0 5980.9 6080.2 6083.5 6119.3 985.0 1017.9 1027.9 1028.2 1056.5 23257.8 23465.0 23818.8 24127.8 24174.9 1092.6 1123.9 1124.6 1125.3 1125.3 12463.5 12654.9 12687.0 12711.3 12736.6 236979.0 237344.0 238577.0 238838.0 239029.0 53102.5 53407.2 53453.0 53468.2 53665.5 1472.7 1486.3 1514.7 1517.7 1519.1 22687.5 22771.3 22817.3 22822.3 22831.7 38143.8 38148.8 38253.6 38475.2 38512.2 212084.0 212577.0 213507.0 215930.0 216049.0 33926.0 34863.5 37009.3 38644.8 39051.4 46216.3 47420.0 47730.3 47877.3 48188.3 34832.5 34920.8 34943.5 34967.0 35241.6 34233.8 34369.8 34544.3 34614.1 34624.7 37819.8 37987.6 38078.4 38150.4 38177.8 32957.0 33278.5 33551.5 33853.5 34005.0 24475.5 24488.4 24569.8 24995.4 25477.4 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#2] jquery.html Cycles:180 Average:34687.92 Median:22567.85 stddev:82986.92 (367.7%) stddev-sans-first:83180.22 05:27:37 INFO - PID 12658 | Values: 587.0 587.2 598.6 601.4 602.4 16521.6 22723.9 23574.6 23778.2 23780.8 19656.1 20037.0 20061.0 22411.8 25823.5 6190.8 6360.4 6360.9 6361.2 6362.0 6252.2 6303.8 6346.1 6359.9 6388.4 6115.5 6368.5 6401.3 6415.2 6415.9 6338.9 6341.8 6359.3 6362.5 6390.9 5932.8 5963.5 5963.6 5969.9 5973.2 28098.9 28997.1 29401.0 29625.3 29722.3 1952.7 2009.9 2010.6 2013.5 2013.8 18538.8 19143.0 19242.9 19268.7 19273.4 2323.6 2345.5 2345.6 2377.7 2428.0 122841.0 130849.0 138602.3 142272.3 147524.5 14229.3 14753.4 14905.6 15036.5 15226.0 23339.5 23357.4 23382.0 23459.2 23460.5 10413.6 10431.2 10507.4 10588.3 10721.1 9677.0 9817.3 9864.8 9866.8 9874.2 9191.0 9324.8 9345.5 9370.9 9376.8 2810.6 2827.8 2833.6 2844.8 2933.8 964.2 990.2 992.7 994.8 1005.7 18797.5 19488.4 19523.3 19775.7 20090.6 1050.9 1055.3 1055.8 1065.2 1067.8 10913.9 10968.1 11068.9 11081.3 11142.6 476503.0 488875.0 494937.0 497764.0 506875.0 114392.4 115458.0 115729.4 116396.0 117542.0 1090.6 1133.7 1195.3 1221.7 1265.5 19850.4 19861.0 19982.3 20033.4 20370.7 54139.7 54311.0 54729.0 56095.4 56830.4 68689.7 69771.3 69867.3 69919.3 70861.0 14347.5 14427.4 14956.5 15099.0 15115.3 22950.8 23461.9 23598.0 23751.2 23829.8 18178.5 18620.2 18812.2 18848.2 18889.4 15725.9 16042.6 16270.2 16330.9 17100.0 17414.0 19201.8 19574.8 19580.5 19603.9 14814.7 14867.0 14876.2 14918.9 14928.1 18108.7 18251.2 18513.8 18540.2 18558.0 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#3] mootools.html Cycles:180 Average:8805.73 Median:2660.20 stddev:6026.25 (226.5%) stddev-sans-first:6017.20 05:27:37 INFO - PID 12658 | Values: 1361.3 1424.9 1427.0 1430.9 1441.3 13300.9 13695.5 14275.5 14295.9 14314.9 14420.3 14659.9 14661.6 14670.6 14677.0 2761.3 2813.9 2818.1 2822.2 2823.2 2617.8 2753.0 2772.1 2775.0 2781.7 2667.7 2685.9 2706.3 2733.1 2735.3 2668.8 2693.8 2701.8 2717.9 2721.7 2594.4 2613.9 2628.4 2631.1 2652.7 13784.5 14117.9 14128.2 14154.4 14160.6 7640.6 7944.7 7952.8 7965.5 7966.2 4894.9 5103.1 5198.5 5204.9 5214.5 1746.8 1791.7 1810.0 1844.4 1850.6 23693.4 23795.8 23856.0 23918.4 23949.8 6619.3 7117.0 7139.4 7387.7 7458.0 16110.4 16262.5 16263.3 16269.1 16281.6 7679.2 7838.8 7839.8 7840.9 7846.6 7195.2 7235.3 7342.4 7368.3 7410.3 5153.3 5244.0 5263.7 5290.4 5332.2 1533.4 1535.0 1546.6 1576.5 1599.2 870.9 885.9 899.9 905.9 906.0 7332.9 7396.0 7411.1 7427.9 7447.7 688.9 704.5 740.8 742.1 757.0 5210.2 5257.7 5281.0 5317.1 5346.5 18589.6 19068.1 19354.9 19506.6 19609.0 18868.8 18983.2 19595.0 19708.4 19770.4 11108.1 11109.2 11160.1 11248.8 11304.3 8154.7 8182.8 8216.3 8219.9 8334.3 17205.9 17501.4 17531.0 17823.6 17906.3 17134.6 17385.0 17673.9 17806.5 17871.4 10424.7 10531.8 10540.5 10551.5 10563.5 12756.7 12972.4 13004.2 13076.7 13079.3 10305.1 10382.4 10395.5 10408.2 10500.5 10525.7 10607.5 10660.7 10791.5 10822.6 8998.4 9090.9 9115.0 9117.9 9120.4 6941.7 6948.8 7025.0 7026.1 7050.9 7097.3 7179.0 7198.6 7216.7 7326.7 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#4] prototype.html Cycles:180 Average:5486.89 Median:6045.58 stddev:1553.75 (25.7%) stddev-sans-first:1511.74 05:27:37 INFO - PID 12658 | Values: 467.1 482.0 498.4 502.3 506.1 6084.7 6105.1 6192.2 6235.5 6341.2 5889.6 5980.0 6072.8 6084.0 6117.6 4934.5 4937.8 4939.0 4947.5 4972.9 4936.1 4956.2 4960.8 4972.4 4991.2 4812.8 4895.5 4899.5 4902.7 4932.7 4883.1 4895.9 4909.2 4931.4 4973.2 4342.5 4382.6 4392.0 4428.6 4439.5 5980.6 6006.2 6022.9 6029.4 6061.7 5560.4 5606.7 5652.3 5655.6 5672.6 6455.8 6491.2 6513.0 6567.5 6590.6 4776.4 4795.6 4803.9 4813.7 4845.0 6773.1 6823.1 6874.2 6892.4 6923.7 4866.9 4926.9 4930.6 4931.8 4932.0 4948.3 4955.5 5046.1 5054.3 5060.2 5607.7 5653.6 5669.9 5676.6 5712.3 6464.0 6467.0 6508.9 6509.2 6566.8 1650.1 1712.2 1722.3 1742.9 1757.9 1167.4 1183.7 1230.4 1240.9 1251.2 5654.6 5704.6 5727.3 5749.9 5804.1 6537.8 6575.6 6612.0 6631.2 6673.6 5746.4 5750.7 5773.8 5780.8 5786.7 3533.9 3573.7 3602.5 3607.9 3631.7 6440.0 6463.7 6468.4 6541.2 6541.7 6731.1 6800.4 6861.9 6907.9 6959.7 6493.9 6494.4 6502.3 6535.2 6573.3 6635.7 6696.7 6716.8 6738.0 6825.7 6636.5 6692.8 6708.0 6727.4 6740.8 6539.4 6543.9 6592.2 6619.6 6636.4 4927.9 4932.9 4938.3 4953.8 4986.4 6715.2 6761.6 6803.6 6823.7 6851.1 6536.7 6572.2 6630.7 6634.5 6668.3 6511.8 6553.6 6585.2 6598.0 6627.4 6287.7 6461.3 6464.1 6488.2 6522.2 6423.5 6483.2 6572.0 6605.8 6640.7 6275.3 6335.1 6370.6 6394.6 6416.3 05:27:37 INFO - PID 12658 | 05:27:37 INFO - PID 12658 | [#5] yui.html Cycles:180 Average:23092.86 Median:19641.91 stddev:30957.15 (157.6%) stddev-sans-first:30999.11 05:27:37 INFO - PID 12658 | Values: 892.8 919.5 928.7 933.6 949.1 18703.0 19636.2 19647.6 19696.9 19769.8 21630.4 22359.7 22458.7 22487.8 22523.3 1025.2 1063.0 1063.1 1063.7 1063.8 1007.1 1047.7 1048.3 1050.4 1050.5 1106.3 1114.0 1119.4 1119.7 1120.2 1112.0 1112.9 1116.1 1116.4 1117.7 814.1 814.2 814.6 815.2 819.4 19869.2 19974.8 20187.1 20299.8 20339.6 21863.2 22094.4 22243.1 22474.0 22800.3 16191.5 16351.8 16368.8 16484.5 17712.9 3721.8 3725.7 3741.5 3741.9 3742.6 117481.0 120882.4 127369.0 128688.0 129013.0 16666.7 17929.3 18007.6 18105.0 18204.4 31200.7 31296.5 31411.4 31856.0 31878.5 7802.9 8253.8 8540.4 9033.9 9357.1 4338.6 4406.2 4432.1 4443.6 4461.5 5240.9 5320.2 5385.9 5391.7 5406.7 1062.4 1081.6 1088.8 1099.6 1101.5 643.4 654.4 667.4 672.1 685.9 11593.1 12503.7 12931.0 13018.0 13022.5 693.0 698.8 709.0 715.4 715.8 5700.3 5710.5 5735.4 5735.7 5824.3 106203.0 107785.0 108575.5 108889.0 110119.0 94534.0 95264.5 96914.0 97449.0 98512.5 82032.0 82449.2 83292.0 84810.6 87471.0 11156.7 11269.0 11493.8 11519.0 11590.3 37394.4 38879.6 38887.8 39586.4 39690.4 48503.3 48880.8 48942.5 49073.8 50149.7 15578.2 16070.8 16440.6 16525.7 16557.7 17660.6 18122.2 18395.4 18490.7 18659.8 18942.2 19101.0 19127.8 19198.1 19248.5 18568.2 18746.3 19457.5 19631.8 19876.8 17953.5 18037.8 18105.2 18298.1 18472.4 13255.4 13823.4 13867.9 14160.7 14244.9 14261.6 14303.6 14343.8 14384.1 14435.9 05:27:37 INFO - PID 12658 | -------- Summary: end -------- 05:27:37 INFO - PID 12658 | 05:27:38 INFO - TEST-INFO | 12658: exit 0 05:27:38 INFO - TEST-OK | dromaeo_css | took 1112908ms 05:27:38 INFO - TEST-START | kraken 05:27:38 INFO - Initialising browser for kraken test... 05:27:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48987/getInfo.html -profile /tmp/tmpFL51Nc/profile 05:27:38 INFO - TEST-INFO | started process 13031 (/builds/slave/test/build/application/firefox/firefox http://localhost:48987/getInfo.html) 05:27:44 INFO - TEST-INFO | 13031: exit 0 05:27:44 INFO - Browser initialized. 05:27:44 INFO - Running cycle 1/1 for kraken test... 05:27:44 INFO - TEST-INFO | started process 13255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFL51Nc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:27:45 INFO - PID 13255 | 05:27:45 INFO - PID 13255 | (/builds/slave/test/build/application/firefox/firefox:13309): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:27:45 INFO - PID 13255 | 05:27:55 INFO - PID 13255 | RSS: Main: 173461504 05:27:55 INFO - PID 13255 | 05:27:55 INFO - PID 13255 | serialization: Helvetica 05:27:55 INFO - PID 13255 | serialization: Arial 05:27:58 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection) 05:27:59 INFO - PID 13255 | RSS: Main: 177709056 05:27:59 INFO - PID 13255 | 05:27:59 INFO - PID 13255 | serialization: Helvetica 05:27:59 INFO - PID 13255 | serialization: Arial 05:28:01 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-dft) 05:28:02 INFO - PID 13255 | RSS: Main: 178278400 05:28:02 INFO - PID 13255 | 05:28:02 INFO - PID 13255 | serialization: Helvetica 05:28:02 INFO - PID 13255 | serialization: Arial 05:28:05 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-fft) 05:28:06 INFO - PID 13255 | RSS: Main: 173326336 05:28:06 INFO - PID 13255 | 05:28:06 INFO - PID 13255 | serialization: Helvetica 05:28:06 INFO - PID 13255 | serialization: Arial 05:28:08 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator) 05:28:09 INFO - PID 13255 | RSS: Main: 174252032 05:28:09 INFO - PID 13255 | 05:28:09 INFO - PID 13255 | serialization: Helvetica 05:28:09 INFO - PID 13255 | serialization: Arial 05:28:11 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:11 INFO - PID 13255 | RSS: Main: 174440448 05:28:11 INFO - PID 13255 | 05:28:11 INFO - PID 13255 | serialization: Helvetica 05:28:11 INFO - PID 13255 | serialization: Arial 05:28:15 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:15 INFO - PID 13255 | RSS: Main: 177049600 05:28:15 INFO - PID 13255 | 05:28:15 INFO - PID 13255 | serialization: Helvetica 05:28:15 INFO - PID 13255 | serialization: Arial 05:28:19 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:19 INFO - PID 13255 | RSS: Main: 175976448 05:28:19 INFO - PID 13255 | 05:28:19 INFO - PID 13255 | serialization: Helvetica 05:28:19 INFO - PID 13255 | serialization: Arial 05:28:22 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial) 05:28:23 INFO - PID 13255 | RSS: Main: 176697344 05:28:23 INFO - PID 13255 | 05:28:23 INFO - PID 13255 | serialization: Helvetica 05:28:23 INFO - PID 13255 | serialization: Arial 05:28:25 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:25 INFO - PID 13255 | RSS: Main: 176898048 05:28:25 INFO - PID 13255 | 05:28:25 INFO - PID 13255 | serialization: Helvetica 05:28:25 INFO - PID 13255 | serialization: Arial 05:28:27 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:28 INFO - PID 13255 | RSS: Main: 174157824 05:28:28 INFO - PID 13255 | 05:28:28 INFO - PID 13255 | serialization: Helvetica 05:28:28 INFO - PID 13255 | serialization: Arial 05:28:30 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:28:31 INFO - PID 13255 | RSS: Main: 174436352 05:28:31 INFO - PID 13255 | 05:28:31 INFO - PID 13255 | serialization: Helvetica 05:28:31 INFO - PID 13255 | serialization: Arial 05:28:33 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:28:34 INFO - PID 13255 | RSS: Main: 174510080 05:28:34 INFO - PID 13255 | 05:28:34 INFO - PID 13255 | serialization: Helvetica 05:28:34 INFO - PID 13255 | serialization: Arial 05:28:37 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:28:38 INFO - PID 13255 | RSS: Main: 174571520 05:28:38 INFO - PID 13255 | 05:28:38 INFO - PID 13255 | serialization: Helvetica 05:28:38 INFO - PID 13255 | serialization: Arial 05:28:40 INFO - PID 13255 | Cycle 1(1): loaded http://localhost:48987/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48987/tests/kraken/driver.html?testName=ai-astar) 05:28:40 INFO - PID 13255 | RSS: Main: 175988736 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | __start_tp_report 05:28:40 INFO - PID 13255 | _x_x_mozilla_page_load 05:28:40 INFO - PID 13255 | _x_x_mozilla_page_load_details 05:28:40 INFO - PID 13255 | |i|pagename|runs| 05:28:40 INFO - PID 13255 | |0;ai-astar;97;108;101;110;109;113;114;99;109;108 05:28:40 INFO - PID 13255 | |1;audio-beat-detection;142;117;146;182;118;158;157;127;176;120 05:28:40 INFO - PID 13255 | |2;audio-dft;162;165;165;164;164;170;167;167;162;168 05:28:40 INFO - PID 13255 | |3;audio-fft;82;75;84;175;80;81;74;87;103;76 05:28:40 INFO - PID 13255 | |4;audio-oscillator;78;78;142;82;79;82;138;83;84;128 05:28:40 INFO - PID 13255 | |5;imaging-gaussian-blur;114;118;117;113;114;114;114;117;114;114 05:28:40 INFO - PID 13255 | |6;imaging-darkroom;151;152;156;151;151;152;152;152;154;151 05:28:40 INFO - PID 13255 | |7;imaging-desaturate;96;95;95;94;93;94;94;94;93;102 05:28:40 INFO - PID 13255 | |8;json-parse-financial;60;57;55;55;55;61;54;53;54;62 05:28:40 INFO - PID 13255 | |9;json-stringify-tinderbox;56;57;55;55;55;55;55;55;60;65 05:28:40 INFO - PID 13255 | |10;stanford-crypto-aes;88;91;81;87;88;79;79;84;77;78 05:28:40 INFO - PID 13255 | |11;stanford-crypto-ccm;129;136;135;128;122;139;134;138;126;164 05:28:40 INFO - PID 13255 | |12;stanford-crypto-pbkdf2;172;179;173;183;183;171;174;174;183;171 05:28:40 INFO - PID 13255 | |13;stanford-crypto-sha256-iterative;67;64;64;66;69;65;73;68;66;70 05:28:40 INFO - PID 13255 | __end_tp_report 05:28:40 INFO - PID 13255 | __start_cc_report 05:28:40 INFO - PID 13255 | _x_x_mozilla_cycle_collect,979 05:28:40 INFO - PID 13255 | __end_cc_report 05:28:40 INFO - PID 13255 | __startTimestamp1502108920448__endTimestamp 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | ------- Summary: start ------- 05:28:40 INFO - PID 13255 | Number of tests: 14 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#0] ai-astar Cycles:10 Average:106.80 Median:111.50 stddev:5.81 (5.2%) stddev-sans-first:4.96 05:28:40 INFO - PID 13255 | Values: 97.0 108.0 101.0 110.0 109.0 113.0 114.0 99.0 109.0 108.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:151.50 stddev:23.83 (15.7%) stddev-sans-first:25.26 05:28:40 INFO - PID 13255 | Values: 142.0 117.0 146.0 182.0 118.0 158.0 157.0 127.0 176.0 120.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#2] audio-dft Cycles:10 Average:165.40 Median:166.00 stddev:2.59 (1.6%) stddev-sans-first:2.44 05:28:40 INFO - PID 13255 | Values: 162.0 165.0 165.0 164.0 164.0 170.0 167.0 167.0 162.0 168.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#3] audio-fft Cycles:10 Average:91.70 Median:80.50 stddev:30.43 (37.8%) stddev-sans-first:32.07 05:28:40 INFO - PID 13255 | Values: 82.0 75.0 84.0 175.0 80.0 81.0 74.0 87.0 103.0 76.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:80.50 stddev:26.93 (33.5%) stddev-sans-first:27.63 05:28:40 INFO - PID 13255 | Values: 78.0 78.0 142.0 82.0 79.0 82.0 138.0 83.0 84.0 128.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:1.73 (1.5%) stddev-sans-first:1.80 05:28:40 INFO - PID 13255 | Values: 114.0 118.0 117.0 113.0 114.0 114.0 114.0 117.0 114.0 114.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.00 stddev:1.62 (1.1%) stddev-sans-first:1.66 05:28:40 INFO - PID 13255 | Values: 151.0 152.0 156.0 151.0 151.0 152.0 152.0 152.0 154.0 151.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.62 (2.8%) stddev-sans-first:2.76 05:28:40 INFO - PID 13255 | Values: 96.0 95.0 95.0 94.0 93.0 94.0 94.0 94.0 93.0 102.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.24 (5.8%) stddev-sans-first:3.19 05:28:40 INFO - PID 13255 | Values: 60.0 57.0 55.0 55.0 55.0 61.0 54.0 53.0 54.0 62.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:55.50 stddev:3.29 (5.9%) stddev-sans-first:3.48 05:28:40 INFO - PID 13255 | Values: 56.0 57.0 55.0 55.0 55.0 55.0 55.0 55.0 60.0 65.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:85.50 stddev:5.03 (5.9%) stddev-sans-first:5.02 05:28:40 INFO - PID 13255 | Values: 88.0 91.0 81.0 87.0 88.0 79.0 79.0 84.0 77.0 78.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:135.50 stddev:11.56 (8.5%) stddev-sans-first:12.05 05:28:40 INFO - PID 13255 | Values: 129.0 136.0 135.0 128.0 122.0 139.0 134.0 138.0 126.0 164.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.50 stddev:5.14 (2.9%) stddev-sans-first:5.21 05:28:40 INFO - PID 13255 | Values: 172.0 179.0 173.0 183.0 183.0 171.0 174.0 174.0 183.0 171.0 05:28:40 INFO - PID 13255 | 05:28:40 INFO - PID 13255 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:2.86 (4.2%) stddev-sans-first:3.03 05:28:40 INFO - PID 13255 | Values: 67.0 64.0 64.0 66.0 69.0 65.0 73.0 68.0 66.0 70.0 05:28:40 INFO - PID 13255 | -------- Summary: end -------- 05:28:40 INFO - PID 13255 | 05:28:41 INFO - PID 13255 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:28:41 INFO - TEST-INFO | 13255: exit 0 05:28:41 INFO - TEST-OK | kraken | took 63086ms 05:28:41 INFO - SUITE-END | took 1175s 05:28:41 INFO - Completed test suite (00:19:36) 05:28:41 INFO - javascript benchmark 05:28:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8507.6641267963, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.1570176052483, 3157.652658207598, 3167.7149056584904, 3190.090824115128, 3195.169255993441, 6150.8154755357355, 6167.074938759189, 6213.751449941997, 6215.347388524202, 6227.252729672446, 6179.66011869347, 6193.442590166884, 6213.378662133784, 6229.968850155743, 6305.337939516354, 5685.204071430003, 5790.420957904207, 5805.448482394166, 5827.970860145693, 5835.35811060783, 5614.438556144394, 5729.341125770548, 5742.39704830993, 5816.796412125576, 5825.359210486864, 5589.441055894398, 5655.575831812631, 5667.866426714632, 5691.260136182291, 5732.856678583027, 5586.106223004341, 5597.720113994284, 5627.577931655102, 5696.572757043197, 5716.542676585905, 5587.636803607753, 5702.2301989231755, 5702.372738998707, 5763.3948435414095, 5766.135079738073, 6098.1157732128595, 6104.359042300539, 6121.0, 6197.845053873644, 6218.22272215973, 6490.3509649035195, 6589.505787065989, 6614.437772789319, 6644.302348253412, 6690.197176338822, 6752.561083529555, 6768.796936091925, 6773.4242589379965, 6789.083473731032, 6801.795946121575, 6193.473554747807, 6203.2866220384785, 6278.215223097113, 6284.685765711742, 6302.810915672537, 6845.383915447534, 6872.896906546406, 6903.0680858083515, 6979.790606281819, 7000.439964802804, 6440.677966101676, 6496.610203387811, 6544.640044797582, 6591.176102987127, 6612.206535215805, 6714.664266786739, 6758.42553382968, 6763.458923286125, 6764.695588698422, 6772.255051944282, 6616.834579135464, 6631.734730610818, 6654.334566543307, 6733.69698363565, 6736.360045795642, 6552.967235163794, 6686.665666716644, 6692.564983276169, 6754.493412994045, 6783.525153239325, 5398.13629819227, 5424.891502169935, 5435.347758268954, 5446.428125046892, 5449.346078470529, 4640.628749700016, 4655.2784318430695, 4657.184992626277, 4730.952690473051, 4753.310769938409, 5799.88400231993, 5815.592908496449, 5846.649201047951, 5873.676947767914, 5876.500497457764, 6644.202695676549, 6677.565958212701, 6762.69567869447, 6765.255821859591, 6780.423663988616, 5696.344920334214, 5779.3642699303045, 5798.536117110621, 5831.591788574759, 5845.590808643354, 5841.620294680833, 5894.793682221101, 5915.260592425947, 5929.169916211734, 5936.495397891142, 6440.098386225932, 6494.155759751202, 6497.317781632955, 6498.415142637091, 6526.738930442729, 6721.563098398588, 6725.9663701681175, 6733.3939945405145, 6734.124563806869, 6748.257691654012, 6417.0, 6442.484601231797, 6468.126802881551, 6487.18910136233, 6495.870082598416, 6479.287278399466, 6526.412622863965, 6572.539922205399, 6661.966690166518, 6671.733130674718, 6649.301823308677, 6680.699368528525, 6701.832454188684, 6727.2263689674355, 6775.593464392152, 6532.804015879531, 6541.836454088496, 6613.074169616161, 6629.46964242869, 6644.0, 6361.395667411589, 6481.287058423664, 6494.967525162533, 6570.441512471493, 6605.966970165118, 6386.297507274103, 6423.29343772194, 6469.5794773339585, 6473.8705225896165, 6477.060826180272, 6515.02274658805, 6526.118973938647, 6550.967245163743, 6573.638449885302, 6587.9670601646685, 6367.490600751836, 6377.808665740035, 6430.710618022106, 6440.227172739301, 6464.5151613630105], "value": 6108.423485503431, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.5970256656273, 764.6253335865425, 780.7501599488163, 786.4259090863673, 1173.5423184957863, 31460.842695786516, 32222.0, 42386.57613423865, 43214.567854321445, 43244.56755432452, 43694.56305436945, 43881.780591097, 43885.78057109718, 43888.780556097256, 44169.55830441695, 7284.0, 7766.883496747553, 7818.530888146701, 7903.920960790405, 7922.881156782653, 7728.845423091535, 7852.489588176779, 7856.450048496607, 7861.646225919819, 7862.0, 7827.608619568999, 7841.451098423084, 7894.842103157934, 7895.8420831583335, 7900.604969751518, 7794.259545343183, 7820.76537703867, 7844.646990885424, 7851.4111441641535, 7854.489458185229, 7546.584937828417, 7708.229177082303, 7716.6913323467, 7720.15078341382, 7726.459147859652, 38884.611153888385, 39167.21665566673, 39242.0, 39518.20963580741, 39534.80232598819, 3505.263894582141, 3538.575370955476, 3547.8580856765698, 3548.254866478043, 3554.626764189749, 31027.689723102707, 31088.844555777076, 31157.37685246305, 31180.376392472022, 31272.843635781675, 4561.703489273186, 4782.7130372177435, 4785.784639691222, 4792.113459010095, 4830.468648448667, 200773.0, 201322.0, 202764.0, 202928.0, 203440.99999999852, 47460.5253947463, 47752.28371574429, 48046.75976620094, 48063.0, 48082.27876581854, 50389.24416133761, 50455.747721261156, 50723.0, 50783.49216507861, 50791.23813142806, 15700.68598628044, 15787.842121578868, 15934.760978585331, 15952.92023539898, 15962.521124366056, 12037.217580857216, 12364.752704945851, 13742.381592828347, 14030.088044277294, 14087.577372678836, 14332.49836255726, 14334.354954027094, 14359.353829077716, 14400.279986000658, 14572.0, 5915.958994147012, 5980.880382392328, 6080.179175811298, 6083.482903953213, 6119.296280927661, 984.9556769945369, 1017.9491025448698, 1027.8817935937464, 1028.2442404832443, 1056.5034433816095, 23257.7674223259, 23465.0, 23818.761812382, 24127.78352344004, 24174.87912560426, 1092.63396762084, 1123.9269447485888, 1124.606387764276, 1125.3023125662141, 1125.3304283951036, 12463.501459941683, 12654.87345126537, 12687.0, 12711.300878451773, 12736.554220602235, 236979.0, 237344.0, 238577.0, 238838.0, 239029.0, 53102.468975309755, 53407.19889201665, 53452.99999999922, 53468.19797703037, 53665.46334536605, 1472.690734945652, 1486.2642991718951, 1514.681916797463, 1517.7351641886335, 1519.1037288000132, 22687.546249075258, 22771.31686049421, 22817.31548053561, 22822.31533054011, 22831.657525137467, 38143.80928095342, 38148.80925595354, 38253.61746382501, 38475.230495389376, 38512.22975540417, 212084.0, 212577.0, 213507.0, 215930.0, 216049.0, 33926.0, 34863.47704784481, 37009.259814803016, 38644.80677596594, 39051.41422878602, 46216.30675539802, 47420.0, 47730.28404573865, 47877.28184077172, 48188.277175841686, 34832.47751283682, 34920.82539587286, 34943.475847862814, 34967.0, 35241.64758352384, 34233.82883085569, 34369.82815085909, 34544.30911381808, 34614.13464663403, 34624.65375346315, 37819.81090094642, 37987.620123798406, 38078.428823568225, 38150.427743583314, 38177.809110954266, 32957.0, 33278.5008224872, 33551.49672754862, 33853.49219761755, 34005.0, 24475.510489789747, 24488.387790305384, 24569.754302456746, 24995.375115622253, 25477.3630659235], "value": 17547.94716687168, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.9618474799138, 587.2160665511542, 598.6079118177595, 601.4016054026245, 602.3705228036702, 16521.586960325996, 22723.886380568114, 23574.646380304308, 23778.16776412826, 23780.762192378093, 19656.115474803668, 20037.0, 20060.996950152472, 22411.822581767203, 25823.483530329384, 6190.84522886927, 6360.395762402564, 6360.936390636104, 6361.2048493938255, 6362.0, 6252.155958945529, 6303.810885673437, 6346.111544383767, 6359.936400635981, 6388.361163883597, 6115.480184184327, 6368.458681012119, 6401.295857455676, 6415.1981002374705, 6415.903761443582, 6338.936610633904, 6341.8414539636415, 6359.300476947532, 6362.522810789209, 6390.872182556346, 5932.822015339547, 5963.493103086243, 5963.582549221556, 5969.910451343233, 5973.223480947492, 28098.859505702545, 28997.13008609745, 29401.0, 29625.259368515744, 29722.256943576584, 1952.6582848001542, 2009.9095540700703, 2010.58782949495, 2013.5268211970176, 2013.818756311939, 18538.814611853977, 19143.042847857552, 19242.90378548112, 19268.710969335472, 19273.4217973461, 2323.604987152188, 2345.5074434368803, 2345.5543446745064, 2377.738448770634, 2427.9878600606885, 122841.0, 130849.0, 138602.30698846543, 142272.2886385572, 147524.52475475214, 14229.275802968887, 14753.409863605335, 14905.552833414798, 15036.473723419627, 15226.0, 23339.533209335717, 23357.41606459852, 23382.0, 23459.178928737412, 23460.53078938446, 10413.635522756667, 10431.21765867563, 10507.369557826554, 10588.258821882548, 10721.142308615292, 9676.951615241878, 9817.312788104908, 9864.802703946025, 9866.753331166634, 9874.160696340748, 9191.0, 9324.766880828034, 9345.532723363805, 9370.859437108313, 9376.765580860532, 2810.578413238031, 2827.787915906274, 2833.617461642693, 2844.8293102413922, 2933.750631196372, 964.1611797735875, 990.1732053735212, 992.7270000749852, 994.8457989011715, 1005.6982905128432, 18797.54380889187, 19488.415347539598, 19523.299544220397, 19775.703364449546, 20090.598188036158, 1050.894910508943, 1055.3351388625117, 1055.767731099157, 1065.2197763836382, 1067.7971185474735, 10913.890861091288, 10968.067714244218, 11068.944655276833, 11081.279716818543, 11142.554297827995, 476503.0, 488875.0, 494937.0, 497764.0, 506875.0, 114392.42803786094, 115458.0, 115729.42135289269, 116396.0, 117542.0, 1090.5637744901944, 1133.6825688807148, 1195.2708847602955, 1221.7190046289404, 1265.5001274496522, 19850.404487865388, 19861.0, 19982.30061947825, 20033.398998030083, 20370.694439583123, 54139.72930135324, 54311.0, 54729.0, 56095.43904560902, 56830.43169568251, 68689.65655171892, 69771.30228697648, 69867.30132698608, 69919.25201869995, 70861.0, 14347.497837575635, 14427.35076921562, 14956.476523321631, 15099.0, 15115.31981060877, 22950.770492294865, 23461.88269058712, 23598.0, 23751.168709095098, 23829.761702383446, 18178.545536361697, 18620.16209270613, 18812.24751009944, 18848.151833167816, 18889.394401475478, 15725.921370393533, 16042.598935026717, 16270.186490675656, 16330.918345408198, 17099.974001559945, 17413.968723161954, 19201.807981920003, 19574.8042519573, 19580.510487237934, 19603.901980490005, 14814.703705926036, 14867.0, 14876.181810000553, 14918.925405372904, 14928.10431374121, 18108.72836907474, 18251.178696958403, 18513.81486185121, 18540.165692543596, 18558.0], "value": 11950.985096324745, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.2853252042676, 1424.9002569820116, 1427.0296198584965, 1430.8998370114089, 1441.2721575604319, 13300.866991330084, 13695.452181912724, 14275.500357487477, 14295.928520357396, 14314.928425357884, 14420.278986050682, 14659.853401465982, 14661.633459163526, 14670.559883203521, 14677.045992010511, 2761.295869553266, 2813.85930703465, 2818.1263808219414, 2822.2379957411486, 2823.237725814029, 2617.803664725144, 2752.9587056194173, 2772.1406364027116, 2775.0287399410145, 2781.721827817212, 2667.6932152802383, 2685.9462810743776, 2706.2557796605993, 2733.0570953021174, 2735.261479400561, 2668.7731542818883, 2693.8114331996767, 2701.75684188423, 2717.8641067946523, 2721.71422000691, 2594.3773494361217, 2613.8693065346847, 2628.4348864993926, 2631.0659715800807, 2652.7082020977678, 13784.517541885985, 14117.858821411757, 14128.152310861382, 14154.433822647185, 14160.575182744535, 7640.617969101579, 7944.721934732314, 7952.761417157494, 7965.482243654202, 7966.163552826928, 4894.926576101326, 5103.055934652064, 5198.532132108091, 5204.895902081975, 5214.478552144793, 1746.8253174682557, 1791.6595846789069, 1809.972850407245, 1844.4097888675628, 1850.6483768084022, 23693.407664808346, 23795.762042379527, 23856.045758169654, 23918.402039949142, 23949.76050239493, 6619.271880093186, 7117.0, 7139.39315158207, 7387.704491820375, 7458.0304560407885, 16110.355585776671, 16262.512124636043, 16263.349466021464, 16269.105199214157, 16281.59296017609, 7679.155292917774, 7838.764837054898, 7839.84320313602, 7840.921590784019, 7846.568438735811, 7195.2444993276, 7235.3488186063505, 7342.3758980487255, 7368.300011498899, 7410.333070023724, 5153.304303918923, 5244.0, 5263.657862239019, 5290.444503327095, 5332.226827110125, 1533.4249656378859, 1534.9539513814605, 1546.5824227458747, 1576.4718819195468, 1599.2323684631442, 870.851955167623, 885.9069797671152, 899.869518919766, 905.9310014183195, 905.968291109808, 7332.853342933112, 7396.038514993016, 7411.110666720028, 7427.888581671171, 7447.702091916262, 688.9311068893071, 704.4505285877024, 740.7555506682781, 742.109468637637, 756.9697212111564, 5210.21846722987, 5257.710825904535, 5281.0, 5317.1492561190025, 5346.518813306821, 18589.628207436046, 19068.14193361302, 19354.903225483784, 19506.609867802563, 19609.019549022778, 18868.811311886704, 18983.240670373307, 19595.0, 19708.40874773759, 19770.40688779339, 11108.055815255631, 11109.166812489095, 11160.0513956313, 11248.775024499628, 11304.321740695748, 8154.673813047649, 8182.7954301142945, 8216.34269258446, 8219.86084252084, 8334.333253339839, 17205.876490052906, 17501.38745143914, 17531.0, 17823.554411139827, 17906.28374864991, 17134.571635708708, 17385.0, 17673.911630441766, 17806.46580602532, 17871.374501892373, 10424.68725938223, 10531.789364212826, 10540.525676344736, 10551.472426378803, 10563.471826408495, 12756.681082973, 12972.416241268977, 13004.154729942524, 13076.738465230832, 13079.346032698137, 10305.124064454305, 10382.377057376581, 10395.532201051123, 10408.219383546113, 10500.474976251004, 10525.684229473129, 10607.522661480407, 10660.733481663021, 10791.460426978776, 10822.621208257673, 8998.370114092213, 9090.863637045317, 9114.954425227832, 9117.863232051392, 9120.361574689974, 6941.722331106901, 6948.756793512202, 7025.0, 7026.1217347831525, 7050.858982820212, 7097.325754053357, 7179.0, 7198.604076775828, 7216.71133154689, 7326.6702998364135], "value": 6402.292358974895, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.0798526902006, 481.99277010844844, 498.36707381625325, 502.30932467856695, 506.0663076623628, 6084.72618732157, 6105.1452796608455, 6192.164057852195, 6235.532335074865, 6341.239051313843, 5889.61717488363, 5979.970100149504, 6072.757089716406, 6084.0, 6117.5717699761035, 4934.4572097069295, 4937.7777999990085, 4938.975305123469, 4947.455779864212, 4972.925406118911, 4936.111499930011, 4956.1822299320565, 4960.801567937278, 4972.353594032771, 4991.176455884774, 4812.831550895719, 4895.534924182197, 4899.534544218312, 4902.65681402302, 4932.654714170009, 4883.145449546315, 4895.926561101604, 4909.165441874889, 4931.432885218174, 4973.229149481836, 4342.478902531685, 4382.583654552813, 4392.0, 4428.601425871655, 4439.511653718088, 5980.551458640576, 6006.249218847644, 6022.879542409171, 6029.442628849, 6061.727222275008, 5560.443955604448, 5606.6636001840025, 5652.321721393418, 5655.550114430194, 5672.574556908248, 6455.7740479083, 6491.188601424822, 6513.0, 6567.507436942201, 6590.604563726144, 4776.4268287805335, 4795.592374648124, 4803.9039219215765, 4813.711177329336, 4845.0, 6773.06967514256, 6823.147106611624, 6874.243833178346, 6892.448604111659, 6923.653817309165, 4866.9292755593715, 4926.852194434173, 4930.630202734809, 4931.767058235441, 4931.950680493149, 4948.282499037619, 4955.488575984287, 5046.142155833444, 5054.292399064134, 5060.165072762953, 5607.719614019283, 5653.632513886584, 5669.886602268014, 5676.602637815396, 5712.257406537124, 6464.0, 6466.997615369625, 6508.9349106508325, 6509.1863517060365, 6566.752317059743, 1650.1419261983701, 1712.2380540659287, 1722.3110755697571, 1742.8671363613498, 1757.8769486135848, 1167.4104577188634, 1183.721825371037, 1230.366361323919, 1240.8883200511998, 1251.1554700577074, 5654.604177707603, 5704.572157088235, 5727.255456790674, 5749.8787736391005, 5804.100364443518, 6537.823191825517, 6575.572587781779, 6612.0, 6631.204255489372, 6673.599584024974, 5746.396628353963, 5750.6837123958585, 5773.826785196451, 5780.797672081541, 5786.652800831964, 3533.9293214136087, 3573.714102871764, 3602.4776407420777, 3607.9458808117897, 3631.727620428426, 6440.0, 6463.6768161591735, 6468.353164683494, 6541.215054193527, 6541.738330466823, 6731.057651928734, 6800.353966373186, 6861.931380686229, 6907.861842763116, 6959.6868140933775, 6493.870122597522, 6494.350564943468, 6502.349765023459, 6535.183102112236, 6573.3426657333885, 6635.734570617315, 6696.665166741741, 6716.764913228014, 6738.0, 6825.726970921306, 6636.469082473294, 6692.83267918306, 6707.966460167668, 6727.394534491919, 6740.764073257413, 6539.444147247537, 6543.873241196726, 6592.24189218246, 6619.602823830585, 6636.435902948304, 4927.852164435073, 4932.901341973212, 4938.333325001223, 4953.777080031336, 4986.426560945392, 6715.1941766988275, 6761.560498567577, 6803.557768745016, 6823.658817059028, 6851.122528538126, 6536.705848236746, 6572.244191917991, 6630.668466576748, 6634.535582509178, 6668.3326669332655, 6511.804645860631, 6553.606783593, 6585.20977482686, 6598.030886101178, 6627.436667883284, 6287.71705273273, 6461.321561236003, 6464.127342808849, 6488.221413430419, 6522.184726909137, 6423.486121110206, 6483.222013358427, 6571.967140164268, 6605.834854128685, 6640.701168447335, 6275.278342990615, 6335.144755458138, 6370.55406121567, 6394.616323020634, 6416.294207637249], "value": 5024.680626276544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [892.8125093730316, 919.4896832258096, 928.6749637626828, 933.561226223675, 949.0651708067552, 18703.0, 19636.214551417943, 19647.60704785905, 19696.9015154924, 19769.802301976975, 21630.3510894673, 22359.664605030895, 22458.663120053214, 22487.77512224877, 22523.32430027102, 1025.2054657640333, 1062.9734256643608, 1063.1282348474253, 1063.744701271697, 1063.8244689626201, 1007.0584003956287, 1047.7014050995467, 1048.3395460859647, 1050.422267752733, 1050.5220124843179, 1106.33066994468, 1114.025227925565, 1119.3787447966376, 1119.7088756923176, 1120.199057673763, 1112.0491979357694, 1112.9054030407426, 1116.1238427834191, 1116.4417791104488, 1117.7317443813508, 814.1085511365046, 814.2386868278179, 814.5519964019766, 815.1725998111921, 819.3731795176694, 19869.20523179071, 19974.800251997585, 20187.091580878896, 20299.79700202994, 20339.593208135753, 21863.234786782545, 22094.447638808997, 22243.11027558896, 22473.988670509865, 22800.31599052031, 16191.514254572381, 16351.754723679154, 16368.836311636851, 16484.505464835955, 17712.91143544274, 3721.79530125843, 3725.720570957189, 3741.5323084614424, 3741.8690345838036, 3742.644448777362, 117481.0, 120882.39558802238, 127369.0, 128688.0, 129013.0, 16666.6666666666, 17929.282828686966, 18007.639847202983, 18105.0, 18204.36284730028, 31200.68799312023, 31296.53055204174, 31411.37177256442, 31856.0, 31878.521822172686, 7802.882956755653, 8253.752387428387, 8540.402171848034, 9033.864492032624, 9357.06429357059, 4338.566143385636, 4406.20688276107, 4432.113577284556, 4443.600075993176, 4461.486929003141, 5240.9475905241225, 5320.228566857784, 5385.865353366197, 5391.676499409969, 5406.729663516809, 1062.3997441445558, 1081.567373050786, 1088.7985722641338, 1099.5821587796586, 1101.5263436722125, 643.3566433566433, 654.3848782144769, 667.4260136282793, 672.0658284983876, 685.9211190713032, 11593.130515211393, 12503.74992500145, 12931.0, 13018.0, 13022.544210952572, 693.0089971341031, 698.7554355975368, 709.042792230495, 715.4348065028569, 715.7530651925077, 5700.315962084576, 5710.514606258432, 5735.369109397963, 5735.741891614887, 5824.3302020267365, 106203.0, 107785.0, 108575.45712271388, 108889.0, 110119.0, 94534.0, 95264.52367738116, 96914.0, 97449.0, 98512.50743746235, 82032.0, 82449.17550824535, 83292.0, 84810.57594711987, 87471.0, 11156.665300041012, 11269.0, 11493.82759258595, 11519.0, 11590.304581725124, 37394.43908341431, 38879.6112038876, 38887.8333649991, 39586.40620390639, 39690.40464393094, 48503.27245091397, 48880.75559622179, 48942.51057489379, 49073.75463122661, 50149.74925125351, 15578.221088945735, 16070.758938616164, 16440.588985274986, 16525.66948660996, 16557.66884662324, 17660.558486037953, 18122.184501697193, 18395.356162534783, 18490.722639160154, 18659.81340186581, 18942.242310307432, 19101.0, 19127.808721912603, 19198.13608387598, 19248.518787030436, 18568.164432600297, 18746.343877964206, 19457.51356216106, 19631.803681962996, 19876.801231988073, 17953.461396158134, 18037.819621803614, 18105.185266663295, 18298.085095745424, 18472.445826625222, 13255.403506842407, 13823.377947992565, 13867.930660347038, 14160.716785664436, 14244.928775356057, 14261.572152835432, 14303.64240893986, 14343.784843227151, 14384.136951782926, 14435.855641443452], "value": 9200.92578375907, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 101.0, 110.0, 109.0, 113.0, 114.0, 99.0, 109.0, 108.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 117.0, 146.0, 182.0, 118.0, 158.0, 157.0, 127.0, 176.0, 120.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 165.0, 164.0, 164.0, 170.0, 167.0, 167.0, 162.0, 168.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 75.0, 84.0, 175.0, 80.0, 81.0, 74.0, 87.0, 103.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 142.0, 82.0, 79.0, 82.0, 138.0, 83.0, 84.0, 128.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 113.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 156.0, 151.0, 151.0, 152.0, 152.0, 152.0, 154.0, 151.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 102.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 57.0, 55.0, 55.0, 55.0, 61.0, 54.0, 53.0, 54.0, 62.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 60.0, 65.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 91.0, 81.0, 87.0, 88.0, 79.0, 79.0, 84.0, 77.0, 78.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 135.0, 128.0, 122.0, 139.0, 134.0, 138.0, 126.0, 164.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 173.0, 183.0, 183.0, 171.0, 174.0, 174.0, 183.0, 171.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 64.0, 66.0, 69.0, 65.0, 73.0, 68.0, 66.0, 70.0], "value": 67.2, "unit": "score"}]}]} 05:28:41 INFO - Return code: 0 05:28:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:28:41 INFO - # TBPL SUCCESS # 05:28:41 INFO - Running post-action listener: _package_coverage_data 05:28:41 INFO - Running post-action listener: _resource_record_post_action 05:28:41 INFO - [mozharness: 2017-08-07 12:28:41.734992Z] Finished run-tests step (success) 05:28:41 INFO - Running post-run listener: _resource_record_post_run 05:28:41 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 16384; Write bytes: 439046144; Read time: 300; Write time: 231424 05:28:41 INFO - TinderboxPrint: CPU usage
13.2% 05:28:41 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 300 05:28:41 INFO - TinderboxPrint: I/O write bytes / time
439,046,144 / 231,424 05:28:41 INFO - TinderboxPrint: CPU idle
8,271.4 (86.8%) 05:28:41 INFO - TinderboxPrint: CPU user
1,205.8 (12.7%) 05:28:41 INFO - TinderboxPrint: Swap in / out
0 / 0 05:28:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115933184; Read time: 92; Write time: 74428 05:28:41 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:28:41 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 323112960; Read time: 204; Write time: 156996 05:28:42 INFO - Running post-run listener: _upload_blobber_files 05:28:42 INFO - Blob upload gear active. 05:28:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:28:42 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 05:28:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:28:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:28:42 INFO - (blobuploader) - INFO - Open directory for files ... 05:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:43 INFO - (blobuploader) - INFO - Done attempting. 05:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:28:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:44 INFO - (blobuploader) - INFO - Done attempting. 05:28:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:28:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:45 INFO - (blobuploader) - INFO - Done attempting. 05:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:28:47 INFO - (blobuploader) - INFO - Done attempting. 05:28:48 INFO - (blobuploader) - INFO - Iteration through files over. 05:28:48 INFO - Return code: 0 05:28:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5b2d03fdef42aea99ad3fd2a17b964e925ce2d8e3710f5d7d9d48858503ddb86358cbdf6b57d0aacdcede2a056dc001ddf687b1053d3906db678642a793c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8922278458fb02f842083d2ba2a7d9be36d257db544b317162ef83587024cf6d8a026c6311ce870f985461be8bbf88047bea3f607700a83cd8d812890c50841c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4520d597a9c0cd7d4fc83a7290d2e4d82d7ea21874be1c672b55816f2a1313e385967f3404d343e42bea0552d229d1a9c7470a782ddf7e541f4b958519332e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1abd7877d0f31989dd38097ab5ea8867a9ec485ba7ffa08c21031822ddf49f13895dd0763f6cd54c1ec6c1304e824e86144e3be484f6bcbcb72c7f6e38dc7b9"} 05:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:28:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:28:48 INFO - Contents: 05:28:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5b2d03fdef42aea99ad3fd2a17b964e925ce2d8e3710f5d7d9d48858503ddb86358cbdf6b57d0aacdcede2a056dc001ddf687b1053d3906db678642a793c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8922278458fb02f842083d2ba2a7d9be36d257db544b317162ef83587024cf6d8a026c6311ce870f985461be8bbf88047bea3f607700a83cd8d812890c50841c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4520d597a9c0cd7d4fc83a7290d2e4d82d7ea21874be1c672b55816f2a1313e385967f3404d343e42bea0552d229d1a9c7470a782ddf7e541f4b958519332e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1abd7877d0f31989dd38097ab5ea8867a9ec485ba7ffa08c21031822ddf49f13895dd0763f6cd54c1ec6c1304e824e86144e3be484f6bcbcb72c7f6e38dc7b9"} 05:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 05:28:48 INFO - Copying logs to upload dir... 05:28:48 INFO - mkdir: /builds/slave/test/build/upload/logs 05:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.621144 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-07 05:28:47.471627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 05:28:47.479126) ========= 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=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5b2d03fdef42aea99ad3fd2a17b964e925ce2d8e3710f5d7d9d48858503ddb86358cbdf6b57d0aacdcede2a056dc001ddf687b1053d3906db678642a793c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8922278458fb02f842083d2ba2a7d9be36d257db544b317162ef83587024cf6d8a026c6311ce870f985461be8bbf88047bea3f607700a83cd8d812890c50841c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4520d597a9c0cd7d4fc83a7290d2e4d82d7ea21874be1c672b55816f2a1313e385967f3404d343e42bea0552d229d1a9c7470a782ddf7e541f4b958519332e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1abd7877d0f31989dd38097ab5ea8867a9ec485ba7ffa08c21031822ddf49f13895dd0763f6cd54c1ec6c1304e824e86144e3be484f6bcbcb72c7f6e38dc7b9"} build_url:https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db5b2d03fdef42aea99ad3fd2a17b964e925ce2d8e3710f5d7d9d48858503ddb86358cbdf6b57d0aacdcede2a056dc001ddf687b1053d3906db678642a793c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8922278458fb02f842083d2ba2a7d9be36d257db544b317162ef83587024cf6d8a026c6311ce870f985461be8bbf88047bea3f607700a83cd8d812890c50841c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b4520d597a9c0cd7d4fc83a7290d2e4d82d7ea21874be1c672b55816f2a1313e385967f3404d343e42bea0552d229d1a9c7470a782ddf7e541f4b958519332e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1abd7877d0f31989dd38097ab5ea8867a9ec485ba7ffa08c21031822ddf49f13895dd0763f6cd54c1ec6c1304e824e86144e3be484f6bcbcb72c7f6e38dc7b9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 05:28:47.506310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:28:47.506624) ========= 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=db7e7c15f3ca076d53731445000001ba-1502107672.747192-2042739010 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:28:47.588790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 05:28:47.589108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 05:28:47.589444) ========= ========= Total master_lag: 0.18 =========