builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1502107718.67 results: success (0) revision: 47248637eafa9a38dade8dc3aa6c4736177c8d8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.667599) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.673701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.674110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.686482) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.686800) ========= 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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-07 05:08:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-08-07 05:08:39 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113389 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.827951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.828300) ========= 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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018778 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.887822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:38.888304) ========= 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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-07 05:08:39,900 truncating revision to first 12 chars 2017-08-07 05:08:39,901 Setting DEBUG logging. 2017-08-07 05:08:39,901 attempt 1/10 2017-08-07 05:08:39,901 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:08:40,434 unpacking tar archive at: mozilla-central-47248637eafa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.836229 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:39.746626) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:39.747062) ========= script_repo_revision: 47248637eafa9a38dade8dc3aa6c4736177c8d8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:39.747539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:39.747861) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-07 05:08:39.761339) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-07 05:08:39.761700) ========= /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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:08:40 INFO - MultiFileLogger online at 20170807 05:08:40 in /builds/slave/test 05:08:40 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:08:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:08:40 INFO - {'append_to_log': False, 05:08:40 INFO - 'base_work_dir': '/builds/slave/test', 05:08:40 INFO - 'blob_upload_branch': 'Firefox', 05:08:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:08:40 INFO - 'branch': 'Firefox', 05:08:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:08:40 INFO - 'code_coverage': False, 05:08:40 INFO - 'config_files': ('talos/linux_config.py',), 05:08:40 INFO - 'default_actions': ('clobber', 05:08:40 INFO - 'read-buildbot-config', 05:08:40 INFO - 'download-and-extract', 05:08:40 INFO - 'populate-webroot', 05:08:40 INFO - 'create-virtualenv', 05:08:40 INFO - 'install', 05:08:40 INFO - 'setup-mitmproxy', 05:08:40 INFO - 'run-tests'), 05:08:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:08:40 INFO - 'disable_ccov_upload': False, 05:08:40 INFO - 'download_minidump_stackwalk': True, 05:08:40 INFO - 'download_symbols': 'ondemand', 05:08:40 INFO - 'enable_stylo': False, 05:08:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:08:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:08:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:08:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:08:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:08:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:08:40 INFO - 'gecko_profile': False, 05:08:40 INFO - 'gecko_profile_interval': 0, 05:08:40 INFO - 'installer_path': 'installer.exe', 05:08:40 INFO - 'log_level': 'info', 05:08:40 INFO - 'log_name': 'talos', 05:08:40 INFO - 'log_to_console': True, 05:08:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:08:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:08:40 INFO - 'opt_config_files': (), 05:08:40 INFO - 'pip_index': False, 05:08:40 INFO - 'suite': 'dromaeojs-e10s', 05:08:40 INFO - 'system_bits': '32', 05:08:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:08:40 INFO - 'title': 'talos-linux64-ix-058', 05:08:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:08:40 INFO - 'use_talos_json': True, 05:08:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:08:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:08:40 INFO - 'work_dir': 'build'} 05:08:40 INFO - [mozharness: 2017-08-07 12:08:40.877767Z] Running clobber step. 05:08:40 INFO - Running pre-action listener: _resource_record_pre_action 05:08:40 INFO - Running main action method: clobber 05:08:40 INFO - rmtree: /builds/slave/test/build 05:08:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:08:42 INFO - Running post-action listener: _resource_record_post_action 05:08:42 INFO - [mozharness: 2017-08-07 12:08:42.059312Z] Finished clobber step (success) 05:08:42 INFO - [mozharness: 2017-08-07 12:08:42.059460Z] Running read-buildbot-config step. 05:08:42 INFO - Running pre-action listener: _resource_record_pre_action 05:08:42 INFO - Running main action method: read_buildbot_config 05:08:42 INFO - Using buildbot properties: 05:08:42 INFO - { 05:08:42 INFO - "project": "", 05:08:42 INFO - "product": "firefox", 05:08:42 INFO - "who": "cbook@mozilla.com", 05:08:42 INFO - "installer_path": "public/build/target.tar.bz2", 05:08:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:08:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:08:42 INFO - "stage_platform": "linux64-stylosequential", 05:08:42 INFO - "basedir": "/builds/slave/test", 05:08:42 INFO - "buildnumber": 139, 05:08:42 INFO - "platform": "ubuntu64_hw_styloseq", 05:08:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:08:42 INFO - "slavebuilddir": "test", 05:08:42 INFO - "taskId": "QWd4ArQqTay6YAa-aBWCWg", 05:08:42 INFO - "branch": "mozilla-central", 05:08:42 INFO - "script_repo_revision": "production", 05:08:42 INFO - "revision": "47248637eafa9a38dade8dc3aa6c4736177c8d8d", 05:08:42 INFO - "slavename": "talos-linux64-ix-058", 05:08:42 INFO - "repo_path": "mozilla-central" 05:08:42 INFO - } 05:08:42 INFO - Finding installer, test and symbols from parent task. 05:08:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QWd4ArQqTay6YAa-aBWCWg'}, attempt #1 05:08:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QWd4ArQqTay6YAa-aBWCWg'}, attempt #1 05:08:42 INFO - Task dependencies: FK6Vw9RDTvi4Ea5oCnVSGw 05:08:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw'}, attempt #1 05:08:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:08:43 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json 05:08:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.crashreporter-symbols.zip 05:08:43 INFO - Running post-action listener: _resource_record_post_action 05:08:43 INFO - [mozharness: 2017-08-07 12:08:43.430440Z] Finished read-buildbot-config step (success) 05:08:43 INFO - [mozharness: 2017-08-07 12:08:43.430662Z] Running download-and-extract step. 05:08:43 INFO - Running pre-action listener: _resource_record_pre_action 05:08:43 INFO - Running main action method: download_and_extract 05:08:43 INFO - mkdir: /builds/slave/test/build/tests 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 - trying https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.test_packages.json 05:08:43 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:08:43 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:08:44 INFO - Downloaded 989 bytes. 05:08:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:08:44 INFO - Using the following test package requirements: 05:08:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:08:44 INFO - u'common': [u'target.common.tests.zip'], 05:08:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:08:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:08:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:08:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:08:44 INFO - u'mozbase': [u'target.common.tests.zip'], 05:08:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:08:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:08:44 INFO - u'web-platform': [u'target.common.tests.zip', 05:08:44 INFO - u'target.web-platform.tests.tar.gz'], 05:08:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:08:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:08:44 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:44 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:44 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip into memory 05:08:45 INFO - Content-Length response header: 54284838 05:08:45 INFO - Bytes received: 54284838 05:08:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:08:56 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:56 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:56 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.common.tests.zip into memory 05:08:57 INFO - Content-Length response header: 54284838 05:08:57 INFO - Bytes received: 54284838 05:09:09 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:09:09 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:09:09 INFO - Fetch https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.talos.tests.zip into memory 05:09:10 INFO - Content-Length response header: 14496008 05:09:10 INFO - Bytes received: 14496008 05:09:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:10 INFO - trying https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:09:10 INFO - Downloading https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:09:10 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:09:11 INFO - Downloaded 61707857 bytes. 05:09:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:09:11 INFO - mkdir: /builds/slave/test/properties 05:09:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:09:11 INFO - Writing to file /builds/slave/test/properties/build_url 05:09:11 INFO - Contents: 05:09:11 INFO - build_url:https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 05:09:11 INFO - Running post-action listener: _resource_record_post_action 05:09:11 INFO - Running post-action listener: set_extra_try_arguments 05:09:11 INFO - [mozharness: 2017-08-07 12:09:11.427085Z] Finished download-and-extract step (success) 05:09:11 INFO - [mozharness: 2017-08-07 12:09:11.427183Z] Running populate-webroot step. 05:09:11 INFO - Running pre-action listener: _resource_record_pre_action 05:09:11 INFO - Running main action method: populate_webroot 05:09:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:09:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:09:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:09:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:09:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:09:11 INFO - 'tests': ['damp', 'tps']}, 05:09:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:09:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:09:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:09:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:09:11 INFO - 'other-e10s': {'tests': ['a11yr', 05:09:11 INFO - 'ts_paint', 05:09:11 INFO - 'tpaint', 05:09:11 INFO - 'sessionrestore', 05:09:11 INFO - 'sessionrestore_many_windows', 05:09:11 INFO - 'sessionrestore_no_auto_restore', 05:09:11 INFO - 'tabpaint']}, 05:09:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:09:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:09:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:09:11 INFO - 'tsvgr_opacity', 05:09:11 INFO - 'tart', 05:09:11 INFO - 'tscrollx', 05:09:11 INFO - 'tsvg_static']}, 05:09:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:09:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:09:11 INFO - 'talos_options': ['--mitmproxy', 05:09:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:09:11 INFO - '--firstNonBlankPaint'], 05:09:11 INFO - 'tests': ['tp6_google', 05:09:11 INFO - 'tp6_youtube', 05:09:11 INFO - 'tp6_amazon', 05:09:11 INFO - 'tp6_facebook']}, 05:09:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:09:11 INFO - 'talos_options': ['--stylo', 05:09:11 INFO - '--mitmproxy', 05:09:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:09:11 INFO - '--firstNonBlankPaint'], 05:09:11 INFO - 'tests': ['tp6_google', 05:09:11 INFO - 'tp6_youtube', 05:09:11 INFO - 'tp6_amazon', 05:09:11 INFO - 'tp6_facebook']}, 05:09:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:09:11 INFO - 'talos_options': ['--stylo', 05:09:11 INFO - '--stylo-threads=1', 05:09:11 INFO - '--mitmproxy', 05:09:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:09:11 INFO - '--firstNonBlankPaint'], 05:09:11 INFO - 'tests': ['tp6_google', 05:09:11 INFO - 'tp6_youtube', 05:09:11 INFO - 'tp6_amazon', 05:09:11 INFO - 'tp6_facebook']}, 05:09:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:09:11 INFO - 'talos_options': ['--xperf_path', 05:09:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:09:11 INFO - 'tests': ['tp5n']}}} 05:09:11 INFO - Running post-action listener: _resource_record_post_action 05:09:11 INFO - [mozharness: 2017-08-07 12:09:11.435577Z] Finished populate-webroot step (success) 05:09:11 INFO - [mozharness: 2017-08-07 12:09:11.435667Z] Running create-virtualenv step. 05:09:11 INFO - Running pre-action listener: _resource_record_pre_action 05:09:11 INFO - Running main action method: create_virtualenv 05:09:11 INFO - Creating virtualenv /builds/slave/test/build/venv 05:09:11 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:09:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:09:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:09:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:09:11 INFO - Using real prefix '/usr' 05:09:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:09:12 INFO - Installing distribute.............................................................................................................................................................................................done. 05:09:14 INFO - Installing pip.................done. 05:09:14 INFO - Return code: 0 05:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:09:14 INFO - Reading from file tmpfile_stdout 05:09:14 INFO - Output received: 05:09:14 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:09:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:09:14 INFO - Using env: {'DISPLAY': ':0', 05:09:14 INFO - 'HOME': '/home/cltbld', 05:09:14 INFO - 'LANG': 'en_US.UTF-8', 05:09:14 INFO - 'LANGUAGE': 'en_US:en', 05:09:14 INFO - 'LOGNAME': 'cltbld', 05:09:14 INFO - 'MAIL': '/var/mail/cltbld', 05:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:14 INFO - 'MOZ_NO_REMOTE': '1', 05:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:14 INFO - 'NO_EM_RESTART': '1', 05:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:14 INFO - 'PWD': '/builds/slave/test', 05:09:14 INFO - 'SHELL': '/bin/bash', 05:09:14 INFO - 'SHLVL': '1', 05:09:14 INFO - 'TERM': 'linux', 05:09:14 INFO - 'TMOUT': '86400', 05:09:14 INFO - 'USER': 'cltbld', 05:09:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:14 INFO - '_': '/tools/buildbot/bin/python'} 05:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:14 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:09:14 INFO - Cleaning up... 05:09:14 INFO - Return code: 0 05:09:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:09:14 INFO - Using env: {'DISPLAY': ':0', 05:09:14 INFO - 'HOME': '/home/cltbld', 05:09:14 INFO - 'LANG': 'en_US.UTF-8', 05:09:14 INFO - 'LANGUAGE': 'en_US:en', 05:09:14 INFO - 'LOGNAME': 'cltbld', 05:09:14 INFO - 'MAIL': '/var/mail/cltbld', 05:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:14 INFO - 'MOZ_NO_REMOTE': '1', 05:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:14 INFO - 'NO_EM_RESTART': '1', 05:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:14 INFO - 'PWD': '/builds/slave/test', 05:09:14 INFO - 'SHELL': '/bin/bash', 05:09:14 INFO - 'SHLVL': '1', 05:09:14 INFO - 'TERM': 'linux', 05:09:14 INFO - 'TMOUT': '86400', 05:09:14 INFO - 'USER': 'cltbld', 05:09:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:14 INFO - '_': '/tools/buildbot/bin/python'} 05:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:14 INFO - Downloading/unpacking psutil>=3.1.1 05:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:09:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:15 INFO - Installing collected packages: psutil 05:09:15 INFO - Running setup.py install for psutil 05:09:15 INFO - building 'psutil._psutil_linux' extension 05:09:15 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:09:16 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:09:16 INFO - building 'psutil._psutil_posix' extension 05:09:16 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:09:16 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:09:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:09:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:09:16 INFO - Successfully installed psutil 05:09:16 INFO - Cleaning up... 05:09:16 INFO - Return code: 0 05:09:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:16 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:16 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:09:16 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:09:16 INFO - Using env: {'DISPLAY': ':0', 05:09:16 INFO - 'HOME': '/home/cltbld', 05:09:16 INFO - 'LANG': 'en_US.UTF-8', 05:09:16 INFO - 'LANGUAGE': 'en_US:en', 05:09:16 INFO - 'LOGNAME': 'cltbld', 05:09:16 INFO - 'MAIL': '/var/mail/cltbld', 05:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:16 INFO - 'MOZ_NO_REMOTE': '1', 05:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:16 INFO - 'NO_EM_RESTART': '1', 05:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:16 INFO - 'PWD': '/builds/slave/test', 05:09:16 INFO - 'SHELL': '/bin/bash', 05:09:16 INFO - 'SHLVL': '1', 05:09:16 INFO - 'TERM': 'linux', 05:09:16 INFO - 'TMOUT': '86400', 05:09:16 INFO - 'USER': 'cltbld', 05:09:16 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:16 INFO - '_': '/tools/buildbot/bin/python'} 05:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:09:16 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:09:16 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:09:16 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:09:16 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:09:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:09:17 INFO - Installing collected packages: mozsystemmonitor 05:09:17 INFO - Running setup.py install for mozsystemmonitor 05:09:17 INFO - Successfully installed mozsystemmonitor 05:09:17 INFO - Cleaning up... 05:09:17 INFO - Return code: 0 05:09:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:09:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:17 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:17 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:09:17 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:09:17 INFO - Using env: {'DISPLAY': ':0', 05:09:17 INFO - 'HOME': '/home/cltbld', 05:09:17 INFO - 'LANG': 'en_US.UTF-8', 05:09:17 INFO - 'LANGUAGE': 'en_US:en', 05:09:17 INFO - 'LOGNAME': 'cltbld', 05:09:17 INFO - 'MAIL': '/var/mail/cltbld', 05:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:17 INFO - 'MOZ_NO_REMOTE': '1', 05:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:17 INFO - 'NO_EM_RESTART': '1', 05:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:17 INFO - 'PWD': '/builds/slave/test', 05:09:17 INFO - 'SHELL': '/bin/bash', 05:09:17 INFO - 'SHLVL': '1', 05:09:17 INFO - 'TERM': 'linux', 05:09:17 INFO - 'TMOUT': '86400', 05:09:17 INFO - 'USER': 'cltbld', 05:09:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:17 INFO - '_': '/tools/buildbot/bin/python'} 05:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:18 INFO - Downloading/unpacking jsonschema==2.5.1 05:09:18 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:09:18 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:09:18 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:09:18 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:09:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:09:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:09:19 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:09:19 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:09:19 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:09:19 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:09:19 INFO - Downloading functools32-3.2.3-2.tar.gz 05:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:09:19 INFO - warning: no files found matching '*.txt' 05:09:19 INFO - no previously-included directories found matching 'build' 05:09:19 INFO - no previously-included directories found matching 'dist' 05:09:19 INFO - no previously-included directories found matching '.git*' 05:09:19 INFO - Installing collected packages: jsonschema, functools32 05:09:19 INFO - Running setup.py install for functools32 05:09:19 INFO - warning: no files found matching '*.txt' 05:09:19 INFO - no previously-included directories found matching 'build' 05:09:19 INFO - no previously-included directories found matching 'dist' 05:09:19 INFO - no previously-included directories found matching '.git*' 05:09:19 INFO - Successfully installed jsonschema functools32 05:09:19 INFO - Cleaning up... 05:09:19 INFO - Return code: 0 05:09:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:19 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:19 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:09:19 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:09:19 INFO - Using env: {'DISPLAY': ':0', 05:09:19 INFO - 'HOME': '/home/cltbld', 05:09:19 INFO - 'LANG': 'en_US.UTF-8', 05:09:19 INFO - 'LANGUAGE': 'en_US:en', 05:09:19 INFO - 'LOGNAME': 'cltbld', 05:09:19 INFO - 'MAIL': '/var/mail/cltbld', 05:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:19 INFO - 'MOZ_NO_REMOTE': '1', 05:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:19 INFO - 'NO_EM_RESTART': '1', 05:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:19 INFO - 'PWD': '/builds/slave/test', 05:09:19 INFO - 'SHELL': '/bin/bash', 05:09:19 INFO - 'SHLVL': '1', 05:09:19 INFO - 'TERM': 'linux', 05:09:19 INFO - 'TMOUT': '86400', 05:09:19 INFO - 'USER': 'cltbld', 05:09:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:19 INFO - '_': '/tools/buildbot/bin/python'} 05:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:09:19 INFO - Cleaning up... 05:09:19 INFO - Return code: 0 05:09:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:19 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:19 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:09:19 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:09:19 INFO - Using env: {'DISPLAY': ':0', 05:09:19 INFO - 'HOME': '/home/cltbld', 05:09:19 INFO - 'LANG': 'en_US.UTF-8', 05:09:19 INFO - 'LANGUAGE': 'en_US:en', 05:09:19 INFO - 'LOGNAME': 'cltbld', 05:09:19 INFO - 'MAIL': '/var/mail/cltbld', 05:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:19 INFO - 'MOZ_NO_REMOTE': '1', 05:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:19 INFO - 'NO_EM_RESTART': '1', 05:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:19 INFO - 'PWD': '/builds/slave/test', 05:09:19 INFO - 'SHELL': '/bin/bash', 05:09:19 INFO - 'SHLVL': '1', 05:09:19 INFO - 'TERM': 'linux', 05:09:19 INFO - 'TMOUT': '86400', 05:09:19 INFO - 'USER': 'cltbld', 05:09:19 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:19 INFO - '_': '/tools/buildbot/bin/python'} 05:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:20 INFO - Downloading/unpacking blobuploader==1.2.4 05:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - Downloading blobuploader-1.2.4.tar.gz 05:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:09:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:09:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:21 INFO - Downloading docopt-0.6.1.tar.gz 05:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:09:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:09:21 INFO - Running setup.py install for blobuploader 05:09:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:09:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:09:21 INFO - Running setup.py install for requests 05:09:22 INFO - Running setup.py install for docopt 05:09:22 INFO - Successfully installed blobuploader requests docopt 05:09:22 INFO - Cleaning up... 05:09:22 INFO - Return code: 0 05:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:22 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:22 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:09:22 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:09:22 INFO - Using env: {'DISPLAY': ':0', 05:09:22 INFO - 'HOME': '/home/cltbld', 05:09:22 INFO - 'LANG': 'en_US.UTF-8', 05:09:22 INFO - 'LANGUAGE': 'en_US:en', 05:09:22 INFO - 'LOGNAME': 'cltbld', 05:09:22 INFO - 'MAIL': '/var/mail/cltbld', 05:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:22 INFO - 'MOZ_NO_REMOTE': '1', 05:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:22 INFO - 'NO_EM_RESTART': '1', 05:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:22 INFO - 'PWD': '/builds/slave/test', 05:09:22 INFO - 'SHELL': '/bin/bash', 05:09:22 INFO - 'SHLVL': '1', 05:09:22 INFO - 'TERM': 'linux', 05:09:22 INFO - 'TMOUT': '86400', 05:09:22 INFO - 'USER': 'cltbld', 05:09:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:22 INFO - '_': '/tools/buildbot/bin/python'} 05:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:22 INFO - Running setup.py (path:/tmp/pip-bduzTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:22 INFO - Running setup.py (path:/tmp/pip-uVBERa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:22 INFO - Running setup.py (path:/tmp/pip-bu5Amk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:22 INFO - Running setup.py (path:/tmp/pip-cHpvON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:22 INFO - Running setup.py (path:/tmp/pip-_20bTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:23 INFO - Running setup.py (path:/tmp/pip-880vCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:23 INFO - Running setup.py (path:/tmp/pip-SwhYm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:23 INFO - Running setup.py (path:/tmp/pip-KEzdby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:23 INFO - Running setup.py (path:/tmp/pip-qpNCPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:23 INFO - Running setup.py (path:/tmp/pip-LXjk4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:23 INFO - Running setup.py (path:/tmp/pip-owDqPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:23 INFO - Running setup.py (path:/tmp/pip-Bnoibp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:23 INFO - Running setup.py (path:/tmp/pip-uDObCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:23 INFO - Running setup.py (path:/tmp/pip-MvPJOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:23 INFO - Running setup.py (path:/tmp/pip-RKl3Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:23 INFO - Running setup.py (path:/tmp/pip-tz_Mmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:23 INFO - Running setup.py (path:/tmp/pip-uXVUSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:09:23 INFO - Running setup.py install for manifestparser 05:09:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:09:23 INFO - Running setup.py install for mozcrash 05:09:24 INFO - Running setup.py install for mozdebug 05:09:24 INFO - Running setup.py install for mozdevice 05:09:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozfile 05:09:24 INFO - Running setup.py install for mozhttpd 05:09:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozinfo 05:09:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozInstall 05:09:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozleak 05:09:24 INFO - Running setup.py install for mozlog 05:09:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for moznetwork 05:09:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:09:24 INFO - Running setup.py install for mozprocess 05:09:25 INFO - Running setup.py install for mozprofile 05:09:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozrunner 05:09:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Running setup.py install for mozscreenshot 05:09:25 INFO - Running setup.py install for moztest 05:09:25 INFO - Running setup.py install for mozversion 05:09:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:09:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:09:25 INFO - Cleaning up... 05:09:25 INFO - Return code: 0 05:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09: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:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:25 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:25 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:09:25 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:09:25 INFO - Using env: {'DISPLAY': ':0', 05:09:25 INFO - 'HOME': '/home/cltbld', 05:09:25 INFO - 'LANG': 'en_US.UTF-8', 05:09:25 INFO - 'LANGUAGE': 'en_US:en', 05:09:25 INFO - 'LOGNAME': 'cltbld', 05:09:25 INFO - 'MAIL': '/var/mail/cltbld', 05:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:25 INFO - 'MOZ_NO_REMOTE': '1', 05:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:25 INFO - 'NO_EM_RESTART': '1', 05:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:25 INFO - 'PWD': '/builds/slave/test', 05:09:25 INFO - 'SHELL': '/bin/bash', 05:09:25 INFO - 'SHLVL': '1', 05:09:25 INFO - 'TERM': 'linux', 05:09:25 INFO - 'TMOUT': '86400', 05:09:25 INFO - 'USER': 'cltbld', 05:09:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:25 INFO - '_': '/tools/buildbot/bin/python'} 05:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:09:25 INFO - Running setup.py (path:/tmp/pip-ZJyLH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:09:25 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:09:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:09:25 INFO - Running setup.py (path:/tmp/pip-EWOKlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:09:26 INFO - Running setup.py (path:/tmp/pip-c9Nb7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:09:26 INFO - Running setup.py (path:/tmp/pip-aPny1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:09:26 INFO - Running setup.py (path:/tmp/pip-mDrpg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 INFO - Running setup.py (path:/tmp/pip-72lcZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 INFO - Running setup.py (path:/tmp/pip-p98ADi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 INFO - Running setup.py (path:/tmp/pip-nGpUGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:09:26 INFO - Running setup.py (path:/tmp/pip-rCxII2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:09:26 INFO - Running setup.py (path:/tmp/pip-koMC93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:09:26 INFO - Running setup.py (path:/tmp/pip-UVBRGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:09:26 INFO - Running setup.py (path:/tmp/pip-wwhUpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:09:26 INFO - Running setup.py (path:/tmp/pip-P2lIBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:09:26 INFO - Running setup.py (path:/tmp/pip-KjedOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:26 INFO - Running setup.py (path:/tmp/pip-Q7x2YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:09:26 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:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:09:26 INFO - Running setup.py (path:/tmp/pip-P9clZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:09:27 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:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:09:27 INFO - Running setup.py (path:/tmp/pip-AtRJ27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:28 INFO - Downloading blessings-1.6.tar.gz 05:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:28 INFO - Installing collected packages: blessings 05:09:28 INFO - Running setup.py install for blessings 05:09:28 INFO - Successfully installed blessings 05:09:28 INFO - Cleaning up... 05:09:28 INFO - Return code: 0 05:09:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:28 INFO - Reading from file tmpfile_stdout 05:09:28 INFO - Current package versions: 05:09:28 INFO - argparse == 1.2.1 05:09:28 INFO - blessings == 1.6 05:09:28 INFO - blobuploader == 1.2.4 05:09:28 INFO - docopt == 0.6.1 05:09:28 INFO - functools32 == 3.2.3-2 05:09:28 INFO - jsonschema == 2.5.1 05:09:28 INFO - manifestparser == 1.1 05:09:28 INFO - mozInstall == 1.13 05:09:28 INFO - mozcrash == 1.0 05:09:28 INFO - mozdebug == 0.1 05:09:28 INFO - mozdevice == 0.51 05:09:28 INFO - mozfile == 1.2 05:09:28 INFO - mozhttpd == 0.7 05:09:28 INFO - mozinfo == 0.10 05:09:28 INFO - mozleak == 0.1 05:09:28 INFO - mozlog == 3.5 05:09:28 INFO - moznetwork == 0.27 05:09:28 INFO - mozprocess == 0.25 05:09:28 INFO - mozprofile == 0.28 05:09:28 INFO - mozrunner == 6.13 05:09:28 INFO - mozscreenshot == 0.1 05:09:28 INFO - mozsystemmonitor == 0.3 05:09:28 INFO - moztest == 0.8 05:09:28 INFO - mozversion == 1.4 05:09:28 INFO - psutil == 3.1.1 05:09:28 INFO - requests == 1.2.3 05:09:28 INFO - wsgiref == 0.1.2 05:09:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:28 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 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09:28 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:09:28 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:09:28 INFO - Using env: {'DISPLAY': ':0', 05:09:28 INFO - 'HOME': '/home/cltbld', 05:09:28 INFO - 'LANG': 'en_US.UTF-8', 05:09:28 INFO - 'LANGUAGE': 'en_US:en', 05:09:28 INFO - 'LOGNAME': 'cltbld', 05:09:28 INFO - 'MAIL': '/var/mail/cltbld', 05:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:28 INFO - 'MOZ_NO_REMOTE': '1', 05:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:28 INFO - 'NO_EM_RESTART': '1', 05:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:28 INFO - 'PWD': '/builds/slave/test', 05:09:28 INFO - 'SHELL': '/bin/bash', 05:09:28 INFO - 'SHLVL': '1', 05:09:28 INFO - 'TERM': 'linux', 05:09:28 INFO - 'TMOUT': '86400', 05:09:28 INFO - 'USER': 'cltbld', 05:09:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:28 INFO - '_': '/tools/buildbot/bin/python'} 05:09:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 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:09:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:09:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:09:30 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:09:30 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:09:30 INFO - Installing collected packages: simplejson 05:09:30 INFO - Running setup.py install for simplejson 05:09:30 INFO - building 'simplejson._speedups' extension 05:09:30 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:09:30 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:09:31 INFO - Successfully installed simplejson 05:09:31 INFO - Cleaning up... 05:09:31 INFO - Return code: 0 05:09:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:09: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:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09: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:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9d91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xba5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd48d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, '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': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', '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:09: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', 'jsonschema'] in /builds/slave/test/build 05:09: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 jsonschema 05:09:31 INFO - Using env: {'DISPLAY': ':0', 05:09:31 INFO - 'HOME': '/home/cltbld', 05:09:31 INFO - 'LANG': 'en_US.UTF-8', 05:09:31 INFO - 'LANGUAGE': 'en_US:en', 05:09:31 INFO - 'LOGNAME': 'cltbld', 05:09:31 INFO - 'MAIL': '/var/mail/cltbld', 05:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:31 INFO - 'MOZ_NO_REMOTE': '1', 05:09:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:31 INFO - 'NO_EM_RESTART': '1', 05:09:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:31 INFO - 'PWD': '/builds/slave/test', 05:09:31 INFO - 'SHELL': '/bin/bash', 05:09:31 INFO - 'SHLVL': '1', 05:09:31 INFO - 'TERM': 'linux', 05:09:31 INFO - 'TMOUT': '86400', 05:09:31 INFO - 'USER': 'cltbld', 05:09:31 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:31 INFO - '_': '/tools/buildbot/bin/python'} 05:09:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:09:31 INFO - Cleaning up... 05:09:31 INFO - Return code: 0 05:09:31 INFO - Running post-action listener: _resource_record_post_action 05:09:31 INFO - Running post-action listener: _start_resource_monitoring 05:09:31 INFO - Starting resource monitoring. 05:09:31 INFO - [mozharness: 2017-08-07 12:09:31.395043Z] Finished create-virtualenv step (success) 05:09:31 INFO - [mozharness: 2017-08-07 12:09:31.395525Z] Running install step. 05:09:31 INFO - Running pre-action listener: _resource_record_pre_action 05:09:31 INFO - Running main action method: install 05:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:31 INFO - Reading from file tmpfile_stdout 05:09:31 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:31 INFO - Reading from file tmpfile_stdout 05:09:31 INFO - Output received: 05:09:31 INFO - Usage: mozinstall [options] installer 05:09:31 INFO - Options: 05:09:31 INFO - -h, --help show this help message and exit 05:09:31 INFO - -d DEST, --destination=DEST 05:09:31 INFO - Directory to install application into. [default: 05:09:31 INFO - "/builds/slave/test"] 05:09:31 INFO - --app=APP Application being installed. [default: firefox] 05:09:31 INFO - mkdir: /builds/slave/test/build/application 05:09:31 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:09:31 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:49 INFO - Reading from file tmpfile_stdout 05:09:49 INFO - Output received: 05:09:49 INFO - /builds/slave/test/build/application/firefox/firefox 05:09:49 INFO - Running post-action listener: _resource_record_post_action 05:09:49 INFO - [mozharness: 2017-08-07 12:09:49.718832Z] Finished install step (success) 05:09:49 INFO - [mozharness: 2017-08-07 12:09:49.719082Z] Running setup-mitmproxy step. 05:09:49 INFO - Running pre-action listener: _resource_record_pre_action 05:09:49 INFO - Running main action method: setup_mitmproxy 05:09:49 INFO - Skipping: mitmproxy is not required 05:09:49 INFO - Running post-action listener: _resource_record_post_action 05:09:49 INFO - [mozharness: 2017-08-07 12:09:49.720197Z] Finished setup-mitmproxy step (success) 05:09:49 INFO - [mozharness: 2017-08-07 12:09:49.720425Z] Running run-tests step. 05:09:49 INFO - Running pre-action listener: _resource_record_pre_action 05:09:49 INFO - Running pre-action listener: _set_gcov_prefix 05:09:49 INFO - Running main action method: run_tests 05:09:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:49 INFO - Python 2.7.3 05:09:49 INFO - Return code: 0 05:09:49 INFO - grabbing minidump binary from tooltool 05:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:09:49 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 0xd45eb0>, '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 0xd46db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd47240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:49 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:49 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:49 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:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:49 INFO - Return code: 0 05:09:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:09:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:49 INFO - ENV: RUST_BACKTRACE is now 1 05:09:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:09:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:49 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-058', '--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:49 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-058 --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:49 INFO - Using env: {'DISPLAY': ':0', 05:09:49 INFO - 'HOME': '/home/cltbld', 05:09:49 INFO - 'LANG': 'en_US.UTF-8', 05:09:49 INFO - 'LANGUAGE': 'en_US:en', 05:09:49 INFO - 'LOGNAME': 'cltbld', 05:09:49 INFO - 'MAIL': '/var/mail/cltbld', 05:09:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:49 INFO - 'MOZ_NO_REMOTE': '1', 05:09:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:09:49 INFO - 'NO_EM_RESTART': '1', 05:09:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:49 INFO - 'PWD': '/builds/slave/test', 05:09:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:49 INFO - 'RUST_BACKTRACE': '1', 05:09:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:09:49 INFO - 'SHELL': '/bin/bash', 05:09:49 INFO - 'SHLVL': '1', 05:09:49 INFO - 'STYLO_FORCE_ENABLED': '1', 05:09:49 INFO - 'TERM': 'linux', 05:09:49 INFO - 'TMOUT': '86400', 05:09:49 INFO - 'USER': 'cltbld', 05:09:49 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578', 05:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:49 INFO - '_': '/tools/buildbot/bin/python'} 05:09:49 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-058', '--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:50 INFO - mozversion application_buildid: 20170807112422 05:09:50 INFO - mozversion application_changeset: 47248637eafa9a38dade8dc3aa6c4736177c8d8d 05:09:50 INFO - mozversion application_display_name: Nightly 05:09:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:50 INFO - mozversion application_name: Firefox 05:09:50 INFO - mozversion application_remotingname: firefox 05:09:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:09:50 INFO - mozversion application_vendor: Mozilla 05:09:50 INFO - mozversion application_version: 57.0a1 05:09:50 INFO - mozversion platform_buildid: 20170807112422 05:09:50 INFO - mozversion platform_changeset: 47248637eafa9a38dade8dc3aa6c4736177c8d8d 05:09:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:09:50 INFO - mozversion platform_version: 57.0a1 05:09:50 INFO - using testdate: 1502107790 05:09:50 INFO - actual date: 1502107790 05:09:50 INFO - starting webserver on 'localhost:50399' 05:09:50 INFO - SUITE-START | Running 2 tests 05:09:50 INFO - TEST-START | dromaeo_css 05:09:50 INFO - Initialising browser for dromaeo_css test... 05:09:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50399/getInfo.html -profile /tmp/tmpttF5bg/profile 05:09:50 INFO - TEST-INFO | started process 5231 (/builds/slave/test/build/application/firefox/firefox http://localhost:50399/getInfo.html) 05:09:56 INFO - TEST-INFO | 5231: exit 0 05:09:56 INFO - Browser initialized. 05:09:56 INFO - Running cycle 1/1 for dromaeo_css test... 05:09:56 INFO - TEST-INFO | started process 5456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpttF5bg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:57 INFO - PID 5456 | 05:09:57 INFO - PID 5456 | (/builds/slave/test/build/application/firefox/firefox:5510): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:09:57 INFO - PID 5456 | 05:10:07 INFO - PID 5456 | RSS: Main: 170500096 05:10:07 INFO - PID 5456 | 05:10:07 INFO - PID 5456 | serialization: Helvetica 05:10:07 INFO - PID 5456 | serialization: Arial 05:13:07 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50399/tests/dromaeo/cssquery-ext.html) 05:13:08 INFO - PID 5456 | RSS: Main: 175173632 05:13:08 INFO - PID 5456 | 05:13:08 INFO - PID 5456 | serialization: Helvetica 05:13:08 INFO - PID 5456 | serialization: Arial 05:16:10 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-ext.html (next: http://localhost:50399/tests/dromaeo/cssquery-jquery.html) 05:16:10 INFO - PID 5456 | RSS: Main: 171298816 05:16:10 INFO - PID 5456 | 05:16:10 INFO - PID 5456 | serialization: Helvetica 05:16:10 INFO - PID 5456 | serialization: Arial 05:19:12 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50399/tests/dromaeo/cssquery-mootools.html) 05:19:13 INFO - PID 5456 | RSS: Main: 175439872 05:19:13 INFO - PID 5456 | 05:19:13 INFO - PID 5456 | serialization: Helvetica 05:19:13 INFO - PID 5456 | serialization: Arial 05:22:15 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50399/tests/dromaeo/cssquery-prototype.html) 05:22:15 INFO - PID 5456 | RSS: Main: 170524672 05:22:15 INFO - PID 5456 | 05:22:15 INFO - PID 5456 | serialization: Helvetica 05:22:15 INFO - PID 5456 | serialization: Arial 05:25:19 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50399/tests/dromaeo/cssquery-yui.html) 05:25:20 INFO - PID 5456 | RSS: Main: 176414720 05:25:20 INFO - PID 5456 | 05:25:20 INFO - PID 5456 | serialization: Helvetica 05:25:20 INFO - PID 5456 | serialization: Arial 05:28:22 INFO - PID 5456 | Cycle 1(1): loaded http://localhost:50399/tests/dromaeo/cssquery-yui.html (next: http://localhost:50399/tests/dromaeo/cssquery-dojo.html) 05:28:22 INFO - PID 5456 | RSS: Main: 177913856 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | __start_tp_report 05:28:22 INFO - PID 5456 | _x_x_mozilla_page_load 05:28:22 INFO - PID 5456 | _x_x_mozilla_page_load_details 05:28:22 INFO - PID 5456 | |i|pagename|runs| 05:28:22 INFO - PID 5456 | |0;dojo.html;3145.6697046810086;3184.601924759405;3187.6812318768125;3190.011096560065;3250.2849373137915;6120.816375508736;6123.081537769337;6142.692865356731;6143.354947730491;6310.179676642041;6229.563930524865;6292;6326;6356.459700925427;6358.268799088106;5561.5272701820395;5696.287964004499;5710.685912274813;5776.82669519913;5780.682062486561;5632.718364081779;5639.464250896158;5695.259616249882;5706.3437704663875;5767.106098554731;5673.6595804251465;5711.228984087136;5712.371639119693;5749.31008279005;5757.309122905257;5633.577481688849;5702.429757024264;5717.599768016241;5740.512056475204;5767.452092051249;5554.583406244507;5603.80386686464;5647.322321321468;5678.290213723285;5679.943200568024;6120.632762034248;6151.200343955302;6160.260768707739;6164;6177.135201071854;6730.764423245212;6767.695453704595;6782.898256526156;6784.660766961632;6821.079154314154;6776.390124888734;6779.084823548807;6781.627010514419;6863.10779598649;6887.001384799176;6176.7838125665385;6246.87506249877;6282.026285925689;6285.748570057147;6347.1114044033875;6875.828104297332;6887.311268873073;6892.586444813327;6897.172339319314;6900.413464855443;6450.8064758057335;6581.572197807127;6627.03907933347;6640.966795165993;6641.302663220389;6675.1989761228;6713.664316784141;6727.865442691119;6731.865362692719;6761.019652150509;6619.238787539494;6655.73377064912;6676.566023208476;6708.496862735315;6709.899351509731;6605.669716514155;6638.269790323061;6665.833354166088;6718.193816742022;6735.191776986793;5411.188321751769;5503.559715222853;5505.862353441196;5506;5530.5022547970875;4565.338025986213;4606.516315786861;4645.581897629229;4675.13510000651;4734.981978874558;5794.82615521535;5812.680302583314;5818.2436283282905;5834.03738383162;5861.384554621789;6716.46268298535;6808.11494505721;6814.420774234147;6815.488838337045;6819.624920629314;5781.392953739881;5810.796622118206;5845.035569131046;5862.091375836752;5881.5882888198275;5805.10020946754;5912.970435147797;5916.083007133901;5930.673812940244;5977.432143946318;6439.9356006440275;6488.545801793829;6507.511936604679;6518.837029074311;6524.869502609921;6701.3298670134545;6704.4301234395625;6728.428083612947;6731.394174524316;6743.831404214934;6483.870322593616;6490.610563366213;6567.047778072249;6573.441257493167;6576.375244351779;6535.803925882231;6589.6375699336995;6592.208934927839;6635.6350400728425;6698.229703583956;6701.028350889192;6703.463722902058;6715.664216789239;6750.763723269662;6764.4588432924265;6381.8723625528155;6492.188476440445;6493.480521558169;6503.674816259263;6517.8696426072165;6016.817309803038;6456.322086180883;6466.838329041811;6512.869742605027;6548.869022619616;6419;6497.935020649733;6498.122753428227;6500.089987401862;6527.216733991761;6558.081868538313;6562.442192413699;6609.173853268341;6611.933880661132;6660.733570657119;6368.617882927039;6371.74513019474;6432.678366081584;6446.5165112615805;6453.515986300952 05:28:22 INFO - PID 5456 | |1;ext.html;810.8337790752896;848.6562942008485;890.5903284489133;1130.6551501791955;1142.9942850285747;30824.229394265156;41430;42632.57367426325;42701.57298427023;42803.78598107013;42952.14095718084;43078.13843723124;43221;43458.130837383236;43510.564894351126;7182.317679820422;7410.370118539904;7804.3756499479905;7814.960925195366;7816.491928024689;7643.197464266255;7741.303282704555;7747.3027427531515;7755;7759.301662850342;7708.57602831844;7781;7785.688572457095;7786.571738554378;7792.181820908808;7679.769606911774;7704.537727736298;7707.653155608011;7755.457118001742;7762.7671169865;7627.275408836152;7682.1549629540705;7691.192424795372;7704.499207551491;7710.884336734954;37617;37747.05632359185;37920.62079379226;38029.80985095084;38050.238995220214;3492.3015396920464;3545;3550.414181660023;3551.1299731565673;3553.076200187944;30489.847550762326;30498.54252186219;30540.236494087603;30584.694153058408;30595.23511912198;4985.35190425246;5000.62495312853;5018.422881368653;5054.469280725508;5069.062223488666;183741;183745;184427;185538;185652;46541;46549.30176047362;46558.301625475644;46562.30156547655;46618;48364.758176208896;48854.26718599224;48871.75564122156;48942;48944.51055489471;14510.564683059525;15484.303206355517;15728.370865165265;15771.29029193689;15818;12182;12187.695307617203;12609.432575534123;12656.936715316364;12657.810132848015;14108.224047677477;14130.788038179435;14139.85860141406;14191.858081419054;14318.928405358114;5664.20701101846;5812.854678633068;5842.620229685057;5846.356900740915;5877.23595932526;984.7882705218412;986.284943416032;994.9054839790208;1001.1940387987739;1024.51335615582;22725.204617838295;22941.541169176522;23070.65394019091;23072.423189420064;23127;1063.1760385700989;1103.3931337764197;1117.9044536354418;1121.3216004317433;1121.955121795119;12208.450619722134;12320.322382269062;12337.321447320484;12406.069544784177;12456.190347627557;228544;231374;231959;232351;233588;55279;56005.719971399885;56534.43465565374;56536.717316413975;56931.43068569344;1433.3693175002966;1478.2978085409345;1481.9629509262354;1482.2292407947807;1487.5462983790048;26452.86773566197;26780;27547.449051018466;27558.5866212003;27633.723662763114;37065.258694826494;37637.24725505529;37641;37647.81176094102;37694.246115078095;197701;199828;199958;200767;201033;30480.84759576188;30796.53805192879;30826.845865770527;30960.845195773876;33665;37721.62278377181;40026.39960400655;40785.79607101945;41541.584584153774;42679.35980960226;31559.368812624078;31926.201844954063;31955.840220798746;32299;32397;31871.840640797574;32349.191270218435;32371;32421.513677294388;32555.511667324536;34490.48264276088;34519.82740086384;34570;34697.653023470455;34717.652823472454;30081;30581.388372232876;30867.38265234638;31516.212094697818;31893;22472.77527224707;22758.544829102993;23183.53632927366;23285.53428931446;23495.530089398457 05:28:22 INFO - PID 5456 | |2;jquery.html;565.5390856451992;577.9104238842981;582.9941700582993;583.9591228613994;596.2010905386782;20841.791582084174;21904.780952190493;21906.89046554767;22005.11979520821;23350.18274360398;25351.746482535214;26103.73896261037;26244.343891402725;26334.473310533776;26343;6445.4843612511;6547.214334279893;6606.8017959461295;6611.504137189706;6617.040529123275;5972.343042265347;6259.029850373199;6488.675566221694;6491.188601424822;6516.446102081329;6469.223693156828;6477.805665830009;6481.189851268591;6484;6484.124643173182;6423.582467139668;6462.838429039288;6466.418022377985;6473.546851720382;6474.838129046764;6000.489958353545;6027.216461859974;6029.155918171459;6032.879342413127;6051.092336149569;28628.856855715796;28721.856390717912;29515.409691806042;30164.54753178704;30311.090667279797;1886.339781076626;1919.1076149590508;1920;1920.2127127877502;1926.1813729165049;18801.15394807223;19664.115114819866;19689.80310196894;19707.605847882962;19720.605587888163;2359.504504054151;2425.1390756281444;2491.6262560615874;2500.8874600643016;2503.699556053267;138663;143992;144042.27978860145;144159;144330.55669443277;14278;15068.773968390484;15070.547883563511;15219.695606088038;15655.295511701774;22615.54768904613;23857.40356491067;23893.92477338524;23957.880210599185;23972.64041039386;10425.635102771366;10507.737306567396;10516.842247366296;10541.736456588493;10653.627123050655;9644.324897257266;9658.517074146264;9825.557849896772;9882.555285012191;9900.752481188028;9139.634414623473;9361.204297634777;9426;9482.905170948203;9745.317827752131;2726.2230264374557;2727.5363188258043;2728.4952283827556;2778.6387769589824;2790.14900455359;962.6245764151986;984.5717113055844;992.7418871093568;992.8957459466797;995.8207522645994;19174.233030678617;19557.706634400496;19671.21315147407;19933.302334418226;24128.758712413;1045.994770026145;1046.8586740789897;1065.1798115451058;1065.7016035510069;1066.664000839733;11125.221234513507;11251.662450126509;11488.48301826403;11558.422078896021;11563.942180289214;501240;521031;525883;529555;530021;113903.43048284705;115108;117494;118506;120372.39813800875;1271.8855303022772;1289.3939848271298;1315.4146404849942;1317.5915466205315;1326.7412854493475;18154.364597239033;18162.72755908636;18255.361062362754;18308.72536911921;18578.163982620543;48242.27636585524;48257.27614085721;52208.73895630497;57571.1364329527;59758.40241597528;66950;67000.6649966747;67048.6647566759;67227;68617.65691171512;14393.208373539555;14564.344604493035;14713.411463541339;14771.335289912195;14783.630409239424;22963;23058.42353941098;23138.537229255657;23294.184703535295;23316.300510984696;18086.819131808512;18292.993885336433;18481.81518184801;19398.70901936444;19572.9021354898;17311.48065558035;17312.22095005753;17596.648067038845;17808;18160.364387246384;18914.243430262635;19813.90093049583;19888;19934.20263189456;19959;14680.77978830297;15077.246137692851;15242;15269.694606108038;15270.160141191896;18177.81822181761;18679.626407472046;18846.623067538298;18869;18873.90563047231 05:28:22 INFO - PID 5456 | |3;mootools.html;1364.3519328319046;1404.115407293405;1419.3896624451481;1420.1124297314186;1426.2440906319648;13657.931710341447;14079.296035198251;14279.000469967094;14283.928580357084;14290.857091429083;14024.298785060757;14721.484748033821;14746.26268686564;14764.704705905875;14823.925880370583;2711.2544050386155;2746.436980419009;2752.1330780803983;2765.363966287755;2770.252031951372;2465.790407815338;2768.6262354582177;2775.597538356947;2775.764060054898;2784.8886044558194;2716.5381885079487;2719.864006799652;2755.2973991632107;2760.2271364018106;2764.5714914188334;2636.6308716779668;2682.222155574881;2693.407450360927;2742.5190397185597;2754.944901101977;2384.988075059631;2392.808575313971;2416.830821842472;2417.758224177586;2420.636904464327;13910.374033168431;14036.649083772885;14088.366023528966;14106.788398173932;14145.434182632682;7520.661570229353;7749.186335434754;7810.531368117931;7810.609469526557;7813.492123011986;4975.179095449246;5144.794208231666;5244.8688782780355;5256.421793602701;5271.815486457956;1748.1346733366938;1782.6256486137927;1794.4257837492007;1837.825406586372;1849.3527265456983;23050;23269.88365058164;23301.883490582608;23334.64998025048;23398.415039623975;6563.671816409161;6620.470362370998;6622.37087476689;6716.83207919806;6746.291639377893;15696.76454853178;15767.605809854846;15794.21028948548;15817.36730530789;15843.128627925344;7589.848203036019;7770.184130666312;7774.883376749353;7783.104942931522;7793.9220607793195;7075.469339799432;7113.253108423541;7179.89230161548;7180.7845764627145;7184.137903451619;4894.437139728905;5125.333706618116;5136.897262054738;5137.588992880561;5165.560927321145;1579.7472404415469;1582.9737935442652;1588.4996226188714;1597.4089586852938;1624.3421414327217;906.3112034853559;907.6278725722422;928.1321963963716;934.1359242700474;935.8455854784021;7463.552186868806;7541.811454713676;8001.959990200012;8319.667213311399;8677.609507572175;989.6734077754323;990.2078337330252;990.5988074829705;1013.1995723378595;1030.860833787444;4466.508684044752;4534.59188673021;4607.124646317189;4640.466346370143;4676.158291507561;18261.178246978918;18709.625807483775;19450.416487505398;19456.805431945784;19462.22151113968;18797.15412806427;19385.127669254918;19401.611967760567;19450.610987780165;19694;10397.428141452292;10465.16278697687;10570.947145264225;10631.574737010587;10649.509068730384;7521.623918803928;7709.537427754352;8010.319122874388;8131.2681858633005;8306.792330191794;17056.57358566046;17104.315827366765;17254.482365529053;17383.304667813147;17399.652006960045;17127.314907403565;17188.14059297055;17278;17322.30710771555;17507.912460437616;9813.214942804701;9970.651027214013;10032.548535315782;10040.397576145455;10056.69829905104;12952.676183095122;12970.092093553361;12986.545470908473;12997;13280.335983200994;10537.104346130358;10666.413347265974;10763.730906727082;10782.406967616856;10982.780344392908;10453.738656533647;10594.841077383691;10729.356238625707;10753.677389678322;10805.189610779065;9566.234701224024;9638.807223855623;9642.566084526354;9648.71053868385;9652.27607929422;6626.6686665667485;6638.601683898982;6674.966625166843;6679.398854103154;6682.665866706742;7561.584112873845;7582.696692132253;7646.847063058819;7696.884546731691;7707.653155607899 05:28:22 INFO - PID 5456 | |4;prototype.html;463.89098561837983;488.2212870471599;495.99313393810564;498.61357447977815;502.18896482181276;6120.724567394467;6171.845703857401;6248.656323902189;6265.5927364721265;6269.369963809409;5837.270341207349;5964.671943043142;5985.5810093293485;6013.51891848651;6026.126211699301;4853.660243782937;4857.761270875922;4859.586935110511;4920.581750551208;4921.80312787488;4761.928571071437;4885.462599114095;4889.386502454199;4903.313536104948;4908.141075311824;4787.186178349689;4852.199387101124;4858.927116093261;4866.878328041792;4867.756612169377;4856.300294896775;4881.804727810883;4882.267659851033;4886.291487734295;4912.36139301892;4337.804798784062;4340.631046361063;4345.8700737808085;4370.344448332776;4388.078503514266;5861.970690146564;5876.265466816648;5897.52819774417;5905.143754155666;5928.318243401977;5624.859378515529;5672.716364181816;5676.574256930706;5677.5522241828485;5687.886242275173;6367.713452894631;6386.13787138735;6425.967870160619;6427.710753016126;6480.967595162041;4791.784369703337;4834.419869615669;4835.9032819343765;4861.100696371147;4869.659123861331;6930.826729331757;6997.265287144878;7016.122984626922;7027.297270272983;7044.788656340318;4904.60763138948;4923.8276660316715;4932.482089380564;4935.7532123393685;5033;4983.626228032839;5002.324686167393;5020.046191223656;5025.623078269145;5064.417591976896;5655.971720141455;5659.5755318351285;5671.914921276184;5683.801066962719;5692.14617807324;6488.28628850826;6526.184226971629;6535.5425120241125;6551.21385433751;6553.934460655332;1678.471281546309;1699.4986478988728;1726.6460375622967;1727.0587529796292;1740.3821643316694;1185.1644590563633;1206.77071356442;1224.663217615163;1226.920250183753;1227.6071657069651;5650.152477128381;5659.830205093854;5694.800681976194;5710.172025056427;5740.712964351849;6554.541182117301;6601.141851559267;6624;6708.832279192961;6767.0901512350165;5746.569007324468;5779.306483222041;5782.508486778587;5809.240610709879;5822.941770582324;3564.821758912096;3581.5344005279667;3598.604153543108;3610.6028336882923;3632.654897784706;6535.150430444012;6559.278479367265;6575.934240657532;6587.868242635216;6599.406053455212;6845.555038922554;6943.513954023271;6976.860462790716;6983.266756990544;6994.125734283215;6423.357664233539;6477.449416799436;6506.121673574102;6538.738450461929;6562.639054852029;6744;6747.730090796509;6757.600427531845;6781.457483401415;6827.351401616838;6662.2351724035925;6666.366695163952;6670.665267156456;6702.19573651165;6723.327667233238;6524.804255872332;6577.243616983917;6591.143151390289;6600.80197594073;6629.900551491828;4905.847125925476;4933.333999909966;4943.442815513102;4950.702957822542;4977.776000079933;6811.931880681328;6820.590764554143;6827.351401616838;6827.726890924506;6850.074685396996;6560.639164845979;6597.373249541286;6616.338366163345;6618.503612229199;6626.668666566556;6223.3465486125115;6418;6479.222493300834;6492.513061520311;6496.545241833026;5921.3782552831335;6248.656323902047;6253.96873015632;6406.263279722892;6410.910145275408;6389.185840884773;6576.539642224999;6586.269945147561;6612.206535215805;6643.202815662152;6282.86382629908;6330.620162790247;6333.619982800862;6356.792209480184;6418.454431373386 05:28:22 INFO - PID 5456 | |5;yui.html;643.4209211709461;643.7167646235657;659.4592434203952;904.0913881549042;906.0667512462159;16470.752938705915;16737.665246695058;16873.83126168738;16893.746593801105;21805.781942180573;21211;22049.559008819815;22159.113635454563;22223.66664500034;22274.88862555685;1040.8750949886025;1057.1014637558092;1060.3955745225226;1061.050359927864;1063.6915294564606;1046.2048842879428;1046.7592453735645;1048.9895101049005;1050.0811789684026;1051.2903789941797;1056.7727938493222;1125.673554669145;1129.3280498103616;1133.5465813674514;1134.1777211521664;1120.456578559398;1120.9775804483907;1122.4836575175389;1122.854028976228;1124.3197865291504;800.8998875140608;802.1657476224719;802.502448481939;802.5345299726145;802.8514724775935;19219.423417297505;19547.413577592695;19652.11565479557;19745.901270493556;20115;21741.2390566331;21860.234891778713;22227.333180004465;22387.888060559755;22395.32814015582;16404.507864764077;16802.747958780627;16827.242774075195;17031.318747250094;17047.744283835753;3492.2491664292297;3522.6125126236093;3524.859005639771;3533.134382076382;3540.309639620275;123880;126902;128132;128256;130361;16580.75128873068;16655.6668866622;16772.496825095266;16925.7461138083;16968;30747.538786918216;31040.53439198414;31154.376912461623;31200.68799312023;31241.218969525944;7625.733099341496;7920.801979950432;8266.751997440086;8367.246947774729;8454.32365410778;4252.340887162495;4318.5033721121845;4348.34774783785;4349.064951035542;4363.629091527192;5213.2701421800975;5308.256844041837;5335.706536140549;5341.118715411992;5347.839564813062;1056.7252514346171;1075.8816530181673;1086.3481910853582;1088.8911108889206;1089.9155340436157;635.5519358851998;663.4294506724214;676.1345477788439;678.6606696651675;684.1789852177407;11408.258463199865;12236.755264894653;12455.501779928883;12872.098953073382;13035.543755968496;700.9264027277164;702.5082442290417;706.0997228533661;716.4053835316674;720.989185162223;5584.21820945068;5598.384177740445;5669.886602267931;5691.715414229272;5738.053221218535;104168.47915760524;105210.94789052011;105486;105766;107666;95385.99999999862;96471.51764241135;96680;96927.51536242274;97843.51078244564;81562;83011;85232.14767852366;85402;85602;11237.71905702364;11377.601783937522;11488.597899073493;11524.481398337262;11558.30650160993;36519.26961460703;37867.431988519646;38263;38294.89378084121;38385.616143838204;64362;65238;66046.33953660402;69141.58004469819;69805.30194697987;18936.43190704281;19222.519437014187;19589.70615440741;20271.391858244275;20277.59444811125;18659.626807464047;18967.457890490507;19492.05079492096;21594.784052159277;22118.694155685767;19137.617247655246;19347.709784353527;19553.315633953312;20031.799682002995;20277;19846.50383740418;20037.699434508784;20241.089150988537;20604.690929635766;20668.79331206729;18783.624327513648;18864.24543018264;19361;19425.320113796515;19762.308319208758;13493.932530337679;13796.862031379958;13830.446782129005;13981;14333.993240946067;14802.925985370004;14810.333534991167;14860.479883204469;14931.17878516692;15099.24503774829 05:28:22 INFO - PID 5456 | __end_tp_report 05:28:22 INFO - PID 5456 | __start_cc_report 05:28:22 INFO - PID 5456 | _x_x_mozilla_cycle_collect,395 05:28:22 INFO - PID 5456 | __end_cc_report 05:28:22 INFO - PID 5456 | __startTimestamp1502108902283__endTimestamp 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | ------- Summary: start ------- 05:28:22 INFO - PID 5456 | Number of tests: 6 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#0] dojo.html Cycles:165 Average:6171.88 Median:6446.52 stddev:729.66 (11.3%) stddev-sans-first:692.20 05:28:22 INFO - PID 5456 | Values: 3145.7 3184.6 3187.7 3190.0 3250.3 6120.8 6123.1 6142.7 6143.4 6310.2 6229.6 6292.0 6326.0 6356.5 6358.3 5561.5 5696.3 5710.7 5776.8 5780.7 5632.7 5639.5 5695.3 5706.3 5767.1 5673.7 5711.2 5712.4 5749.3 5757.3 5633.6 5702.4 5717.6 5740.5 5767.5 5554.6 5603.8 5647.3 5678.3 5679.9 6120.6 6151.2 6160.3 6164.0 6177.1 6730.8 6767.7 6782.9 6784.7 6821.1 6776.4 6779.1 6781.6 6863.1 6887.0 6176.8 6246.9 6282.0 6285.7 6347.1 6875.8 6887.3 6892.6 6897.2 6900.4 6450.8 6581.6 6627.0 6641.0 6641.3 6675.2 6713.7 6727.9 6731.9 6761.0 6619.2 6655.7 6676.6 6708.5 6709.9 6605.7 6638.3 6665.8 6718.2 6735.2 5411.2 5503.6 5505.9 5506.0 5530.5 4565.3 4606.5 4645.6 4675.1 4735.0 5794.8 5812.7 5818.2 5834.0 5861.4 6716.5 6808.1 6814.4 6815.5 6819.6 5781.4 5810.8 5845.0 5862.1 5881.6 5805.1 5913.0 5916.1 5930.7 5977.4 6439.9 6488.5 6507.5 6518.8 6524.9 6701.3 6704.4 6728.4 6731.4 6743.8 6483.9 6490.6 6567.0 6573.4 6576.4 6535.8 6589.6 6592.2 6635.6 6698.2 6701.0 6703.5 6715.7 6750.8 6764.5 6381.9 6492.2 6493.5 6503.7 6517.9 6016.8 6456.3 6466.8 6512.9 6548.9 6419.0 6497.9 6498.1 6500.1 6527.2 6558.1 6562.4 6609.2 6611.9 6660.7 6368.6 6371.7 6432.7 6446.5 6453.5 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#1] ext.html Cycles:180 Average:37329.17 Median:34505.16 stddev:53445.01 (154.9%) stddev-sans-first:53524.59 05:28:22 INFO - PID 5456 | Values: 810.8 848.7 890.6 1130.7 1143.0 30824.2 41430.0 42632.6 42701.6 42803.8 42952.1 43078.1 43221.0 43458.1 43510.6 7182.3 7410.4 7804.4 7815.0 7816.5 7643.2 7741.3 7747.3 7755.0 7759.3 7708.6 7781.0 7785.7 7786.6 7792.2 7679.8 7704.5 7707.7 7755.5 7762.8 7627.3 7682.2 7691.2 7704.5 7710.9 37617.0 37747.1 37920.6 38029.8 38050.2 3492.3 3545.0 3550.4 3551.1 3553.1 30489.8 30498.5 30540.2 30584.7 30595.2 4985.4 5000.6 5018.4 5054.5 5069.1 183741.0 183745.0 184427.0 185538.0 185652.0 46541.0 46549.3 46558.3 46562.3 46618.0 48364.8 48854.3 48871.8 48942.0 48944.5 14510.6 15484.3 15728.4 15771.3 15818.0 12182.0 12187.7 12609.4 12656.9 12657.8 14108.2 14130.8 14139.9 14191.9 14318.9 5664.2 5812.9 5842.6 5846.4 5877.2 984.8 986.3 994.9 1001.2 1024.5 22725.2 22941.5 23070.7 23072.4 23127.0 1063.2 1103.4 1117.9 1121.3 1122.0 12208.5 12320.3 12337.3 12406.1 12456.2 228544.0 231374.0 231959.0 232351.0 233588.0 55279.0 56005.7 56534.4 56536.7 56931.4 1433.4 1478.3 1482.0 1482.2 1487.5 26452.9 26780.0 27547.4 27558.6 27633.7 37065.3 37637.2 37641.0 37647.8 37694.2 197701.0 199828.0 199958.0 200767.0 201033.0 30480.8 30796.5 30826.8 30960.8 33665.0 37721.6 40026.4 40785.8 41541.6 42679.4 31559.4 31926.2 31955.8 32299.0 32397.0 31871.8 32349.2 32371.0 32421.5 32555.5 34490.5 34519.8 34570.0 34697.7 34717.7 30081.0 30581.4 30867.4 31516.2 31893.0 22472.8 22758.5 23183.5 23285.5 23495.5 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#2] jquery.html Cycles:180 Average:35793.71 Median:23098.48 stddev:87574.47 (379.1%) stddev-sans-first:87780.20 05:28:22 INFO - PID 5456 | Values: 565.5 577.9 583.0 584.0 596.2 20841.8 21904.8 21906.9 22005.1 23350.2 25351.7 26103.7 26244.3 26334.5 26343.0 6445.5 6547.2 6606.8 6611.5 6617.0 5972.3 6259.0 6488.7 6491.2 6516.4 6469.2 6477.8 6481.2 6484.0 6484.1 6423.6 6462.8 6466.4 6473.5 6474.8 6000.5 6027.2 6029.2 6032.9 6051.1 28628.9 28721.9 29515.4 30164.5 30311.1 1886.3 1919.1 1920.0 1920.2 1926.2 18801.2 19664.1 19689.8 19707.6 19720.6 2359.5 2425.1 2491.6 2500.9 2503.7 138663.0 143992.0 144042.3 144159.0 144330.6 14278.0 15068.8 15070.5 15219.7 15655.3 22615.5 23857.4 23893.9 23957.9 23972.6 10425.6 10507.7 10516.8 10541.7 10653.6 9644.3 9658.5 9825.6 9882.6 9900.8 9139.6 9361.2 9426.0 9482.9 9745.3 2726.2 2727.5 2728.5 2778.6 2790.1 962.6 984.6 992.7 992.9 995.8 19174.2 19557.7 19671.2 19933.3 24128.8 1046.0 1046.9 1065.2 1065.7 1066.7 11125.2 11251.7 11488.5 11558.4 11563.9 501240.0 521031.0 525883.0 529555.0 530021.0 113903.4 115108.0 117494.0 118506.0 120372.4 1271.9 1289.4 1315.4 1317.6 1326.7 18154.4 18162.7 18255.4 18308.7 18578.2 48242.3 48257.3 52208.7 57571.1 59758.4 66950.0 67000.7 67048.7 67227.0 68617.7 14393.2 14564.3 14713.4 14771.3 14783.6 22963.0 23058.4 23138.5 23294.2 23316.3 18086.8 18293.0 18481.8 19398.7 19572.9 17311.5 17312.2 17596.6 17808.0 18160.4 18914.2 19813.9 19888.0 19934.2 19959.0 14680.8 15077.2 15242.0 15269.7 15270.2 18177.8 18679.6 18846.6 18869.0 18873.9 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#3] mootools.html Cycles:180 Average:8716.99 Median:2551.21 stddev:5949.51 (233.2%) stddev-sans-first:5940.55 05:28:22 INFO - PID 5456 | Values: 1364.4 1404.1 1419.4 1420.1 1426.2 13657.9 14079.3 14279.0 14283.9 14290.9 14024.3 14721.5 14746.3 14764.7 14823.9 2711.3 2746.4 2752.1 2765.4 2770.3 2465.8 2768.6 2775.6 2775.8 2784.9 2716.5 2719.9 2755.3 2760.2 2764.6 2636.6 2682.2 2693.4 2742.5 2754.9 2385.0 2392.8 2416.8 2417.8 2420.6 13910.4 14036.6 14088.4 14106.8 14145.4 7520.7 7749.2 7810.5 7810.6 7813.5 4975.2 5144.8 5244.9 5256.4 5271.8 1748.1 1782.6 1794.4 1837.8 1849.4 23050.0 23269.9 23301.9 23334.6 23398.4 6563.7 6620.5 6622.4 6716.8 6746.3 15696.8 15767.6 15794.2 15817.4 15843.1 7589.8 7770.2 7774.9 7783.1 7793.9 7075.5 7113.3 7179.9 7180.8 7184.1 4894.4 5125.3 5136.9 5137.6 5165.6 1579.7 1583.0 1588.5 1597.4 1624.3 906.3 907.6 928.1 934.1 935.8 7463.6 7541.8 8002.0 8319.7 8677.6 989.7 990.2 990.6 1013.2 1030.9 4466.5 4534.6 4607.1 4640.5 4676.2 18261.2 18709.6 19450.4 19456.8 19462.2 18797.2 19385.1 19401.6 19450.6 19694.0 10397.4 10465.2 10570.9 10631.6 10649.5 7521.6 7709.5 8010.3 8131.3 8306.8 17056.6 17104.3 17254.5 17383.3 17399.7 17127.3 17188.1 17278.0 17322.3 17507.9 9813.2 9970.7 10032.5 10040.4 10056.7 12952.7 12970.1 12986.5 12997.0 13280.3 10537.1 10666.4 10763.7 10782.4 10982.8 10453.7 10594.8 10729.4 10753.7 10805.2 9566.2 9638.8 9642.6 9648.7 9652.3 6626.7 6638.6 6675.0 6679.4 6682.7 7561.6 7582.7 7646.8 7696.9 7707.7 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#4] prototype.html Cycles:180 Average:5476.93 Median:5924.85 stddev:1558.03 (26.3%) stddev-sans-first:1516.28 05:28:22 INFO - PID 5456 | Values: 463.9 488.2 496.0 498.6 502.2 6120.7 6171.8 6248.7 6265.6 6269.4 5837.3 5964.7 5985.6 6013.5 6026.1 4853.7 4857.8 4859.6 4920.6 4921.8 4761.9 4885.5 4889.4 4903.3 4908.1 4787.2 4852.2 4858.9 4866.9 4867.8 4856.3 4881.8 4882.3 4886.3 4912.4 4337.8 4340.6 4345.9 4370.3 4388.1 5862.0 5876.3 5897.5 5905.1 5928.3 5624.9 5672.7 5676.6 5677.6 5687.9 6367.7 6386.1 6426.0 6427.7 6481.0 4791.8 4834.4 4835.9 4861.1 4869.7 6930.8 6997.3 7016.1 7027.3 7044.8 4904.6 4923.8 4932.5 4935.8 5033.0 4983.6 5002.3 5020.0 5025.6 5064.4 5656.0 5659.6 5671.9 5683.8 5692.1 6488.3 6526.2 6535.5 6551.2 6553.9 1678.5 1699.5 1726.6 1727.1 1740.4 1185.2 1206.8 1224.7 1226.9 1227.6 5650.2 5659.8 5694.8 5710.2 5740.7 6554.5 6601.1 6624.0 6708.8 6767.1 5746.6 5779.3 5782.5 5809.2 5822.9 3564.8 3581.5 3598.6 3610.6 3632.7 6535.2 6559.3 6575.9 6587.9 6599.4 6845.6 6943.5 6976.9 6983.3 6994.1 6423.4 6477.4 6506.1 6538.7 6562.6 6744.0 6747.7 6757.6 6781.5 6827.4 6662.2 6666.4 6670.7 6702.2 6723.3 6524.8 6577.2 6591.1 6600.8 6629.9 4905.8 4933.3 4943.4 4950.7 4977.8 6811.9 6820.6 6827.4 6827.7 6850.1 6560.6 6597.4 6616.3 6618.5 6626.7 6223.3 6418.0 6479.2 6492.5 6496.5 5921.4 6248.7 6254.0 6406.3 6410.9 6389.2 6576.5 6586.3 6612.2 6643.2 6282.9 6330.6 6333.6 6356.8 6418.5 05:28:22 INFO - PID 5456 | 05:28:22 INFO - PID 5456 | [#5] yui.html Cycles:180 Average:23664.14 Median:20178.04 stddev:31558.13 (156.4%) stddev-sans-first:31599.31 05:28:22 INFO - PID 5456 | Values: 643.4 643.7 659.5 904.1 906.1 16470.8 16737.7 16873.8 16893.7 21805.8 21211.0 22049.6 22159.1 22223.7 22274.9 1040.9 1057.1 1060.4 1061.1 1063.7 1046.2 1046.8 1049.0 1050.1 1051.3 1056.8 1125.7 1129.3 1133.5 1134.2 1120.5 1121.0 1122.5 1122.9 1124.3 800.9 802.2 802.5 802.5 802.9 19219.4 19547.4 19652.1 19745.9 20115.0 21741.2 21860.2 22227.3 22387.9 22395.3 16404.5 16802.7 16827.2 17031.3 17047.7 3492.2 3522.6 3524.9 3533.1 3540.3 123880.0 126902.0 128132.0 128256.0 130361.0 16580.8 16655.7 16772.5 16925.7 16968.0 30747.5 31040.5 31154.4 31200.7 31241.2 7625.7 7920.8 8266.8 8367.2 8454.3 4252.3 4318.5 4348.3 4349.1 4363.6 5213.3 5308.3 5335.7 5341.1 5347.8 1056.7 1075.9 1086.3 1088.9 1089.9 635.6 663.4 676.1 678.7 684.2 11408.3 12236.8 12455.5 12872.1 13035.5 700.9 702.5 706.1 716.4 721.0 5584.2 5598.4 5669.9 5691.7 5738.1 104168.5 105210.9 105486.0 105766.0 107666.0 95386.0 96471.5 96680.0 96927.5 97843.5 81562.0 83011.0 85232.1 85402.0 85602.0 11237.7 11377.6 11488.6 11524.5 11558.3 36519.3 37867.4 38263.0 38294.9 38385.6 64362.0 65238.0 66046.3 69141.6 69805.3 18936.4 19222.5 19589.7 20271.4 20277.6 18659.6 18967.5 19492.1 21594.8 22118.7 19137.6 19347.7 19553.3 20031.8 20277.0 19846.5 20037.7 20241.1 20604.7 20668.8 18783.6 18864.2 19361.0 19425.3 19762.3 13493.9 13796.9 13830.4 13981.0 14334.0 14802.9 14810.3 14860.5 14931.2 15099.2 05:28:22 INFO - PID 5456 | -------- Summary: end -------- 05:28:22 INFO - PID 5456 | 05:28:22 INFO - TEST-INFO | 5456: exit 0 05:28:22 INFO - TEST-OK | dromaeo_css | took 1112904ms 05:28:22 INFO - TEST-START | kraken 05:28:22 INFO - Initialising browser for kraken test... 05:28:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50399/getInfo.html -profile /tmp/tmphQ0cf7/profile 05:28:23 INFO - TEST-INFO | started process 5837 (/builds/slave/test/build/application/firefox/firefox http://localhost:50399/getInfo.html) 05:28:28 INFO - TEST-INFO | 5837: exit 0 05:28:28 INFO - Browser initialized. 05:28:28 INFO - Running cycle 1/1 for kraken test... 05:28:28 INFO - TEST-INFO | started process 6061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphQ0cf7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:29 INFO - PID 6061 | 05:28:29 INFO - PID 6061 | (/builds/slave/test/build/application/firefox/firefox:6117): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:28:29 INFO - PID 6061 | 05:28:40 INFO - PID 6061 | RSS: Main: 174379008 05:28:40 INFO - PID 6061 | 05:28:40 INFO - PID 6061 | serialization: Helvetica 05:28:40 INFO - PID 6061 | serialization: Arial 05:28:42 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50399/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:43 INFO - PID 6061 | RSS: Main: 178737152 05:28:43 INFO - PID 6061 | 05:28:43 INFO - PID 6061 | serialization: Helvetica 05:28:43 INFO - PID 6061 | serialization: Arial 05:28:46 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50399/tests/kraken/driver.html?testName=audio-dft) 05:28:47 INFO - PID 6061 | RSS: Main: 179310592 05:28:47 INFO - PID 6061 | 05:28:47 INFO - PID 6061 | serialization: Helvetica 05:28:47 INFO - PID 6061 | serialization: Arial 05:28:50 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50399/tests/kraken/driver.html?testName=audio-fft) 05:28:50 INFO - PID 6061 | RSS: Main: 174280704 05:28:50 INFO - PID 6061 | 05:28:50 INFO - PID 6061 | serialization: Helvetica 05:28:50 INFO - PID 6061 | serialization: Arial 05:28:53 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50399/tests/kraken/driver.html?testName=audio-oscillator) 05:28:53 INFO - PID 6061 | RSS: Main: 174522368 05:28:53 INFO - PID 6061 | 05:28:53 INFO - PID 6061 | serialization: Helvetica 05:28:53 INFO - PID 6061 | serialization: Arial 05:28:55 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50399/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:56 INFO - PID 6061 | RSS: Main: 175095808 05:28:56 INFO - PID 6061 | 05:28:56 INFO - PID 6061 | serialization: Helvetica 05:28:56 INFO - PID 6061 | serialization: Arial 05:28:59 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50399/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:00 INFO - PID 6061 | RSS: Main: 177328128 05:29:00 INFO - PID 6061 | 05:29:00 INFO - PID 6061 | serialization: Helvetica 05:29:00 INFO - PID 6061 | serialization: Arial 05:29:03 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50399/tests/kraken/driver.html?testName=imaging-desaturate) 05:29:04 INFO - PID 6061 | RSS: Main: 176992256 05:29:04 INFO - PID 6061 | 05:29:04 INFO - PID 6061 | serialization: Helvetica 05:29:04 INFO - PID 6061 | serialization: Arial 05:29:07 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50399/tests/kraken/driver.html?testName=json-parse-financial) 05:29:08 INFO - PID 6061 | RSS: Main: 177606656 05:29:08 INFO - PID 6061 | 05:29:08 INFO - PID 6061 | serialization: Helvetica 05:29:08 INFO - PID 6061 | serialization: Arial 05:29:09 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50399/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:29:10 INFO - PID 6061 | RSS: Main: 178032640 05:29:10 INFO - PID 6061 | 05:29:10 INFO - PID 6061 | serialization: Helvetica 05:29:10 INFO - PID 6061 | serialization: Arial 05:29:12 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:29:12 INFO - PID 6061 | RSS: Main: 175734784 05:29:12 INFO - PID 6061 | 05:29:13 INFO - PID 6061 | serialization: Helvetica 05:29:13 INFO - PID 6061 | serialization: Arial 05:29:15 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:15 INFO - PID 6061 | RSS: Main: 175079424 05:29:15 INFO - PID 6061 | 05:29:15 INFO - PID 6061 | serialization: Helvetica 05:29:15 INFO - PID 6061 | serialization: Arial 05:29:18 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:19 INFO - PID 6061 | RSS: Main: 175214592 05:29:19 INFO - PID 6061 | 05:29:19 INFO - PID 6061 | serialization: Helvetica 05:29:19 INFO - PID 6061 | serialization: Arial 05:29:22 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:23 INFO - PID 6061 | RSS: Main: 175394816 05:29:23 INFO - PID 6061 | 05:29:23 INFO - PID 6061 | serialization: Helvetica 05:29:23 INFO - PID 6061 | serialization: Arial 05:29:25 INFO - PID 6061 | Cycle 1(1): loaded http://localhost:50399/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50399/tests/kraken/driver.html?testName=ai-astar) 05:29:25 INFO - PID 6061 | RSS: Main: 176648192 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | __start_tp_report 05:29:25 INFO - PID 6061 | _x_x_mozilla_page_load 05:29:25 INFO - PID 6061 | _x_x_mozilla_page_load_details 05:29:25 INFO - PID 6061 | |i|pagename|runs| 05:29:25 INFO - PID 6061 | |0;ai-astar;98;106;108;108;115;120;107;100;112;108 05:29:25 INFO - PID 6061 | |1;audio-beat-detection;145;117;142;183;118;147;150;120;176;124 05:29:25 INFO - PID 6061 | |2;audio-dft;162;164;166;171;165;171;169;168;164;164 05:29:25 INFO - PID 6061 | |3;audio-fft;73;76;74;167;77;82;81;74;159;76 05:29:25 INFO - PID 6061 | |4;audio-oscillator;79;78;129;79;79;79;142;78;80;132 05:29:25 INFO - PID 6061 | |5;imaging-gaussian-blur;118;114;117;113;115;116;115;114;114;118 05:29:25 INFO - PID 6061 | |6;imaging-darkroom;158;156;151;153;150;151;150;152;152;151 05:29:25 INFO - PID 6061 | |7;imaging-desaturate;99;94;94;94;94;99;93;94;93;102 05:29:25 INFO - PID 6061 | |8;json-parse-financial;56;54;63;53;54;61;53;56;53;60 05:29:25 INFO - PID 6061 | |9;json-stringify-tinderbox;55;54;54;59;54;59;59;54;54;55 05:29:25 INFO - PID 6061 | |10;stanford-crypto-aes;79;91;78;90;86;98;85;87;80;86 05:29:25 INFO - PID 6061 | |11;stanford-crypto-ccm;130;138;126;143;127;128;126;132;127;174 05:29:25 INFO - PID 6061 | |12;stanford-crypto-pbkdf2;187;172;175;183;173;171;172;179;174;170 05:29:25 INFO - PID 6061 | |13;stanford-crypto-sha256-iterative;74;70;84;68;71;67;68;68;68;66 05:29:25 INFO - PID 6061 | __end_tp_report 05:29:25 INFO - PID 6061 | __start_cc_report 05:29:25 INFO - PID 6061 | _x_x_mozilla_cycle_collect,954 05:29:25 INFO - PID 6061 | __end_cc_report 05:29:25 INFO - PID 6061 | __startTimestamp1502108965299__endTimestamp 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | ------- Summary: start ------- 05:29:25 INFO - PID 6061 | Number of tests: 14 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.00 stddev:6.48 (5.9%) stddev-sans-first:5.72 05:29:25 INFO - PID 6061 | Values: 98.0 106.0 108.0 108.0 115.0 120.0 107.0 100.0 112.0 108.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:146.00 stddev:23.44 (16.1%) stddev-sans-first:24.84 05:29:25 INFO - PID 6061 | Values: 145.0 117.0 142.0 183.0 118.0 147.0 150.0 120.0 176.0 124.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#2] audio-dft Cycles:10 Average:166.40 Median:167.00 stddev:3.17 (1.9%) stddev-sans-first:2.93 05:29:25 INFO - PID 6061 | Values: 162.0 164.0 166.0 171.0 165.0 171.0 169.0 168.0 164.0 164.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:36.58 (48.1%) stddev-sans-first:38.01 05:29:25 INFO - PID 6061 | Values: 73.0 76.0 74.0 167.0 77.0 82.0 81.0 74.0 159.0 76.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.00 stddev:26.99 (34.2%) stddev-sans-first:27.96 05:29:25 INFO - PID 6061 | Values: 79.0 78.0 129.0 79.0 79.0 79.0 142.0 78.0 80.0 132.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.50 stddev:1.78 (1.5%) stddev-sans-first:1.62 05:29:25 INFO - PID 6061 | Values: 118.0 114.0 117.0 113.0 115.0 116.0 115.0 114.0 114.0 118.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.00 stddev:2.63 (1.7%) stddev-sans-first:1.86 05:29:25 INFO - PID 6061 | Values: 158.0 156.0 151.0 153.0 150.0 151.0 150.0 152.0 152.0 151.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:94.00 stddev:3.17 (3.4%) stddev-sans-first:3.11 05:29:25 INFO - PID 6061 | Values: 99.0 94.0 94.0 94.0 94.0 99.0 93.0 94.0 93.0 102.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:3.71 (6.6%) stddev-sans-first:3.94 05:29:25 INFO - PID 6061 | Values: 56.0 54.0 63.0 53.0 54.0 61.0 53.0 56.0 53.0 60.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.31 (4.2%) stddev-sans-first:2.44 05:29:25 INFO - PID 6061 | Values: 55.0 54.0 54.0 59.0 54.0 59.0 59.0 54.0 54.0 55.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:86.50 stddev:6.11 (7.1%) stddev-sans-first:5.93 05:29:25 INFO - PID 6061 | Values: 79.0 91.0 78.0 90.0 86.0 98.0 85.0 87.0 80.0 86.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:131.00 stddev:14.78 (11.3%) stddev-sans-first:15.56 05:29:25 INFO - PID 6061 | Values: 130.0 138.0 126.0 143.0 127.0 128.0 126.0 132.0 127.0 174.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:174.50 stddev:5.62 (3.2%) stddev-sans-first:4.18 05:29:25 INFO - PID 6061 | Values: 187.0 172.0 175.0 183.0 173.0 171.0 172.0 179.0 174.0 170.0 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:69.00 stddev:5.30 (7.7%) stddev-sans-first:5.45 05:29:25 INFO - PID 6061 | Values: 74.0 70.0 84.0 68.0 71.0 67.0 68.0 68.0 68.0 66.0 05:29:25 INFO - PID 6061 | -------- Summary: end -------- 05:29:25 INFO - PID 6061 | 05:29:25 INFO - PID 6061 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:29:25 INFO - TEST-INFO | 6061: exit 0 05:29:26 INFO - TEST-OK | kraken | took 63054ms 05:29:26 INFO - SUITE-END | took 1175s 05:29:26 INFO - Completed test suite (00:19:36) 05:29:26 INFO - javascript benchmark 05:29:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8494.918587474805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3145.6697046810086, 3184.601924759405, 3187.6812318768125, 3190.011096560065, 3250.2849373137915, 6120.816375508736, 6123.081537769337, 6142.692865356731, 6143.354947730491, 6310.179676642041, 6229.563930524865, 6292.0, 6326.0, 6356.459700925427, 6358.268799088106, 5561.5272701820395, 5696.287964004499, 5710.685912274813, 5776.82669519913, 5780.682062486561, 5632.718364081779, 5639.464250896158, 5695.259616249882, 5706.3437704663875, 5767.106098554731, 5673.6595804251465, 5711.228984087136, 5712.371639119693, 5749.31008279005, 5757.309122905257, 5633.577481688849, 5702.429757024264, 5717.599768016241, 5740.512056475204, 5767.452092051249, 5554.583406244507, 5603.80386686464, 5647.322321321468, 5678.290213723285, 5679.943200568024, 6120.632762034248, 6151.200343955302, 6160.260768707739, 6164.0, 6177.135201071854, 6730.764423245212, 6767.695453704595, 6782.898256526156, 6784.660766961632, 6821.079154314154, 6776.390124888734, 6779.084823548807, 6781.627010514419, 6863.10779598649, 6887.001384799176, 6176.7838125665385, 6246.87506249877, 6282.026285925689, 6285.748570057147, 6347.1114044033875, 6875.828104297332, 6887.311268873073, 6892.586444813327, 6897.172339319314, 6900.413464855443, 6450.8064758057335, 6581.572197807127, 6627.03907933347, 6640.966795165993, 6641.302663220389, 6675.1989761228, 6713.664316784141, 6727.865442691119, 6731.865362692719, 6761.019652150509, 6619.238787539494, 6655.73377064912, 6676.566023208476, 6708.496862735315, 6709.899351509731, 6605.669716514155, 6638.269790323061, 6665.833354166088, 6718.193816742022, 6735.191776986793, 5411.188321751769, 5503.559715222853, 5505.862353441196, 5506.0, 5530.5022547970875, 4565.338025986213, 4606.516315786861, 4645.581897629229, 4675.13510000651, 4734.981978874558, 5794.82615521535, 5812.680302583314, 5818.2436283282905, 5834.03738383162, 5861.384554621789, 6716.46268298535, 6808.11494505721, 6814.420774234147, 6815.488838337045, 6819.624920629314, 5781.392953739881, 5810.796622118206, 5845.035569131046, 5862.091375836752, 5881.5882888198275, 5805.10020946754, 5912.970435147797, 5916.083007133901, 5930.673812940244, 5977.432143946318, 6439.9356006440275, 6488.545801793829, 6507.511936604679, 6518.837029074311, 6524.869502609921, 6701.3298670134545, 6704.4301234395625, 6728.428083612947, 6731.394174524316, 6743.831404214934, 6483.870322593616, 6490.610563366213, 6567.047778072249, 6573.441257493167, 6576.375244351779, 6535.803925882231, 6589.6375699336995, 6592.208934927839, 6635.6350400728425, 6698.229703583956, 6701.028350889192, 6703.463722902058, 6715.664216789239, 6750.763723269662, 6764.4588432924265, 6381.8723625528155, 6492.188476440445, 6493.480521558169, 6503.674816259263, 6517.8696426072165, 6016.817309803038, 6456.322086180883, 6466.838329041811, 6512.869742605027, 6548.869022619616, 6419.0, 6497.935020649733, 6498.122753428227, 6500.089987401862, 6527.216733991761, 6558.081868538313, 6562.442192413699, 6609.173853268341, 6611.933880661132, 6660.733570657119, 6368.617882927039, 6371.74513019474, 6432.678366081584, 6446.5165112615805, 6453.515986300952], "value": 6117.411621070894, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [810.8337790752896, 848.6562942008485, 890.5903284489133, 1130.6551501791955, 1142.9942850285747, 30824.229394265156, 41430.0, 42632.57367426325, 42701.57298427023, 42803.78598107013, 42952.14095718084, 43078.13843723124, 43221.0, 43458.130837383236, 43510.564894351126, 7182.317679820422, 7410.370118539904, 7804.3756499479905, 7814.960925195366, 7816.491928024689, 7643.197464266255, 7741.303282704555, 7747.3027427531515, 7755.0, 7759.301662850342, 7708.57602831844, 7781.0, 7785.688572457095, 7786.571738554378, 7792.181820908808, 7679.769606911774, 7704.537727736298, 7707.653155608011, 7755.457118001742, 7762.7671169865, 7627.275408836152, 7682.1549629540705, 7691.192424795372, 7704.499207551491, 7710.884336734954, 37617.0, 37747.05632359185, 37920.62079379226, 38029.80985095084, 38050.238995220214, 3492.3015396920464, 3545.0, 3550.414181660023, 3551.1299731565673, 3553.076200187944, 30489.847550762326, 30498.54252186219, 30540.236494087603, 30584.694153058408, 30595.23511912198, 4985.35190425246, 5000.62495312853, 5018.422881368653, 5054.469280725508, 5069.062223488666, 183741.0, 183745.0, 184427.0, 185538.0, 185652.0, 46541.0, 46549.30176047362, 46558.301625475644, 46562.30156547655, 46618.0, 48364.758176208896, 48854.26718599224, 48871.75564122156, 48942.0, 48944.51055489471, 14510.564683059525, 15484.303206355517, 15728.370865165265, 15771.29029193689, 15818.0, 12182.0, 12187.695307617203, 12609.432575534123, 12656.936715316364, 12657.810132848015, 14108.224047677477, 14130.788038179435, 14139.85860141406, 14191.858081419054, 14318.928405358114, 5664.20701101846, 5812.854678633068, 5842.620229685057, 5846.356900740915, 5877.23595932526, 984.7882705218412, 986.284943416032, 994.9054839790208, 1001.1940387987739, 1024.51335615582, 22725.204617838295, 22941.541169176522, 23070.65394019091, 23072.423189420064, 23127.0, 1063.1760385700989, 1103.3931337764197, 1117.9044536354418, 1121.3216004317433, 1121.955121795119, 12208.450619722134, 12320.322382269062, 12337.321447320484, 12406.069544784177, 12456.190347627557, 228544.0, 231374.0, 231959.0, 232351.0, 233588.0, 55279.0, 56005.719971399885, 56534.43465565374, 56536.717316413975, 56931.43068569344, 1433.3693175002966, 1478.2978085409345, 1481.9629509262354, 1482.2292407947807, 1487.5462983790048, 26452.86773566197, 26780.0, 27547.449051018466, 27558.5866212003, 27633.723662763114, 37065.258694826494, 37637.24725505529, 37641.0, 37647.81176094102, 37694.246115078095, 197701.0, 199828.0, 199958.0, 200767.0, 201033.0, 30480.84759576188, 30796.53805192879, 30826.845865770527, 30960.845195773876, 33665.0, 37721.62278377181, 40026.39960400655, 40785.79607101945, 41541.584584153774, 42679.35980960226, 31559.368812624078, 31926.201844954063, 31955.840220798746, 32299.0, 32397.0, 31871.840640797574, 32349.191270218435, 32371.0, 32421.513677294388, 32555.511667324536, 34490.48264276088, 34519.82740086384, 34570.0, 34697.653023470455, 34717.652823472454, 30081.0, 30581.388372232876, 30867.38265234638, 31516.212094697818, 31893.0, 22472.77527224707, 22758.544829102993, 23183.53632927366, 23285.53428931446, 23495.530089398457], "value": 17107.287909691076, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.5390856451992, 577.9104238842981, 582.9941700582993, 583.9591228613994, 596.2010905386782, 20841.791582084174, 21904.780952190493, 21906.89046554767, 22005.11979520821, 23350.18274360398, 25351.746482535214, 26103.73896261037, 26244.343891402725, 26334.473310533776, 26343.0, 6445.4843612511, 6547.214334279893, 6606.8017959461295, 6611.504137189706, 6617.040529123275, 5972.343042265347, 6259.029850373199, 6488.675566221694, 6491.188601424822, 6516.446102081329, 6469.223693156828, 6477.805665830009, 6481.189851268591, 6484.0, 6484.124643173182, 6423.582467139668, 6462.838429039288, 6466.418022377985, 6473.546851720382, 6474.838129046764, 6000.489958353545, 6027.216461859974, 6029.155918171459, 6032.879342413127, 6051.092336149569, 28628.856855715796, 28721.856390717912, 29515.409691806042, 30164.54753178704, 30311.090667279797, 1886.339781076626, 1919.1076149590508, 1920.0, 1920.2127127877502, 1926.1813729165049, 18801.15394807223, 19664.115114819866, 19689.80310196894, 19707.605847882962, 19720.605587888163, 2359.504504054151, 2425.1390756281444, 2491.6262560615874, 2500.8874600643016, 2503.699556053267, 138663.0, 143992.0, 144042.27978860145, 144159.0, 144330.55669443277, 14278.0, 15068.773968390484, 15070.547883563511, 15219.695606088038, 15655.295511701774, 22615.54768904613, 23857.40356491067, 23893.92477338524, 23957.880210599185, 23972.64041039386, 10425.635102771366, 10507.737306567396, 10516.842247366296, 10541.736456588493, 10653.627123050655, 9644.324897257266, 9658.517074146264, 9825.557849896772, 9882.555285012191, 9900.752481188028, 9139.634414623473, 9361.204297634777, 9426.0, 9482.905170948203, 9745.317827752131, 2726.2230264374557, 2727.5363188258043, 2728.4952283827556, 2778.6387769589824, 2790.14900455359, 962.6245764151986, 984.5717113055844, 992.7418871093568, 992.8957459466797, 995.8207522645994, 19174.233030678617, 19557.706634400496, 19671.21315147407, 19933.302334418226, 24128.758712413, 1045.994770026145, 1046.8586740789897, 1065.1798115451058, 1065.7016035510069, 1066.664000839733, 11125.221234513507, 11251.662450126509, 11488.48301826403, 11558.422078896021, 11563.942180289214, 501240.0, 521031.0, 525883.0, 529555.0, 530021.0, 113903.43048284705, 115108.0, 117494.0, 118506.0, 120372.39813800875, 1271.8855303022772, 1289.3939848271298, 1315.4146404849942, 1317.5915466205315, 1326.7412854493475, 18154.364597239033, 18162.72755908636, 18255.361062362754, 18308.72536911921, 18578.163982620543, 48242.27636585524, 48257.27614085721, 52208.73895630497, 57571.1364329527, 59758.40241597528, 66950.0, 67000.6649966747, 67048.6647566759, 67227.0, 68617.65691171512, 14393.208373539555, 14564.344604493035, 14713.411463541339, 14771.335289912195, 14783.630409239424, 22963.0, 23058.42353941098, 23138.537229255657, 23294.184703535295, 23316.300510984696, 18086.819131808512, 18292.993885336433, 18481.81518184801, 19398.70901936444, 19572.9021354898, 17311.48065558035, 17312.22095005753, 17596.648067038845, 17808.0, 18160.364387246384, 18914.243430262635, 19813.90093049583, 19888.0, 19934.20263189456, 19959.0, 14680.77978830297, 15077.246137692851, 15242.0, 15269.694606108038, 15270.160141191896, 18177.81822181761, 18679.626407472046, 18846.623067538298, 18869.0, 18873.90563047231], "value": 12125.256898075522, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.3519328319046, 1404.115407293405, 1419.3896624451481, 1420.1124297314186, 1426.2440906319648, 13657.931710341447, 14079.296035198251, 14279.000469967094, 14283.928580357084, 14290.857091429083, 14024.298785060757, 14721.484748033821, 14746.26268686564, 14764.704705905875, 14823.925880370583, 2711.2544050386155, 2746.436980419009, 2752.1330780803983, 2765.363966287755, 2770.252031951372, 2465.790407815338, 2768.6262354582177, 2775.597538356947, 2775.764060054898, 2784.8886044558194, 2716.5381885079487, 2719.864006799652, 2755.2973991632107, 2760.2271364018106, 2764.5714914188334, 2636.6308716779668, 2682.222155574881, 2693.407450360927, 2742.5190397185597, 2754.944901101977, 2384.988075059631, 2392.808575313971, 2416.830821842472, 2417.758224177586, 2420.636904464327, 13910.374033168431, 14036.649083772885, 14088.366023528966, 14106.788398173932, 14145.434182632682, 7520.661570229353, 7749.186335434754, 7810.531368117931, 7810.609469526557, 7813.492123011986, 4975.179095449246, 5144.794208231666, 5244.8688782780355, 5256.421793602701, 5271.815486457956, 1748.1346733366938, 1782.6256486137927, 1794.4257837492007, 1837.825406586372, 1849.3527265456983, 23050.0, 23269.88365058164, 23301.883490582608, 23334.64998025048, 23398.415039623975, 6563.671816409161, 6620.470362370998, 6622.37087476689, 6716.83207919806, 6746.291639377893, 15696.76454853178, 15767.605809854846, 15794.21028948548, 15817.36730530789, 15843.128627925344, 7589.848203036019, 7770.184130666312, 7774.883376749353, 7783.104942931522, 7793.9220607793195, 7075.469339799432, 7113.253108423541, 7179.89230161548, 7180.7845764627145, 7184.137903451619, 4894.437139728905, 5125.333706618116, 5136.897262054738, 5137.588992880561, 5165.560927321145, 1579.7472404415469, 1582.9737935442652, 1588.4996226188714, 1597.4089586852938, 1624.3421414327217, 906.3112034853559, 907.6278725722422, 928.1321963963716, 934.1359242700474, 935.8455854784021, 7463.552186868806, 7541.811454713676, 8001.959990200012, 8319.667213311399, 8677.609507572175, 989.6734077754323, 990.2078337330252, 990.5988074829705, 1013.1995723378595, 1030.860833787444, 4466.508684044752, 4534.59188673021, 4607.124646317189, 4640.466346370143, 4676.158291507561, 18261.178246978918, 18709.625807483775, 19450.416487505398, 19456.805431945784, 19462.22151113968, 18797.15412806427, 19385.127669254918, 19401.611967760567, 19450.610987780165, 19694.0, 10397.428141452292, 10465.16278697687, 10570.947145264225, 10631.574737010587, 10649.509068730384, 7521.623918803928, 7709.537427754352, 8010.319122874388, 8131.2681858633005, 8306.792330191794, 17056.57358566046, 17104.315827366765, 17254.482365529053, 17383.304667813147, 17399.652006960045, 17127.314907403565, 17188.14059297055, 17278.0, 17322.30710771555, 17507.912460437616, 9813.214942804701, 9970.651027214013, 10032.548535315782, 10040.397576145455, 10056.69829905104, 12952.676183095122, 12970.092093553361, 12986.545470908473, 12997.0, 13280.335983200994, 10537.104346130358, 10666.413347265974, 10763.730906727082, 10782.406967616856, 10982.780344392908, 10453.738656533647, 10594.841077383691, 10729.356238625707, 10753.677389678322, 10805.189610779065, 9566.234701224024, 9638.807223855623, 9642.566084526354, 9648.71053868385, 9652.27607929422, 6626.6686665667485, 6638.601683898982, 6674.966625166843, 6679.398854103154, 6682.665866706742, 7561.584112873845, 7582.696692132253, 7646.847063058819, 7696.884546731691, 7707.653155607899], "value": 6388.338445250714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.89098561837983, 488.2212870471599, 495.99313393810564, 498.61357447977815, 502.18896482181276, 6120.724567394467, 6171.845703857401, 6248.656323902189, 6265.5927364721265, 6269.369963809409, 5837.270341207349, 5964.671943043142, 5985.5810093293485, 6013.51891848651, 6026.126211699301, 4853.660243782937, 4857.761270875922, 4859.586935110511, 4920.581750551208, 4921.80312787488, 4761.928571071437, 4885.462599114095, 4889.386502454199, 4903.313536104948, 4908.141075311824, 4787.186178349689, 4852.199387101124, 4858.927116093261, 4866.878328041792, 4867.756612169377, 4856.300294896775, 4881.804727810883, 4882.267659851033, 4886.291487734295, 4912.36139301892, 4337.804798784062, 4340.631046361063, 4345.8700737808085, 4370.344448332776, 4388.078503514266, 5861.970690146564, 5876.265466816648, 5897.52819774417, 5905.143754155666, 5928.318243401977, 5624.859378515529, 5672.716364181816, 5676.574256930706, 5677.5522241828485, 5687.886242275173, 6367.713452894631, 6386.13787138735, 6425.967870160619, 6427.710753016126, 6480.967595162041, 4791.784369703337, 4834.419869615669, 4835.9032819343765, 4861.100696371147, 4869.659123861331, 6930.826729331757, 6997.265287144878, 7016.122984626922, 7027.297270272983, 7044.788656340318, 4904.60763138948, 4923.8276660316715, 4932.482089380564, 4935.7532123393685, 5033.0, 4983.626228032839, 5002.324686167393, 5020.046191223656, 5025.623078269145, 5064.417591976896, 5655.971720141455, 5659.5755318351285, 5671.914921276184, 5683.801066962719, 5692.14617807324, 6488.28628850826, 6526.184226971629, 6535.5425120241125, 6551.21385433751, 6553.934460655332, 1678.471281546309, 1699.4986478988728, 1726.6460375622967, 1727.0587529796292, 1740.3821643316694, 1185.1644590563633, 1206.77071356442, 1224.663217615163, 1226.920250183753, 1227.6071657069651, 5650.152477128381, 5659.830205093854, 5694.800681976194, 5710.172025056427, 5740.712964351849, 6554.541182117301, 6601.141851559267, 6624.0, 6708.832279192961, 6767.0901512350165, 5746.569007324468, 5779.306483222041, 5782.508486778587, 5809.240610709879, 5822.941770582324, 3564.821758912096, 3581.5344005279667, 3598.604153543108, 3610.6028336882923, 3632.654897784706, 6535.150430444012, 6559.278479367265, 6575.934240657532, 6587.868242635216, 6599.406053455212, 6845.555038922554, 6943.513954023271, 6976.860462790716, 6983.266756990544, 6994.125734283215, 6423.357664233539, 6477.449416799436, 6506.121673574102, 6538.738450461929, 6562.639054852029, 6744.0, 6747.730090796509, 6757.600427531845, 6781.457483401415, 6827.351401616838, 6662.2351724035925, 6666.366695163952, 6670.665267156456, 6702.19573651165, 6723.327667233238, 6524.804255872332, 6577.243616983917, 6591.143151390289, 6600.80197594073, 6629.900551491828, 4905.847125925476, 4933.333999909966, 4943.442815513102, 4950.702957822542, 4977.776000079933, 6811.931880681328, 6820.590764554143, 6827.351401616838, 6827.726890924506, 6850.074685396996, 6560.639164845979, 6597.373249541286, 6616.338366163345, 6618.503612229199, 6626.668666566556, 6223.3465486125115, 6418.0, 6479.222493300834, 6492.513061520311, 6496.545241833026, 5921.3782552831335, 6248.656323902047, 6253.96873015632, 6406.263279722892, 6410.910145275408, 6389.185840884773, 6576.539642224999, 6586.269945147561, 6612.206535215805, 6643.202815662152, 6282.86382629908, 6330.620162790247, 6333.619982800862, 6356.792209480184, 6418.454431373386], "value": 5014.162949160108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [643.4209211709461, 643.7167646235657, 659.4592434203952, 904.0913881549042, 906.0667512462159, 16470.752938705915, 16737.665246695058, 16873.83126168738, 16893.746593801105, 21805.781942180573, 21211.0, 22049.559008819815, 22159.113635454563, 22223.66664500034, 22274.88862555685, 1040.8750949886025, 1057.1014637558092, 1060.3955745225226, 1061.050359927864, 1063.6915294564606, 1046.2048842879428, 1046.7592453735645, 1048.9895101049005, 1050.0811789684026, 1051.2903789941797, 1056.7727938493222, 1125.673554669145, 1129.3280498103616, 1133.5465813674514, 1134.1777211521664, 1120.456578559398, 1120.9775804483907, 1122.4836575175389, 1122.854028976228, 1124.3197865291504, 800.8998875140608, 802.1657476224719, 802.502448481939, 802.5345299726145, 802.8514724775935, 19219.423417297505, 19547.413577592695, 19652.11565479557, 19745.901270493556, 20115.0, 21741.2390566331, 21860.234891778713, 22227.333180004465, 22387.888060559755, 22395.32814015582, 16404.507864764077, 16802.747958780627, 16827.242774075195, 17031.318747250094, 17047.744283835753, 3492.2491664292297, 3522.6125126236093, 3524.859005639771, 3533.134382076382, 3540.309639620275, 123880.0, 126902.0, 128132.0, 128256.0, 130361.0, 16580.75128873068, 16655.6668866622, 16772.496825095266, 16925.7461138083, 16968.0, 30747.538786918216, 31040.53439198414, 31154.376912461623, 31200.68799312023, 31241.218969525944, 7625.733099341496, 7920.801979950432, 8266.751997440086, 8367.246947774729, 8454.32365410778, 4252.340887162495, 4318.5033721121845, 4348.34774783785, 4349.064951035542, 4363.629091527192, 5213.2701421800975, 5308.256844041837, 5335.706536140549, 5341.118715411992, 5347.839564813062, 1056.7252514346171, 1075.8816530181673, 1086.3481910853582, 1088.8911108889206, 1089.9155340436157, 635.5519358851998, 663.4294506724214, 676.1345477788439, 678.6606696651675, 684.1789852177407, 11408.258463199865, 12236.755264894653, 12455.501779928883, 12872.098953073382, 13035.543755968496, 700.9264027277164, 702.5082442290417, 706.0997228533661, 716.4053835316674, 720.989185162223, 5584.21820945068, 5598.384177740445, 5669.886602267931, 5691.715414229272, 5738.053221218535, 104168.47915760524, 105210.94789052011, 105486.0, 105766.0, 107666.0, 95385.99999999862, 96471.51764241135, 96680.0, 96927.51536242274, 97843.51078244564, 81562.0, 83011.0, 85232.14767852366, 85402.0, 85602.0, 11237.71905702364, 11377.601783937522, 11488.597899073493, 11524.481398337262, 11558.30650160993, 36519.26961460703, 37867.431988519646, 38263.0, 38294.89378084121, 38385.616143838204, 64362.0, 65238.0, 66046.33953660402, 69141.58004469819, 69805.30194697987, 18936.43190704281, 19222.519437014187, 19589.70615440741, 20271.391858244275, 20277.59444811125, 18659.626807464047, 18967.457890490507, 19492.05079492096, 21594.784052159277, 22118.694155685767, 19137.617247655246, 19347.709784353527, 19553.315633953312, 20031.799682002995, 20277.0, 19846.50383740418, 20037.699434508784, 20241.089150988537, 20604.690929635766, 20668.79331206729, 18783.624327513648, 18864.24543018264, 19361.0, 19425.320113796515, 19762.308319208758, 13493.932530337679, 13796.862031379958, 13830.446782129005, 13981.0, 14333.993240946067, 14802.925985370004, 14810.333534991167, 14860.479883204469, 14931.17878516692, 15099.24503774829], "value": 9244.8981442149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 108.0, 108.0, 115.0, 120.0, 107.0, 100.0, 112.0, 108.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 142.0, 183.0, 118.0, 147.0, 150.0, 120.0, 176.0, 124.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 166.0, 171.0, 165.0, 171.0, 169.0, 168.0, 164.0, 164.0], "value": 166.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 74.0, 167.0, 77.0, 82.0, 81.0, 74.0, 159.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 129.0, 79.0, 79.0, 79.0, 142.0, 78.0, 80.0, 132.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 117.0, 113.0, 115.0, 116.0, 115.0, 114.0, 114.0, 118.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 151.0, 153.0, 150.0, 151.0, 150.0, 152.0, 152.0, 151.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 94.0, 99.0, 93.0, 94.0, 93.0, 102.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 63.0, 53.0, 54.0, 61.0, 53.0, 56.0, 53.0, 60.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 59.0, 54.0, 59.0, 59.0, 54.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 91.0, 78.0, 90.0, 86.0, 98.0, 85.0, 87.0, 80.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 138.0, 126.0, 143.0, 127.0, 128.0, 126.0, 132.0, 127.0, 174.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 172.0, 175.0, 183.0, 173.0, 171.0, 172.0, 179.0, 174.0, 170.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 70.0, 84.0, 68.0, 71.0, 67.0, 68.0, 68.0, 68.0, 66.0], "value": 70.4, "unit": "score"}]}]} 05:29:26 INFO - Return code: 0 05:29:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:29:26 INFO - # TBPL SUCCESS # 05:29:26 INFO - Running post-action listener: _package_coverage_data 05:29:26 INFO - Running post-action listener: _resource_record_post_action 05:29:26 INFO - [mozharness: 2017-08-07 12:29:26.551495Z] Finished run-tests step (success) 05:29:26 INFO - Running post-run listener: _resource_record_post_run 05:29:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 98304; Write bytes: 439042048; Read time: 220; Write time: 385388 05:29:26 INFO - TinderboxPrint: CPU usage
13.2% 05:29:26 INFO - TinderboxPrint: I/O read bytes / time
98,304 / 220 05:29:26 INFO - TinderboxPrint: I/O write bytes / time
439,042,048 / 385,388 05:29:26 INFO - TinderboxPrint: CPU idle
8,270.7 (86.8%) 05:29:26 INFO - TinderboxPrint: CPU user
1,205.7 (12.7%) 05:29:26 INFO - TinderboxPrint: Swap in / out
0 / 0 05:29:26 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115585024; Read time: 0; Write time: 100220 05:29:26 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:29:26 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 94208; Write bytes: 322179072; Read time: 208; Write time: 285076 05:29:27 INFO - Running post-run listener: _upload_blobber_files 05:29:27 INFO - Blob upload gear active. 05:29:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:29:27 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:29:27 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:29:27 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:29:27 INFO - (blobuploader) - INFO - Open directory for files ... 05:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:29:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:28 INFO - (blobuploader) - INFO - Done attempting. 05:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:35 INFO - (blobuploader) - INFO - Done attempting. 05:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:29:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:36 INFO - (blobuploader) - INFO - Done attempting. 05:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:29:37 INFO - (blobuploader) - INFO - Done attempting. 05:29:37 INFO - (blobuploader) - INFO - Iteration through files over. 05:29:37 INFO - Return code: 0 05:29:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:29:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:29:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd79758b3a55421772f03508e7d4f27c7ebd635f9e6f24d5326f1787930c5297ee119b34bd7cb60ff966aa23ade551b62e6906a7230333f675a11c56399c58a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e99aef077c2452bf86397cb56f6ab9db44bbf45f17f7875e5b35890c438bc460c934e83ea0d173cb9df2dcb911df40b384b8a1f41ea7f0c6b390db40af1ff90", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad776a8302e2f68a5eb269f5569b032370cb3f5b338d5a631e991ecb05532f85e42d91d7d510c4f68ec102bbc24b077431ae1a99ff2c205e7cd153e2009ca6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ae3ff5768b3d82c4220bac991a212598aa7b9ba8e1e026b2a4dd21a3a1de9e5984da52982551541870d412f8d9399f0de9305fa2f78dc544594a12442a7783"} 05:29:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:29:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:29:37 INFO - Contents: 05:29:37 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd79758b3a55421772f03508e7d4f27c7ebd635f9e6f24d5326f1787930c5297ee119b34bd7cb60ff966aa23ade551b62e6906a7230333f675a11c56399c58a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e99aef077c2452bf86397cb56f6ab9db44bbf45f17f7875e5b35890c438bc460c934e83ea0d173cb9df2dcb911df40b384b8a1f41ea7f0c6b390db40af1ff90", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad776a8302e2f68a5eb269f5569b032370cb3f5b338d5a631e991ecb05532f85e42d91d7d510c4f68ec102bbc24b077431ae1a99ff2c205e7cd153e2009ca6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ae3ff5768b3d82c4220bac991a212598aa7b9ba8e1e026b2a4dd21a3a1de9e5984da52982551541870d412f8d9399f0de9305fa2f78dc544594a12442a7783"} 05:29:37 INFO - Running post-run listener: copy_logs_to_upload_dir 05:29:37 INFO - Copying logs to upload dir... 05:29:37 INFO - mkdir: /builds/slave/test/build/upload/logs 05:29:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.372736 ========= master_lag: 0.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-07 05:29:36.634487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 05:29:36.638967) ========= 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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd79758b3a55421772f03508e7d4f27c7ebd635f9e6f24d5326f1787930c5297ee119b34bd7cb60ff966aa23ade551b62e6906a7230333f675a11c56399c58a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e99aef077c2452bf86397cb56f6ab9db44bbf45f17f7875e5b35890c438bc460c934e83ea0d173cb9df2dcb911df40b384b8a1f41ea7f0c6b390db40af1ff90", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad776a8302e2f68a5eb269f5569b032370cb3f5b338d5a631e991ecb05532f85e42d91d7d510c4f68ec102bbc24b077431ae1a99ff2c205e7cd153e2009ca6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ae3ff5768b3d82c4220bac991a212598aa7b9ba8e1e026b2a4dd21a3a1de9e5984da52982551541870d412f8d9399f0de9305fa2f78dc544594a12442a7783"} build_url:https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/FK6Vw9RDTvi4Ea5oCnVSGw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd79758b3a55421772f03508e7d4f27c7ebd635f9e6f24d5326f1787930c5297ee119b34bd7cb60ff966aa23ade551b62e6906a7230333f675a11c56399c58a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e99aef077c2452bf86397cb56f6ab9db44bbf45f17f7875e5b35890c438bc460c934e83ea0d173cb9df2dcb911df40b384b8a1f41ea7f0c6b390db40af1ff90", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad776a8302e2f68a5eb269f5569b032370cb3f5b338d5a631e991ecb05532f85e42d91d7d510c4f68ec102bbc24b077431ae1a99ff2c205e7cd153e2009ca6b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a8ae3ff5768b3d82c4220bac991a212598aa7b9ba8e1e026b2a4dd21a3a1de9e5984da52982551541870d412f8d9399f0de9305fa2f78dc544594a12442a7783"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-07 05:29:36.666736) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:29:36.667055) ========= 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=0e2a256762fed810e2f0f810000001b3-1502107718.957582-878053578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-07 05:29:36.747482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 05:29:36.750821) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-07 05:29:36.751109) ========= ========= Total master_lag: 0.68 =========