builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1502071559.53 results: success (0) revision: 813810854eeaae9f2c5cb8f6879f91ac45e5038a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.534491) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.534971) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.535245) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.548418) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.548671) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 19:06:00-- 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% 46.1M=0s 2017-08-06 19:06:00 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.350476 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.910499) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.910812) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019097 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.959964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:05:59.960282) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 813810854eeaae9f2c5cb8f6879f91ac45e5038a --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 813810854eeaae9f2c5cb8f6879f91ac45e5038a --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 19:06:00,749 truncating revision to first 12 chars 2017-08-06 19:06:00,749 Setting DEBUG logging. 2017-08-06 19:06:00,749 attempt 1/10 2017-08-06 19:06:00,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/813810854eea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 19:06:01,140 unpacking tar archive at: mozilla-central-813810854eea/testing/mozharness/ program finished with exit code 0 elapsedTime=0.680672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:06:00.653642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:06:00.653958) ========= script_repo_revision: 813810854eeaae9f2c5cb8f6879f91ac45e5038a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 19:06:00.654314) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:06:00.658626) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 19:06:00.668990) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-06 19:06:00.669264) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:06:01 INFO - MultiFileLogger online at 20170806 19:06:01 in /builds/slave/test 19:06:01 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 19:06:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:06:01 INFO - {'append_to_log': False, 19:06:01 INFO - 'base_work_dir': '/builds/slave/test', 19:06:01 INFO - 'blob_upload_branch': 'Firefox', 19:06:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:06:01 INFO - 'branch': 'Firefox', 19:06:01 INFO - 'buildbot_json_path': 'buildprops.json', 19:06:01 INFO - 'code_coverage': False, 19:06:01 INFO - 'config_files': ('talos/linux_config.py',), 19:06:01 INFO - 'default_actions': ('clobber', 19:06:01 INFO - 'read-buildbot-config', 19:06:01 INFO - 'download-and-extract', 19:06:01 INFO - 'populate-webroot', 19:06:01 INFO - 'create-virtualenv', 19:06:01 INFO - 'install', 19:06:01 INFO - 'setup-mitmproxy', 19:06:01 INFO - 'run-tests'), 19:06:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:06:01 INFO - 'disable_ccov_upload': False, 19:06:01 INFO - 'download_minidump_stackwalk': True, 19:06:01 INFO - 'download_symbols': 'ondemand', 19:06:01 INFO - 'enable_stylo': False, 19:06:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:06:01 INFO - 'tooltool.py': '/tools/tooltool.py', 19:06:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:06:01 INFO - '/tools/misc-python/virtualenv.py')}, 19:06:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:06:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:06:01 INFO - 'gecko_profile': False, 19:06:01 INFO - 'gecko_profile_interval': 0, 19:06:01 INFO - 'installer_path': 'installer.exe', 19:06:01 INFO - 'log_level': 'info', 19:06:01 INFO - 'log_name': 'talos', 19:06:01 INFO - 'log_to_console': True, 19:06:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:06:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:06:01 INFO - 'opt_config_files': (), 19:06:01 INFO - 'pip_index': False, 19:06:01 INFO - 'suite': 'dromaeojs-e10s', 19:06:01 INFO - 'system_bits': '32', 19:06:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:06:01 INFO - 'title': 'talos-linux64-ix-079', 19:06:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:06:01 INFO - 'use_talos_json': True, 19:06:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:06:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:06:01 INFO - 'work_dir': 'build'} 19:06:01 INFO - [mozharness: 2017-08-07 02:06:01.567586Z] Running clobber step. 19:06:01 INFO - Running pre-action listener: _resource_record_pre_action 19:06:01 INFO - Running main action method: clobber 19:06:01 INFO - rmtree: /builds/slave/test/build 19:06:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:06:02 INFO - Running post-action listener: _resource_record_post_action 19:06:02 INFO - [mozharness: 2017-08-07 02:06:02.752083Z] Finished clobber step (success) 19:06:02 INFO - [mozharness: 2017-08-07 02:06:02.752186Z] Running read-buildbot-config step. 19:06:02 INFO - Running pre-action listener: _resource_record_pre_action 19:06:02 INFO - Running main action method: read_buildbot_config 19:06:02 INFO - Using buildbot properties: 19:06:02 INFO - { 19:06:02 INFO - "project": "", 19:06:02 INFO - "product": "firefox", 19:06:02 INFO - "who": "ryanvm@gmail.com", 19:06:02 INFO - "installer_path": "public/build/target.tar.bz2", 19:06:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:06:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 19:06:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:06:02 INFO - "stage_platform": "linux64-stylosequential", 19:06:02 INFO - "basedir": "/builds/slave/test", 19:06:02 INFO - "buildnumber": 170, 19:06:02 INFO - "platform": "ubuntu64_hw_styloseq", 19:06:02 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:06:02 INFO - "slavebuilddir": "test", 19:06:02 INFO - "taskId": "UNZT4zjqTUWseKvN1Xr4Vg", 19:06:02 INFO - "branch": "mozilla-central", 19:06:02 INFO - "script_repo_revision": "production", 19:06:02 INFO - "revision": "813810854eeaae9f2c5cb8f6879f91ac45e5038a", 19:06:02 INFO - "slavename": "talos-linux64-ix-079", 19:06:02 INFO - "repo_path": "mozilla-central" 19:06:02 INFO - } 19:06:02 INFO - Finding installer, test and symbols from parent task. 19:06:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNZT4zjqTUWseKvN1Xr4Vg'}, attempt #1 19:06:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UNZT4zjqTUWseKvN1Xr4Vg'}, attempt #1 19:06:03 INFO - Task dependencies: RKvT63nbRo-zGQ2y8mYqJQ 19:06:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ'}, attempt #1 19:06:04 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:06:04 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json 19:06:04 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip 19:06:04 INFO - Running post-action listener: _resource_record_post_action 19:06:04 INFO - [mozharness: 2017-08-07 02:06:04.097798Z] Finished read-buildbot-config step (success) 19:06:04 INFO - [mozharness: 2017-08-07 02:06:04.098027Z] Running download-and-extract step. 19:06:04 INFO - Running pre-action listener: _resource_record_pre_action 19:06:04 INFO - Running main action method: download_and_extract 19:06:04 INFO - mkdir: /builds/slave/test/build/tests 19:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:04 INFO - trying https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json 19:06:04 INFO - Downloading https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:06:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:06:04 INFO - Downloaded 989 bytes. 19:06:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:06:04 INFO - Using the following test package requirements: 19:06:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:06:04 INFO - u'common': [u'target.common.tests.zip'], 19:06:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:06:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:06:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:06:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:06:04 INFO - u'mozbase': [u'target.common.tests.zip'], 19:06:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:06:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:06:04 INFO - u'web-platform': [u'target.common.tests.zip', 19:06:04 INFO - u'target.web-platform.tests.tar.gz'], 19:06:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:06:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:06:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip 19:06:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:06:04 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip into memory 19:06:06 INFO - Content-Length response header: 54284835 19:06:06 INFO - Bytes received: 54284835 19:06:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:06:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip 19:06:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:06:17 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.common.tests.zip into memory 19:06:18 INFO - Content-Length response header: 54284835 19:06:18 INFO - Bytes received: 54284835 19:06:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip 19:06:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:06:30 INFO - Fetch https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.talos.tests.zip into memory 19:06:31 INFO - Content-Length response header: 14496008 19:06:31 INFO - Bytes received: 14496008 19:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:32 INFO - trying https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:06:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:06:33 INFO - Downloaded 61820626 bytes. 19:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:06:33 INFO - mkdir: /builds/slave/test/properties 19:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 19:06:33 INFO - Contents: 19:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 19:06:33 INFO - Running post-action listener: _resource_record_post_action 19:06:33 INFO - Running post-action listener: set_extra_try_arguments 19:06:33 INFO - [mozharness: 2017-08-07 02:06:33.714470Z] Finished download-and-extract step (success) 19:06:33 INFO - [mozharness: 2017-08-07 02:06:33.714571Z] Running populate-webroot step. 19:06:33 INFO - Running pre-action listener: _resource_record_pre_action 19:06:33 INFO - Running main action method: populate_webroot 19:06:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:06:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:06:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:06:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:06:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:06:33 INFO - 'tests': ['damp', 'tps']}, 19:06:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:06:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:06:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:06:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:06:33 INFO - 'other-e10s': {'tests': ['a11yr', 19:06:33 INFO - 'ts_paint', 19:06:33 INFO - 'tpaint', 19:06:33 INFO - 'sessionrestore', 19:06:33 INFO - 'sessionrestore_many_windows', 19:06:33 INFO - 'sessionrestore_no_auto_restore', 19:06:33 INFO - 'tabpaint']}, 19:06:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:06:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:06:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:06:33 INFO - 'tsvgr_opacity', 19:06:33 INFO - 'tart', 19:06:33 INFO - 'tscrollx', 19:06:33 INFO - 'tsvg_static']}, 19:06:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:06:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:06:33 INFO - 'talos_options': ['--mitmproxy', 19:06:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:06:33 INFO - '--firstNonBlankPaint'], 19:06:33 INFO - 'tests': ['tp6_google', 19:06:33 INFO - 'tp6_youtube', 19:06:33 INFO - 'tp6_amazon', 19:06:33 INFO - 'tp6_facebook']}, 19:06:33 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:06:33 INFO - 'talos_options': ['--stylo', 19:06:33 INFO - '--mitmproxy', 19:06:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:06:33 INFO - '--firstNonBlankPaint'], 19:06:33 INFO - 'tests': ['tp6_google', 19:06:33 INFO - 'tp6_youtube', 19:06:33 INFO - 'tp6_amazon', 19:06:33 INFO - 'tp6_facebook']}, 19:06:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:06:33 INFO - 'talos_options': ['--stylo', 19:06:33 INFO - '--stylo-threads=1', 19:06:33 INFO - '--mitmproxy', 19:06:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:06:33 INFO - '--firstNonBlankPaint'], 19:06:33 INFO - 'tests': ['tp6_google', 19:06:33 INFO - 'tp6_youtube', 19:06:33 INFO - 'tp6_amazon', 19:06:33 INFO - 'tp6_facebook']}, 19:06:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:06:33 INFO - 'talos_options': ['--xperf_path', 19:06:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:06:33 INFO - 'tests': ['tp5n']}}} 19:06:33 INFO - Running post-action listener: _resource_record_post_action 19:06:33 INFO - [mozharness: 2017-08-07 02:06:33.723010Z] Finished populate-webroot step (success) 19:06:33 INFO - [mozharness: 2017-08-07 02:06:33.723100Z] Running create-virtualenv step. 19:06:33 INFO - Running pre-action listener: _resource_record_pre_action 19:06:33 INFO - Running main action method: create_virtualenv 19:06:33 INFO - Creating virtualenv /builds/slave/test/build/venv 19:06:33 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 19:06:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:06:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:06:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:06:33 INFO - Using real prefix '/usr' 19:06:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:06:34 INFO - Installing distribute.............................................................................................................................................................................................done. 19:06:36 INFO - Installing pip.................done. 19:06:36 INFO - Return code: 0 19:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:06:36 INFO - Reading from file tmpfile_stdout 19:06:36 INFO - Output received: 19:06:36 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) 19:06:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:36 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:36 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 19:06:36 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 19:06:36 INFO - Using env: {'DISPLAY': ':0', 19:06:36 INFO - 'HOME': '/home/cltbld', 19:06:36 INFO - 'LANG': 'en_US.UTF-8', 19:06:36 INFO - 'LANGUAGE': 'en_US:en', 19:06:36 INFO - 'LOGNAME': 'cltbld', 19:06:36 INFO - 'MAIL': '/var/mail/cltbld', 19:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:36 INFO - 'MOZ_NO_REMOTE': '1', 19:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:36 INFO - 'NO_EM_RESTART': '1', 19:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:36 INFO - 'PWD': '/builds/slave/test', 19:06:36 INFO - 'SHELL': '/bin/bash', 19:06:36 INFO - 'SHLVL': '1', 19:06:36 INFO - 'TERM': 'linux', 19:06:36 INFO - 'TMOUT': '86400', 19:06:36 INFO - 'USER': 'cltbld', 19:06:36 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:36 INFO - '_': '/tools/buildbot/bin/python'} 19:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:36 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 19:06:36 INFO - Cleaning up... 19:06:36 INFO - Return code: 0 19:06:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:36 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:36 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 19:06:36 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 19:06:36 INFO - Using env: {'DISPLAY': ':0', 19:06:36 INFO - 'HOME': '/home/cltbld', 19:06:36 INFO - 'LANG': 'en_US.UTF-8', 19:06:36 INFO - 'LANGUAGE': 'en_US:en', 19:06:36 INFO - 'LOGNAME': 'cltbld', 19:06:36 INFO - 'MAIL': '/var/mail/cltbld', 19:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:36 INFO - 'MOZ_NO_REMOTE': '1', 19:06:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:36 INFO - 'NO_EM_RESTART': '1', 19:06:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:36 INFO - 'PWD': '/builds/slave/test', 19:06:36 INFO - 'SHELL': '/bin/bash', 19:06:36 INFO - 'SHLVL': '1', 19:06:36 INFO - 'TERM': 'linux', 19:06:36 INFO - 'TMOUT': '86400', 19:06:36 INFO - 'USER': 'cltbld', 19:06:36 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:36 INFO - '_': '/tools/buildbot/bin/python'} 19:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:36 INFO - Downloading/unpacking psutil>=3.1.1 19:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:38 INFO - Installing collected packages: psutil 19:06:38 INFO - Running setup.py install for psutil 19:06:38 INFO - building 'psutil._psutil_linux' extension 19:06:38 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 19:06:38 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 19:06:38 INFO - building 'psutil._psutil_posix' extension 19:06:38 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 19:06:38 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 19:06:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:06:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:06:38 INFO - Successfully installed psutil 19:06:38 INFO - Cleaning up... 19:06:38 INFO - Return code: 0 19:06:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:06:38 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')]} 19:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:38 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')]} 19:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:38 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:38 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 19:06:38 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 19:06:38 INFO - Using env: {'DISPLAY': ':0', 19:06:38 INFO - 'HOME': '/home/cltbld', 19:06:38 INFO - 'LANG': 'en_US.UTF-8', 19:06:38 INFO - 'LANGUAGE': 'en_US:en', 19:06:38 INFO - 'LOGNAME': 'cltbld', 19:06:38 INFO - 'MAIL': '/var/mail/cltbld', 19:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:38 INFO - 'MOZ_NO_REMOTE': '1', 19:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:38 INFO - 'NO_EM_RESTART': '1', 19:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:38 INFO - 'PWD': '/builds/slave/test', 19:06:38 INFO - 'SHELL': '/bin/bash', 19:06:38 INFO - 'SHLVL': '1', 19:06:38 INFO - 'TERM': 'linux', 19:06:38 INFO - 'TMOUT': '86400', 19:06:38 INFO - 'USER': 'cltbld', 19:06:38 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:38 INFO - '_': '/tools/buildbot/bin/python'} 19:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:06:38 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 19:06:38 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 19:06:38 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 19:06:38 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 19:06:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:06:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:06:40 INFO - Installing collected packages: mozsystemmonitor 19:06:40 INFO - Running setup.py install for mozsystemmonitor 19:06:40 INFO - Successfully installed mozsystemmonitor 19:06:40 INFO - Cleaning up... 19:06:40 INFO - Return code: 0 19:06:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:40 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:40 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 19:06:40 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 19:06:40 INFO - Using env: {'DISPLAY': ':0', 19:06:40 INFO - 'HOME': '/home/cltbld', 19:06:40 INFO - 'LANG': 'en_US.UTF-8', 19:06:40 INFO - 'LANGUAGE': 'en_US:en', 19:06:40 INFO - 'LOGNAME': 'cltbld', 19:06:40 INFO - 'MAIL': '/var/mail/cltbld', 19:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:40 INFO - 'MOZ_NO_REMOTE': '1', 19:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:40 INFO - 'NO_EM_RESTART': '1', 19:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:40 INFO - 'PWD': '/builds/slave/test', 19:06:40 INFO - 'SHELL': '/bin/bash', 19:06:40 INFO - 'SHLVL': '1', 19:06:40 INFO - 'TERM': 'linux', 19:06:40 INFO - 'TMOUT': '86400', 19:06:40 INFO - 'USER': 'cltbld', 19:06:40 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:40 INFO - '_': '/tools/buildbot/bin/python'} 19:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:40 INFO - Downloading/unpacking jsonschema==2.5.1 19:06:40 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 19:06:40 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 19:06:40 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 19:06:40 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 19:06:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:06:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:06:41 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 19:06:41 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 19:06:41 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 19:06:41 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 19:06:41 INFO - Downloading functools32-3.2.3-2.tar.gz 19:06:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:06:41 INFO - warning: no files found matching '*.txt' 19:06:41 INFO - no previously-included directories found matching 'build' 19:06:41 INFO - no previously-included directories found matching 'dist' 19:06:41 INFO - no previously-included directories found matching '.git*' 19:06:41 INFO - Installing collected packages: jsonschema, functools32 19:06:41 INFO - Running setup.py install for functools32 19:06:41 INFO - warning: no files found matching '*.txt' 19:06:41 INFO - no previously-included directories found matching 'build' 19:06:41 INFO - no previously-included directories found matching 'dist' 19:06:41 INFO - no previously-included directories found matching '.git*' 19:06:41 INFO - Successfully installed jsonschema functools32 19:06:41 INFO - Cleaning up... 19:06:41 INFO - Return code: 0 19:06:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:06:41 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')]} 19:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:41 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')]} 19:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:41 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:41 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 19:06:41 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 19:06:41 INFO - Using env: {'DISPLAY': ':0', 19:06:41 INFO - 'HOME': '/home/cltbld', 19:06:41 INFO - 'LANG': 'en_US.UTF-8', 19:06:41 INFO - 'LANGUAGE': 'en_US:en', 19:06:41 INFO - 'LOGNAME': 'cltbld', 19:06:41 INFO - 'MAIL': '/var/mail/cltbld', 19:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:41 INFO - 'MOZ_NO_REMOTE': '1', 19:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:41 INFO - 'NO_EM_RESTART': '1', 19:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:41 INFO - 'PWD': '/builds/slave/test', 19:06:41 INFO - 'SHELL': '/bin/bash', 19:06:41 INFO - 'SHLVL': '1', 19:06:41 INFO - 'TERM': 'linux', 19:06:41 INFO - 'TMOUT': '86400', 19:06:41 INFO - 'USER': 'cltbld', 19:06:41 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:41 INFO - '_': '/tools/buildbot/bin/python'} 19:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:06:42 INFO - Cleaning up... 19:06:42 INFO - Return code: 0 19:06:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:06:42 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')]} 19:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:42 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')]} 19:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:42 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:42 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 19:06:42 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 19:06:42 INFO - Using env: {'DISPLAY': ':0', 19:06:42 INFO - 'HOME': '/home/cltbld', 19:06:42 INFO - 'LANG': 'en_US.UTF-8', 19:06:42 INFO - 'LANGUAGE': 'en_US:en', 19:06:42 INFO - 'LOGNAME': 'cltbld', 19:06:42 INFO - 'MAIL': '/var/mail/cltbld', 19:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:42 INFO - 'MOZ_NO_REMOTE': '1', 19:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:42 INFO - 'NO_EM_RESTART': '1', 19:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:42 INFO - 'PWD': '/builds/slave/test', 19:06:42 INFO - 'SHELL': '/bin/bash', 19:06:42 INFO - 'SHLVL': '1', 19:06:42 INFO - 'TERM': 'linux', 19:06:42 INFO - 'TMOUT': '86400', 19:06:42 INFO - 'USER': 'cltbld', 19:06:42 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:42 INFO - '_': '/tools/buildbot/bin/python'} 19:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:42 INFO - Downloading/unpacking blobuploader==1.2.4 19:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:43 INFO - Downloading blobuploader-1.2.4.tar.gz 19:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:06:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:06:43 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 19:06:43 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 19:06:43 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 19:06:43 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 19:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:06:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:06:43 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 19:06:43 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 19:06:43 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 19:06:43 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 19:06:43 INFO - Downloading docopt-0.6.1.tar.gz 19:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:06:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:06:44 INFO - Running setup.py install for blobuploader 19:06:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:06:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:06:44 INFO - Running setup.py install for requests 19:06:44 INFO - Running setup.py install for docopt 19:06:44 INFO - Successfully installed blobuploader requests docopt 19:06:44 INFO - Cleaning up... 19:06:44 INFO - Return code: 0 19:06:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:44 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')]} 19:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:44 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')]} 19:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:44 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:44 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 19:06:44 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 19:06:44 INFO - Using env: {'DISPLAY': ':0', 19:06:44 INFO - 'HOME': '/home/cltbld', 19:06:44 INFO - 'LANG': 'en_US.UTF-8', 19:06:44 INFO - 'LANGUAGE': 'en_US:en', 19:06:44 INFO - 'LOGNAME': 'cltbld', 19:06:44 INFO - 'MAIL': '/var/mail/cltbld', 19:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:44 INFO - 'MOZ_NO_REMOTE': '1', 19:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:44 INFO - 'NO_EM_RESTART': '1', 19:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:44 INFO - 'PWD': '/builds/slave/test', 19:06:44 INFO - 'SHELL': '/bin/bash', 19:06:44 INFO - 'SHLVL': '1', 19:06:44 INFO - 'TERM': 'linux', 19:06:44 INFO - 'TMOUT': '86400', 19:06:44 INFO - 'USER': 'cltbld', 19:06:44 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:44 INFO - '_': '/tools/buildbot/bin/python'} 19:06:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:44 INFO - Running setup.py (path:/tmp/pip-Wncs_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:44 INFO - Running setup.py (path:/tmp/pip-Yk8tZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:44 INFO - Running setup.py (path:/tmp/pip-RHbcFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:45 INFO - Running setup.py (path:/tmp/pip-qBFrjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:45 INFO - Running setup.py (path:/tmp/pip-nWgh7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:45 INFO - Running setup.py (path:/tmp/pip-sjAq1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:45 INFO - Running setup.py (path:/tmp/pip-eVX0LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:45 INFO - Running setup.py (path:/tmp/pip-TTkt9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:45 INFO - Running setup.py (path:/tmp/pip-kEeolA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:45 INFO - Running setup.py (path:/tmp/pip-4dhA4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:45 INFO - Running setup.py (path:/tmp/pip-d5TmDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:45 INFO - Running setup.py (path:/tmp/pip-Q_mgyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:45 INFO - Running setup.py (path:/tmp/pip-KB0TE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:45 INFO - Running setup.py (path:/tmp/pip-dLISsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:45 INFO - Running setup.py (path:/tmp/pip-6jBgvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:45 INFO - Running setup.py (path:/tmp/pip-42Ly9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:45 INFO - Running setup.py (path:/tmp/pip-v_r1mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:06:46 INFO - Running setup.py install for manifestparser 19:06:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Running setup.py install for mozcrash 19:06:46 INFO - Running setup.py install for mozdebug 19:06:46 INFO - Running setup.py install for mozdevice 19:06:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Running setup.py install for mozfile 19:06:46 INFO - Running setup.py install for mozhttpd 19:06:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Running setup.py install for mozinfo 19:06:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Running setup.py install for mozInstall 19:06:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:06:46 INFO - Running setup.py install for mozleak 19:06:46 INFO - Running setup.py install for mozlog 19:06:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Running setup.py install for moznetwork 19:06:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Running setup.py install for mozprocess 19:06:47 INFO - Running setup.py install for mozprofile 19:06:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Running setup.py install for mozrunner 19:06:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Running setup.py install for mozscreenshot 19:06:47 INFO - Running setup.py install for moztest 19:06:47 INFO - Running setup.py install for mozversion 19:06:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:06:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:06:47 INFO - Cleaning up... 19:06:47 INFO - Return code: 0 19:06:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:47 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')]} 19:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:47 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')]} 19:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:47 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:47 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 19:06:47 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 19:06:47 INFO - Using env: {'DISPLAY': ':0', 19:06:47 INFO - 'HOME': '/home/cltbld', 19:06:47 INFO - 'LANG': 'en_US.UTF-8', 19:06:47 INFO - 'LANGUAGE': 'en_US:en', 19:06:47 INFO - 'LOGNAME': 'cltbld', 19:06:47 INFO - 'MAIL': '/var/mail/cltbld', 19:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:47 INFO - 'MOZ_NO_REMOTE': '1', 19:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:47 INFO - 'NO_EM_RESTART': '1', 19:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:47 INFO - 'PWD': '/builds/slave/test', 19:06:47 INFO - 'SHELL': '/bin/bash', 19:06:47 INFO - 'SHLVL': '1', 19:06:47 INFO - 'TERM': 'linux', 19:06:47 INFO - 'TMOUT': '86400', 19:06:47 INFO - 'USER': 'cltbld', 19:06:47 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:47 INFO - '_': '/tools/buildbot/bin/python'} 19:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:06:48 INFO - Running setup.py (path:/tmp/pip-Rn77BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:06:48 INFO - Running setup.py (path:/tmp/pip-haK5wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:06:48 INFO - Running setup.py (path:/tmp/pip-4vtJPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:06:48 INFO - Running setup.py (path:/tmp/pip-17ydu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:06:48 INFO - Running setup.py (path:/tmp/pip-9RcJ31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:06:48 INFO - Running setup.py (path:/tmp/pip-XHmkNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:06:48 INFO - Running setup.py (path:/tmp/pip-iajo9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:06:48 INFO - Running setup.py (path:/tmp/pip-W3wpeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:06:48 INFO - Running setup.py (path:/tmp/pip-AGtKAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:06:48 INFO - Running setup.py (path:/tmp/pip-bcYd81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:06:48 INFO - Running setup.py (path:/tmp/pip-ZbhJ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:06:48 INFO - Running setup.py (path:/tmp/pip-hhbSCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:06:48 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)) 19:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:06:48 INFO - Running setup.py (path:/tmp/pip-BDQsCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:06:49 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)) 19:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:06:49 INFO - Running setup.py (path:/tmp/pip-UbExl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:06:49 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)) 19:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:49 INFO - Running setup.py (path:/tmp/pip-chWy91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:06:49 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)) 19:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:06:49 INFO - Running setup.py (path:/tmp/pip-KdzZwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:06:49 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)) 19:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:06:49 INFO - Running setup.py (path:/tmp/pip-4qnphK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:06:49 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)) 19:06:49 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)) 19:06:49 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)) 19:06:49 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)) 19:06:49 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)) 19:06:49 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)) 19:06:49 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)) 19:06:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:50 INFO - Downloading blessings-1.6.tar.gz 19:06:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:06:50 INFO - Installing collected packages: blessings 19:06:50 INFO - Running setup.py install for blessings 19:06:50 INFO - Successfully installed blessings 19:06:50 INFO - Cleaning up... 19:06:50 INFO - Return code: 0 19:06:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:06:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:50 INFO - Reading from file tmpfile_stdout 19:06:50 INFO - Current package versions: 19:06:50 INFO - argparse == 1.2.1 19:06:50 INFO - blessings == 1.6 19:06:50 INFO - blobuploader == 1.2.4 19:06:50 INFO - docopt == 0.6.1 19:06:50 INFO - functools32 == 3.2.3-2 19:06:50 INFO - jsonschema == 2.5.1 19:06:50 INFO - manifestparser == 1.1 19:06:50 INFO - mozInstall == 1.13 19:06:50 INFO - mozcrash == 1.0 19:06:50 INFO - mozdebug == 0.1 19:06:50 INFO - mozdevice == 0.51 19:06:50 INFO - mozfile == 1.2 19:06:50 INFO - mozhttpd == 0.7 19:06:50 INFO - mozinfo == 0.10 19:06:50 INFO - mozleak == 0.1 19:06:50 INFO - mozlog == 3.5 19:06:50 INFO - moznetwork == 0.27 19:06:50 INFO - mozprocess == 0.25 19:06:50 INFO - mozprofile == 0.28 19:06:50 INFO - mozrunner == 6.13 19:06:50 INFO - mozscreenshot == 0.1 19:06:50 INFO - mozsystemmonitor == 0.3 19:06:50 INFO - moztest == 0.8 19:06:50 INFO - mozversion == 1.4 19:06:50 INFO - psutil == 3.1.1 19:06:50 INFO - requests == 1.2.3 19:06:50 INFO - wsgiref == 0.1.2 19:06:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:06:50 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')]} 19:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:50 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')]} 19:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:50 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 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:50 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 19:06:50 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 19:06:50 INFO - Using env: {'DISPLAY': ':0', 19:06:50 INFO - 'HOME': '/home/cltbld', 19:06:50 INFO - 'LANG': 'en_US.UTF-8', 19:06:50 INFO - 'LANGUAGE': 'en_US:en', 19:06:50 INFO - 'LOGNAME': 'cltbld', 19:06:50 INFO - 'MAIL': '/var/mail/cltbld', 19:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:50 INFO - 'MOZ_NO_REMOTE': '1', 19:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:50 INFO - 'NO_EM_RESTART': '1', 19:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:50 INFO - 'PWD': '/builds/slave/test', 19:06:50 INFO - 'SHELL': '/bin/bash', 19:06:50 INFO - 'SHLVL': '1', 19:06:50 INFO - 'TERM': 'linux', 19:06:50 INFO - 'TMOUT': '86400', 19:06:50 INFO - 'USER': 'cltbld', 19:06:50 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:50 INFO - '_': '/tools/buildbot/bin/python'} 19:06:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 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)) 19:06:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:06:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:06:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:06:52 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)) 19:06:52 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)) 19:06:52 INFO - Installing collected packages: simplejson 19:06:52 INFO - Running setup.py install for simplejson 19:06:52 INFO - building 'simplejson._speedups' extension 19:06:52 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 19:06:53 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 19:06:53 INFO - Successfully installed simplejson 19:06:53 INFO - Cleaning up... 19:06:53 INFO - Return code: 0 19:06:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:06:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:06:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:06:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xa4f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc1ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdbed10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', '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 19:06:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:06:53 INFO - Using env: {'DISPLAY': ':0', 19:06:53 INFO - 'HOME': '/home/cltbld', 19:06:53 INFO - 'LANG': 'en_US.UTF-8', 19:06:53 INFO - 'LANGUAGE': 'en_US:en', 19:06:53 INFO - 'LOGNAME': 'cltbld', 19:06:53 INFO - 'MAIL': '/var/mail/cltbld', 19:06:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:06:53 INFO - 'MOZ_NO_REMOTE': '1', 19:06:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:06:53 INFO - 'NO_EM_RESTART': '1', 19:06:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:06:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:06:53 INFO - 'PWD': '/builds/slave/test', 19:06:53 INFO - 'SHELL': '/bin/bash', 19:06:53 INFO - 'SHLVL': '1', 19:06:53 INFO - 'TERM': 'linux', 19:06:53 INFO - 'TMOUT': '86400', 19:06:53 INFO - 'USER': 'cltbld', 19:06:53 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:06:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:06:53 INFO - '_': '/tools/buildbot/bin/python'} 19:06:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:06:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:06:53 INFO - Cleaning up... 19:06:53 INFO - Return code: 0 19:06:53 INFO - Running post-action listener: _resource_record_post_action 19:06:53 INFO - Running post-action listener: _start_resource_monitoring 19:06:53 INFO - Starting resource monitoring. 19:06:53 INFO - [mozharness: 2017-08-07 02:06:53.671482Z] Finished create-virtualenv step (success) 19:06:53 INFO - [mozharness: 2017-08-07 02:06:53.671949Z] Running install step. 19:06:53 INFO - Running pre-action listener: _resource_record_pre_action 19:06:53 INFO - Running main action method: install 19:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:06:53 INFO - Reading from file tmpfile_stdout 19:06:53 INFO - Detecting whether we're running mozinstall >=1.0... 19:06:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:06:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:06:54 INFO - Reading from file tmpfile_stdout 19:06:54 INFO - Output received: 19:06:54 INFO - Usage: mozinstall [options] installer 19:06:54 INFO - Options: 19:06:54 INFO - -h, --help show this help message and exit 19:06:54 INFO - -d DEST, --destination=DEST 19:06:54 INFO - Directory to install application into. [default: 19:06:54 INFO - "/builds/slave/test"] 19:06:54 INFO - --app=APP Application being installed. [default: firefox] 19:06:54 INFO - mkdir: /builds/slave/test/build/application 19:06:54 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'] 19:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:07:11 INFO - Reading from file tmpfile_stdout 19:07:11 INFO - Output received: 19:07:11 INFO - /builds/slave/test/build/application/firefox/firefox 19:07:11 INFO - Running post-action listener: _resource_record_post_action 19:07:11 INFO - [mozharness: 2017-08-07 02:07:11.954798Z] Finished install step (success) 19:07:11 INFO - [mozharness: 2017-08-07 02:07:11.955050Z] Running setup-mitmproxy step. 19:07:11 INFO - Running pre-action listener: _resource_record_pre_action 19:07:11 INFO - Running main action method: setup_mitmproxy 19:07:11 INFO - Skipping: mitmproxy is not required 19:07:11 INFO - Running post-action listener: _resource_record_post_action 19:07:11 INFO - [mozharness: 2017-08-07 02:07:11.956191Z] Finished setup-mitmproxy step (success) 19:07:11 INFO - [mozharness: 2017-08-07 02:07:11.956413Z] Running run-tests step. 19:07:11 INFO - Running pre-action listener: _resource_record_pre_action 19:07:11 INFO - Running pre-action listener: _set_gcov_prefix 19:07:11 INFO - Running main action method: run_tests 19:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:07:11 INFO - Python 2.7.3 19:07:11 INFO - Return code: 0 19:07:11 INFO - grabbing minidump binary from tooltool 19:07:11 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')]} 19:07:11 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 0xdbbeb0>, '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 0xdbcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xdbd240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:07:11 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 19:07:11 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 19:07:11 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 19:07:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:07:12 INFO - Return code: 0 19:07:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:07:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:07:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:07:12 INFO - ENV: RUST_BACKTRACE is now 1 19:07:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:07:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:07:12 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/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:07:12 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/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:07:12 INFO - Using env: {'DISPLAY': ':0', 19:07:12 INFO - 'HOME': '/home/cltbld', 19:07:12 INFO - 'LANG': 'en_US.UTF-8', 19:07:12 INFO - 'LANGUAGE': 'en_US:en', 19:07:12 INFO - 'LOGNAME': 'cltbld', 19:07:12 INFO - 'MAIL': '/var/mail/cltbld', 19:07:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:07:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:07:12 INFO - 'MOZ_NO_REMOTE': '1', 19:07:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:07:12 INFO - 'NO_EM_RESTART': '1', 19:07:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:07:12 INFO - 'PWD': '/builds/slave/test', 19:07:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:07:12 INFO - 'RUST_BACKTRACE': '1', 19:07:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:07:12 INFO - 'SHELL': '/bin/bash', 19:07:12 INFO - 'SHLVL': '1', 19:07:12 INFO - 'STYLO_FORCE_ENABLED': '1', 19:07:12 INFO - 'TERM': 'linux', 19:07:12 INFO - 'TMOUT': '86400', 19:07:12 INFO - 'USER': 'cltbld', 19:07:12 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316', 19:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:07:12 INFO - '_': '/tools/buildbot/bin/python'} 19:07:12 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/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:07:12 INFO - mozversion application_buildid: 20170807011658 19:07:12 INFO - mozversion application_changeset: 813810854eeaae9f2c5cb8f6879f91ac45e5038a 19:07:12 INFO - mozversion application_display_name: Nightly 19:07:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:07:12 INFO - mozversion application_name: Firefox 19:07:12 INFO - mozversion application_remotingname: firefox 19:07:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:07:12 INFO - mozversion application_vendor: Mozilla 19:07:12 INFO - mozversion application_version: 57.0a1 19:07:12 INFO - mozversion platform_buildid: 20170807011658 19:07:12 INFO - mozversion platform_changeset: 813810854eeaae9f2c5cb8f6879f91ac45e5038a 19:07:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:07:12 INFO - mozversion platform_version: 57.0a1 19:07:12 INFO - using testdate: 1502071632 19:07:12 INFO - actual date: 1502071632 19:07:12 INFO - starting webserver on 'localhost:36567' 19:07:12 INFO - SUITE-START | Running 2 tests 19:07:12 INFO - TEST-START | dromaeo_css 19:07:12 INFO - Initialising browser for dromaeo_css test... 19:07:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36567/getInfo.html -profile /tmp/tmp2GYRhx/profile 19:07:12 INFO - TEST-INFO | started process 9238 (/builds/slave/test/build/application/firefox/firefox http://localhost:36567/getInfo.html) 19:07:18 INFO - TEST-INFO | 9238: exit 0 19:07:18 INFO - Browser initialized. 19:07:18 INFO - Running cycle 1/1 for dromaeo_css test... 19:07:18 INFO - TEST-INFO | started process 9463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2GYRhx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:19 INFO - PID 9463 | 19:07:19 INFO - PID 9463 | (/builds/slave/test/build/application/firefox/firefox:9517): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:07:19 INFO - PID 9463 | 19:07:30 INFO - PID 9463 | RSS: Main: 173871104 19:07:30 INFO - PID 9463 | 19:07:30 INFO - PID 9463 | serialization: Helvetica 19:07:30 INFO - PID 9463 | serialization: Arial 19:10:29 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36567/tests/dromaeo/cssquery-ext.html) 19:10:30 INFO - PID 9463 | RSS: Main: 175677440 19:10:30 INFO - PID 9463 | 19:10:30 INFO - PID 9463 | serialization: Helvetica 19:10:30 INFO - PID 9463 | serialization: Arial 19:13:32 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-ext.html (next: http://localhost:36567/tests/dromaeo/cssquery-jquery.html) 19:13:33 INFO - PID 9463 | RSS: Main: 173170688 19:13:33 INFO - PID 9463 | 19:13:33 INFO - PID 9463 | serialization: Helvetica 19:13:33 INFO - PID 9463 | serialization: Arial 19:16:35 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36567/tests/dromaeo/cssquery-mootools.html) 19:16:35 INFO - PID 9463 | RSS: Main: 175034368 19:16:35 INFO - PID 9463 | 19:16:35 INFO - PID 9463 | serialization: Helvetica 19:16:35 INFO - PID 9463 | serialization: Arial 19:19:37 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36567/tests/dromaeo/cssquery-prototype.html) 19:19:38 INFO - PID 9463 | RSS: Main: 173268992 19:19:38 INFO - PID 9463 | 19:19:38 INFO - PID 9463 | serialization: Helvetica 19:19:38 INFO - PID 9463 | serialization: Arial 19:22:42 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36567/tests/dromaeo/cssquery-yui.html) 19:22:42 INFO - PID 9463 | RSS: Main: 176828416 19:22:42 INFO - PID 9463 | 19:22:42 INFO - PID 9463 | serialization: Helvetica 19:22:42 INFO - PID 9463 | serialization: Arial 19:25:44 INFO - PID 9463 | Cycle 1(1): loaded http://localhost:36567/tests/dromaeo/cssquery-yui.html (next: http://localhost:36567/tests/dromaeo/cssquery-dojo.html) 19:25:44 INFO - PID 9463 | RSS: Main: 177598464 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | __start_tp_report 19:25:44 INFO - PID 9463 | _x_x_mozilla_page_load 19:25:44 INFO - PID 9463 | _x_x_mozilla_page_load_details 19:25:44 INFO - PID 9463 | |i|pagename|runs| 19:25:44 INFO - PID 9463 | |0;dojo.html;3169.176014236299;3175.7776955613103;3207.8556464959074;3209.3420848726014;3216.7909085909414;6104.664243466607;6170.382961703833;6206.255249370076;6219.502439804816;6242.18851549298;6170.228721409824;6266.185395898538;6290.119383286332;6394.904076438846;6428.26075001375;5712.22884910537;5759.395263497336;5761.279840019997;5799.623024503394;5816.214811000503;850.7137131582195;5513.862153446155;5643.746031428595;5692.0608099663505;5821.446962538574;5717.685527295997;5742.109972954198;5752.079667253241;5787.710614469281;5800.4489573490455;5733.655980641175;5742.3396309424115;5794.043982742843;5802.33273173582;5827.067669172912;5633.464820842013;5763.855903602402;5770.422957704196;5773;5775.768969241225;6173.104899789505;6197.256329240475;6222.937770622281;6298.937010629881;6301.527385446064;6593.175853018372;6657.334266573353;6706.463482921404;6708.463322934153;6783.525153239275;6701.29636388182;6721.798346049626;6755.9324406755795;6765.323467653196;6767.323267673193;6261.311255761862;6270.65511396873;6280.937190628035;6292.5595208335435;6302.779402720883;6833.863322733518;6836.179658441019;6845.8973115403305;6938.965305173543;6944.097267355211;6480.870382592322;6525.608463492205;6567.4417674497245;6589.24223714279;6618.966905165444;6686.197656281277;6699.9665001674675;6705.798826035227;6705.966470167716;6707.5975441473665;6574.57265277765;6684.832879177962;6686.264510903797;6702.698378572976;6706.597604143767;5839.620424672383;6625.3374662534325;6681.866362672719;6702.832429189211;6705.899411508832;5389.730513474311;5405.324334458192;5462.2079798429;5476.452354764571;5479.0959491684225;4556.589906908394;4606.654500912445;4629.8148074077335;4675.368825208621;4702.835400761025;5741.138829175574;5754.913676294859;5764.74058667361;5765.8558536036935;5767.913481297784;6793.932060679429;6811.25076241613;6815.522913396114;6819.556728812611;6825.146856642919;5791.913121303184;5809.564282678816;5819.214406055128;5827.79602713903;5832.125181222766;5920.082387229986;5933.732982015819;5964.105384192406;6002.669853158118;6020.337762846083;6557.9344206557325;6564.212294524592;6611.933880661132;6645.235797883209;6652.800415987528;6685.699143538455;6756.223034351113;6760.3239676032;6856.5200435969;6859.897101543381;6584.04531342943;6594.538382313192;6606.10817539626;6609.933900660932;6612;6701.095352127595;6702.698378572878;6707.564008339442;6745.156855393076;6745.93254067453;6770.187577490536;6784.864302714017;6795.218549866631;6891.586504809728;6893.448524118159;6464.741410343721;6568.507361947969;6568.901466477911;6571.277159512545;6622.768203112868;6493.967530162319;6501.674916254263;6515.576487528296;6515.641639709672;6535.281119076993;6378.489720822416;6450.516211284079;6452.451541619015;6458.321876202931;6458.677066146768;5762.625429347079;6472.385123413268;6554.279029306867;6649.700763465559;6694.062831203538;6355.745770169141;6394.104825324552;6398.680065996775;6474.158359413246;6476.287608362982 19:25:44 INFO - PID 9463 | |1;ext.html;791.2364568191693;850.7065062553419;888.8711136885152;891.0777345447461;1133.2463911498853;29563.55654665179;40760;41586.79206603963;41617;41708;41506.58493415065;41678.37482437766;41792.37311440331;41798.164036719245;41952.58047419525;7506.474546781727;7727.343175830061;7728.806779830493;7739.342155916754;7750.4962177458565;7615.5811430371305;7679.69281228753;7722.073351197864;7737.303642672158;7745;7719.922800771977;7755.844883102334;7762.107357653857;7772.26163514468;7774.766756997299;7686.385089192851;7700.6919723211;7711.113221979488;7714.768556943301;7733.96133019337;7543.924560754432;7563.9621801890635;7590.848183036308;7625;7630.084389873251;37714.81142594297;37752.81123594392;37864.62135378639;37875.81062094672;38023.42964855529;3631.2011357501306;3658.158623516606;3661.176235347026;3666.4866918631415;3666.5416822897137;30164.0950771475;30423.543646845315;30556.847215764003;30632.081037568907;30703;5048.7728052237735;5053.166227572447;5061.139606266906;5083.008813281412;5116.027954688634;185728;186990;187724;188349;189801;48544;48553;48565.271520927214;48651.756741216064;48681;49777;50083.499165008616;50203.497965020615;50315.24527132096;50355.24467132996;14509.637259068608;14791.926040369945;14811.925940370445;16451.67096658084;16538.25577849;13907;13913;13926.094803837717;13927.164370137823;13940.58178254654;14284.785728214085;14353.64115897111;14384.712305753827;14514.274286285643;14576.562703118923;5905.844366806171;6001;6045.72794224261;6050.2437195350585;6056.788012419544;987.2595553334999;1015.4212099103588;1017.5268500147467;1031.3554028732042;1031.437866362834;22588.369099996966;23073.42316442069;23203.187888423825;23348.649770253458;23508.294751157493;1105.5065991466927;1121.4056550028497;1127.3912087472836;1131.9660410187707;1144.0618692671928;12106.334151621746;12162.878371216351;12223.572174973833;12237.877621223673;12283.508659653693;217322;217583;218018;218159;219008;52457.47542524526;52665.7366713164;52842;53079.469205308225;53252;1443.4082026369138;1483.2954346685237;1494.3648949196547;1511.4105498855456;1511.6749898771816;22954.655680164477;23038.42403939915;23211.419714507272;23323.416914577272;23326.533469330858;36130.63869361378;36282.4557631641;36295.455568167024;36303;36330.636693632725;186614;186731;186781;187473;187835;33050.33899322048;34027;35855.82072089623;35959.64040359668;36004.639953600126;45261.32108018317;46475;46766;47035;47397.52602474069;34242.48636270408;34317.82841085878;34454.31091378209;34527.482087769204;34561.65438345585;33701.49447758334;34070.8296458526;34126.31747365089;34209;34667.47998780071;37404.81297593495;37698.62301376951;37703.434448483844;37779.244415112094;37914.43128353132;32727.836360818044;32980.340393192484;33024.66975330312;33148.502772458916;33492.832535837166;24588.139415120386;24593.631095533223;24641.630375544024;24940;25183.49633007293 19:25:44 INFO - PID 9463 | |2;jquery.html;580;583.2301362201895;595.1192235491474;596.1415561591311;609.2567068176824;21579.784202157975;22435;22448.102075916962;22461.101555937763;23518.412039698975;26525.336866578346;26728;26755.732442675566;27042.459150816972;27121;6557.082008518799;6728.562643428186;6729.158855143107;6729.25978142404;6731.461483081342;4093.1199792044704;5822.524682441578;6526.869462610745;6591.967040164816;6602.603843769365;4124.381342798574;6807.115075040238;6827.317268273157;6827.897581536281;6831.521793474459;6796.864062718767;6810.727570897158;6823.317668233161;6823.658817059128;6824.965875170592;6670.899936500957;6677.098591690156;6678.332166783332;6681.799546013627;6691.297413771533;31048.53427198594;31281.217969550715;31727.27862860331;32091.518627220612;32183.034508964534;1951.5608987977732;1999.1603526518898;2010.497375656086;2011.6077364913847;2012.5371164632218;20630;21214.5757084859;21297.893510532347;21310.36068917935;21384.25155119579;2495.4510007798253;2509.924702258935;2511.259178542316;2615.3461634591354;2624.3045592917892;145927;149978.25010874876;150865;150975;152120.23939880342;21391.358259252247;22538.661920071212;23158.884205578863;23215.53568928612;23524.64713029306;45248;45508.72456377234;45563.772181138884;45590.31614525785;45604.771976139906;11498.827517587242;11524.135689823297;11631.59289424866;11712.941435292769;11918.225315354473;8099.514029158269;9760.219182465386;9793.657221997197;9839.655612053544;9945.502724863727;9347.719568412958;11527.365994870363;11605.419729013684;11684.357360345262;11761.117916156323;3838.9059118151195;3843.9231215376094;3868.323043467382;4065.5527891931865;4475.261581839025;958.0993865766296;983.233078199006;984.4880662055691;992.3648864726581;998.9250806189419;20416.387508374773;20699.27552535654;20718.48203794887;20728.48178795542;21093.78906210949;1044.8641676581997;1061.8585021102347;1064.9361038337724;1068.3109394440542;1071.3678929431674;13859;14506.782398264035;14611;14802.407903683732;15012.47456339023;480184;481299;492136;492392;499612;117418;127409;128260;128526;129347.35326323497;1238.58507400022;1271.7456508698297;1324.9668758280927;1327.5486334646266;1331.6737399337223;21524;21987.23044693428;21993.780062199174;22079.33761987143;22150.556988860455;60103;61884.96983788851;62671;63064.684676576326;63237.36762632315;74093;74274;74395.6280218617;74722;75757.72726818205;14873.256337183315;15128.924355378153;15196.696066078837;15213.391464341303;15217.239138042833;23456;23772;23797.405064873517;23800.166994155123;23834.88082559576;18684.906575467037;18763.437096887115;18829.058547072866;18949;18958.715619265447;17008.829911700726;17071.317147314465;17404.651906962044;17767.289308428037;18243.361482348053;18631.906840465712;19090;19305;19522.8047719521;19632.312869049514;15076.396944122112;15122.319495622503;15194;15225.923870380577;15238.847611523743;18825.811741882408;18871.339503117324;18873;19027.33404330842;19120.521986950436 19:25:44 INFO - PID 9463 | |3;mootools.html;1335.6260247130801;1406.648337915521;1410.5274732964456;1418.751718449271;1424.9430022799086;13944;14894.329755161016;14933.925330373333;14999;14999.550013499613;14519.49181778638;14725.116493010426;14729.631759205999;14764.704705905875;14787.408503659868;2651.992242947682;2654.3629528913116;2717.171262764856;2770.0858716623466;2771.071690983523;2591.7796987256106;2632.315597944529;2632.578787394017;2632.8157029007975;2633.894644214229;2597.844129352245;2661.8535980521065;2662.986685066572;2673.3851214220645;2687.784977201829;2627.408833012576;2645.722199169079;2654.8407095574134;2676.9732302677016;2689.260453375318;2570.717221105677;2607.4654695787317;2608;2625.8030647701307;2627.78977681785;13998.93000535001;14144.929275353661;14185.361658725382;14573.562793116223;14589.124652520883;7812.843743125162;8112.188781121899;8122.431429799916;8132.512049277003;8132.715354962607;5171.276021357013;5285.682859028432;5385.3268341457315;5398.406175320712;5421.620486565942;1895.469268604793;1939.864209505335;1941.1264930781206;1971.5366888781125;1971.684530475117;23347.53304933892;23480.64779028316;23522.411939701473;23585.528289434285;23606.527869442514;6406.551541392151;6473.352664733583;6650.73397064112;6664.86670266592;6676.26561078281;15944;15950.601234968986;15968.201589920458;15971.440999565191;15982.680346393006;7569.129550101698;7687.923120768833;7708.38332933364;7709.691612335444;7716.2669546393;5857.736401861926;6033.78881739137;6325.399087086719;6330.05049242608;7265.237150099163;5045.621578381562;5258.290130832365;5314.415414304423;5344;5358.812441564526;1544.2124516496667;1565.7807906893045;1568.0278227498795;1578.3134336563633;1601.7357136072417;896.4262871762078;924.5469719837231;931.6087243357806;939.7697564096703;944.004075700143;7460.962695186489;7507.887381689279;7538.547687138789;7574.356179724785;7668.693252269958;734.5996431944603;740.9333160015625;743.8884167374937;746.2574738135589;752.1838804896748;4624.630029597624;4631.397918270671;4638.2115040443205;4653.95346046542;4657.930131048037;18652;19350.903245483965;19430.2227910882;19479.220831166876;20407.4898127548;19909.10409031597;20184.495387615134;20281.492962675755;20341.694874576893;20345.694814577793;10662.626808061681;11319.490622921989;11330.886691132982;11398.316101033965;11409.60066397672;8420.4947703138;8672.26285765717;8672.566371681265;8686.131386861263;8961.775955601162;17067;17263.22315495831;17502.82497175063;17526.561835954202;17676.91161544184;17562.648747025243;17623.383181588582;17710.291588336324;18009.819901800813;18024.459266222035;11591.188616796744;11937.343446110548;11974.820377694516;11991.520339186334;11991.520339186334;13031.283279419724;13247.20516768997;13363.933180334036;13376.130551514121;13382.397792099184;11022.724431889266;11082.445877706245;11955.940220299191;12072.698182545155;12268.877311226774;11524.13568982313;11587.826182607436;11760.82358764602;11864.406779661154;12041.879581204075;9879.50602469888;9956.402615843073;9994.700158995242;10000.699979000641;10003.14973227284;7044.753433629799;7050.471214658818;7171.42628589722;7469.701211951461;7517.323440890346;7447.776566703008;7511.211322811245;7616.466847320856;7706.537607743553;7787.844243115219 19:25:44 INFO - PID 9463 | |4;prototype.html;475.3796295833935;496.99751501242497;500.4920006193712;507.796881247501;523.7302789063633;6166.414190651886;6169.753209871606;6177.166082578845;6191.009438489843;6238.1266622672865;6025.126356678279;6048.3044449888275;6129.969350153254;6136.539759518032;6147.8770424591485;5047.798088076473;5063;5072.391313042422;5084.949150508503;5104.642675012732;4803.5676789088975;5052.393712754456;5055.924161137567;5095.184770436731;5152.92270615941;4869.344422896214;4883.169861123618;4885.8778530536665;4904;4907.460179380265;4865.737432094075;4896.265560165968;4907.705537667752;4909.7790599423115;4926.2118061110405;4260.318349064135;4317.15815415994;4347.434923427563;4372.934405983913;4403.361512580658;5864.941350586482;5873.647581145145;5913.846799874026;5943.64338139713;5992.602958816465;5517.206907754996;5586.413426590231;5597.692126933017;5603.887922241533;5622.522085622686;6398.776042838478;6399.456046236029;6411.807645770635;6423.293437721847;6507.772227972046;4787.832425865078;4800.639952003614;4822.927656085161;4835.791052236941;4868.391451068616;6421.967890160566;6574.441172500296;6644;6650.83372915681;6687;4833.3958255218095;4906.607471402279;4908.165611845995;4909.846186146253;4928.408590969107;4992.525710057539;5001.974990125099;5020.698758074527;5021.171506701427;5022.459166287831;5585.385607583163;5600.887982240332;5635.549156067505;5642.181883626933;5661.971690141605;6477.740890364333;6494.415502604788;6511.014140687042;6548.246951600531;6552.180977377828;1742.6166243426426;1742.8082910879793;1759.3490408548919;1763.4885883094016;1773.5122841218767;1154.486253617149;1183.5325046606542;1202.8015377462796;1217.622537013511;1217.8369656977566;5659.915101273484;5662.66024038559;5666.97166514173;5673.886522269531;5736.6558006519745;6512;6530.053142294436;6558.344165583403;6608.801735947929;6715.2613212546585;5647.209390685307;5652.236948012048;5692.516136128475;5727.7422515986045;5771.538276937835;3529.094289083866;3532.5407696999227;3560.412531932254;3570.4644303354703;3591.4612808078996;6340;6344.587601805868;6418.133551970518;6440.452561532228;6488.610683359014;6692.966535167293;6732;6761.763338283136;6776.085228494188;6809.761658342033;6387.616742995435;6388.744450221939;6438.903416448757;6465.739180859781;6505.154329937267;6579.2104947406615;6589.835254118685;6639.568428052161;6652.401283884474;6663.033860090357;6466.967665161644;6565.555577772882;6567.211934567882;6581.440577550962;6585.868282634417;5738.5696072795545;6356.4279214870885;6386.425221730066;6407.615543067431;6416.743330266737;4896.755162241945;4932.778024988812;4946.233333833262;4975.328330675457;4979.128652485873;6399.488040956619;6412.39082287182;6594.505412094208;6595.98822359185;6596.80209593713;6425.903611445926;6478.319776423407;6482.319356467503;6492.253390860112;6501.34986501365;6428.821266177022;6461.515386346136;6483.610983341015;6532.542722009413;6540.117084193573;6418.775342862978;6436.967815160894;6459.48080248694;6488.286288508166;6509.576877502947;6476.773312934213;6484.4812415005745;6511.479081673549;6552.934470655233;6587.4071333580205;6300.779472718433;6345.777897773741;6349.365063493614;6356.491480681627;6404 19:25:44 INFO - PID 9463 | |5;yui.html;896.6368620708615;908.5684299957517;918.0589895357258;919.2967379954335;948.3314263444272;16281.267342969566;16823.495295141136;16915.57711057224;16918.830811691896;22450.775492245073;18371.63256734868;18544.814551854477;18584.349547765833;18591.721124183114;18600;973.1582181413062;1029.0121483375967;1030.6392762533128;1039.2569312941246;1063.24509598185;1038.7143535527714;1040.5005597313293;1041.6302212714454;1048.0410424461609;1048.09863517375;1091.612477570463;1097.248384856372;1098.4288170151556;1105.0441368216516;1105.3312745788803;1102.1568500097433;1102.7298311913632;1102.81803502422;1102.862142232221;1103.2773533335599;796.55791035975;797.5613412623034;801.5711594297023;802.7631848604676;805.1787177079405;18672.06639668011;19091.80908190914;19166;19350.903245483823;19473.415797526097;21482.140714371406;21697.891510542504;21916.671249931263;22109.889450552804;22163;16538.58653533659;16672.166391680366;16763.49709508717;17351.91324043384;17928.462146135636;3735.458358537997;3736.1220113273357;3740.214554943465;3745.700343972476;3760.2667479841443;134464;134744.32627836798;134902.999999999;137348.31325843307;140711.29644351816;15709;16203.918980405258;16275.10486923207;16583.91708041452;16611.252493637814;30603;31221;31451.52822707661;31552.211194719857;31554.526682099327;8573.099824518336;8800.163984421597;8840.027596964328;8912.910870891337;8995;4239.236937351307;4330.523642399334;4411.228035093845;4414.448193975753;4423.447069116361;5182.663126896739;5344.438833922382;5349.866253343697;5353.652012619167;5703.287089113861;1111.9166062545341;1125.2573301620891;1131.095123900876;1132.1678566253797;1135.914806389524;446.23470747667903;446.5311423005831;449.4651364875787;449.74139869575123;449.9010217752089;10717.732056698645;10883.346999180074;11184.328940263611;11558.595449159238;11568.30590164576;521.1921521641441;526.5787370103901;531.5375623207757;541.4991133201852;541.9701916394636;5039.974800125976;5102.056119617882;5126.359205099363;5226.843194704165;5291.365036195682;97546;100133.49933250288;101728.49135754273;101899;104295;86890;87673;92190.53904730434;93470;94846.5257673721;73078;75176.62411687906;75392.62303688447;76422;77049.61475192588;10187.592496300065;10272.486375681336;10282.588696452358;10286;10385.844212336971;36924.815375922946;38071.809640951615;38822.4176637345;38935.6106438932;38990.80504597459;46608.76695616636;64676.353236468916;65836.67081664561;66347.66826165839;68106.65946670235;16953.830461695226;17082.572935676708;17093.658126837643;17283.91358043252;17341.046242456785;16645.750313745546;18633.90683046576;19265.90367048156;19370.12834422426;19376.321828735927;15927;15965.760513592073;16053.759193611872;16087.517374478784;16252.349906003627;16358.672826543641;16567.50297491077;16913.49259522167;17066.658666826843;17159.7426038607;16929.15354232308;17058.402955896483;17117.315307387566;17511.38710145139;17674.558136046187;11587.478563464832;11723.824142638037;11812.645620631394;11968.401579921143;12133.332666703416;12162.574309899112;13102.672433189247;13228.735425291248;13481.932590336986;13526.18842869431 19:25:44 INFO - PID 9463 | __end_tp_report 19:25:44 INFO - PID 9463 | __start_cc_report 19:25:44 INFO - PID 9463 | _x_x_mozilla_cycle_collect,373 19:25:44 INFO - PID 9463 | __end_cc_report 19:25:44 INFO - PID 9463 | __startTimestamp1502072744713__endTimestamp 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | ------- Summary: start ------- 19:25:44 INFO - PID 9463 | Number of tests: 6 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#0] dojo.html Cycles:165 Average:6153.14 Median:6458.32 stddev:840.75 (13.0%) stddev-sans-first:810.08 19:25:44 INFO - PID 9463 | Values: 3169.2 3175.8 3207.9 3209.3 3216.8 6104.7 6170.4 6206.3 6219.5 6242.2 6170.2 6266.2 6290.1 6394.9 6428.3 5712.2 5759.4 5761.3 5799.6 5816.2 850.7 5513.9 5643.7 5692.1 5821.4 5717.7 5742.1 5752.1 5787.7 5800.4 5733.7 5742.3 5794.0 5802.3 5827.1 5633.5 5763.9 5770.4 5773.0 5775.8 6173.1 6197.3 6222.9 6298.9 6301.5 6593.2 6657.3 6706.5 6708.5 6783.5 6701.3 6721.8 6755.9 6765.3 6767.3 6261.3 6270.7 6280.9 6292.6 6302.8 6833.9 6836.2 6845.9 6939.0 6944.1 6480.9 6525.6 6567.4 6589.2 6619.0 6686.2 6700.0 6705.8 6706.0 6707.6 6574.6 6684.8 6686.3 6702.7 6706.6 5839.6 6625.3 6681.9 6702.8 6705.9 5389.7 5405.3 5462.2 5476.5 5479.1 4556.6 4606.7 4629.8 4675.4 4702.8 5741.1 5754.9 5764.7 5765.9 5767.9 6793.9 6811.3 6815.5 6819.6 6825.1 5791.9 5809.6 5819.2 5827.8 5832.1 5920.1 5933.7 5964.1 6002.7 6020.3 6557.9 6564.2 6611.9 6645.2 6652.8 6685.7 6756.2 6760.3 6856.5 6859.9 6584.0 6594.5 6606.1 6609.9 6612.0 6701.1 6702.7 6707.6 6745.2 6745.9 6770.2 6784.9 6795.2 6891.6 6893.4 6464.7 6568.5 6568.9 6571.3 6622.8 6494.0 6501.7 6515.6 6515.6 6535.3 6378.5 6450.5 6452.5 6458.3 6458.7 5762.6 6472.4 6554.3 6649.7 6694.1 6355.7 6394.1 6398.7 6474.2 6476.3 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#1] ext.html Cycles:180 Average:37098.72 Median:36067.64 stddev:51236.34 (142.1%) stddev-sans-first:51307.53 19:25:44 INFO - PID 9463 | Values: 791.2 850.7 888.9 891.1 1133.2 29563.6 40760.0 41586.8 41617.0 41708.0 41506.6 41678.4 41792.4 41798.2 41952.6 7506.5 7727.3 7728.8 7739.3 7750.5 7615.6 7679.7 7722.1 7737.3 7745.0 7719.9 7755.8 7762.1 7772.3 7774.8 7686.4 7700.7 7711.1 7714.8 7734.0 7543.9 7564.0 7590.8 7625.0 7630.1 37714.8 37752.8 37864.6 37875.8 38023.4 3631.2 3658.2 3661.2 3666.5 3666.5 30164.1 30423.5 30556.8 30632.1 30703.0 5048.8 5053.2 5061.1 5083.0 5116.0 185728.0 186990.0 187724.0 188349.0 189801.0 48544.0 48553.0 48565.3 48651.8 48681.0 49777.0 50083.5 50203.5 50315.2 50355.2 14509.6 14791.9 14811.9 16451.7 16538.3 13907.0 13913.0 13926.1 13927.2 13940.6 14284.8 14353.6 14384.7 14514.3 14576.6 5905.8 6001.0 6045.7 6050.2 6056.8 987.3 1015.4 1017.5 1031.4 1031.4 22588.4 23073.4 23203.2 23348.6 23508.3 1105.5 1121.4 1127.4 1132.0 1144.1 12106.3 12162.9 12223.6 12237.9 12283.5 217322.0 217583.0 218018.0 218159.0 219008.0 52457.5 52665.7 52842.0 53079.5 53252.0 1443.4 1483.3 1494.4 1511.4 1511.7 22954.7 23038.4 23211.4 23323.4 23326.5 36130.6 36282.5 36295.5 36303.0 36330.6 186614.0 186731.0 186781.0 187473.0 187835.0 33050.3 34027.0 35855.8 35959.6 36004.6 45261.3 46475.0 46766.0 47035.0 47397.5 34242.5 34317.8 34454.3 34527.5 34561.7 33701.5 34070.8 34126.3 34209.0 34667.5 37404.8 37698.6 37703.4 37779.2 37914.4 32727.8 32980.3 33024.7 33148.5 33492.8 24588.1 24593.6 24641.6 24940.0 25183.5 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#2] jquery.html Cycles:180 Average:37099.29 Median:23187.21 stddev:83067.82 (358.2%) stddev-sans-first:83255.60 19:25:44 INFO - PID 9463 | Values: 580.0 583.2 595.1 596.1 609.3 21579.8 22435.0 22448.1 22461.1 23518.4 26525.3 26728.0 26755.7 27042.5 27121.0 6557.1 6728.6 6729.2 6729.3 6731.5 4093.1 5822.5 6526.9 6592.0 6602.6 4124.4 6807.1 6827.3 6827.9 6831.5 6796.9 6810.7 6823.3 6823.7 6825.0 6670.9 6677.1 6678.3 6681.8 6691.3 31048.5 31281.2 31727.3 32091.5 32183.0 1951.6 1999.2 2010.5 2011.6 2012.5 20630.0 21214.6 21297.9 21310.4 21384.3 2495.5 2509.9 2511.3 2615.3 2624.3 145927.0 149978.3 150865.0 150975.0 152120.2 21391.4 22538.7 23158.9 23215.5 23524.6 45248.0 45508.7 45563.8 45590.3 45604.8 11498.8 11524.1 11631.6 11712.9 11918.2 8099.5 9760.2 9793.7 9839.7 9945.5 9347.7 11527.4 11605.4 11684.4 11761.1 3838.9 3843.9 3868.3 4065.6 4475.3 958.1 983.2 984.5 992.4 998.9 20416.4 20699.3 20718.5 20728.5 21093.8 1044.9 1061.9 1064.9 1068.3 1071.4 13859.0 14506.8 14611.0 14802.4 15012.5 480184.0 481299.0 492136.0 492392.0 499612.0 117418.0 127409.0 128260.0 128526.0 129347.4 1238.6 1271.7 1325.0 1327.5 1331.7 21524.0 21987.2 21993.8 22079.3 22150.6 60103.0 61885.0 62671.0 63064.7 63237.4 74093.0 74274.0 74395.6 74722.0 75757.7 14873.3 15128.9 15196.7 15213.4 15217.2 23456.0 23772.0 23797.4 23800.2 23834.9 18684.9 18763.4 18829.1 18949.0 18958.7 17008.8 17071.3 17404.7 17767.3 18243.4 18631.9 19090.0 19305.0 19522.8 19632.3 15076.4 15122.3 15194.0 15225.9 15238.8 18825.8 18871.3 18873.0 19027.3 19120.5 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#3] mootools.html Cycles:180 Average:8965.68 Median:2607.73 stddev:6143.63 (235.6%) stddev-sans-first:6134.11 19:25:44 INFO - PID 9463 | Values: 1335.6 1406.6 1410.5 1418.8 1424.9 13944.0 14894.3 14933.9 14999.0 14999.6 14519.5 14725.1 14729.6 14764.7 14787.4 2652.0 2654.4 2717.2 2770.1 2771.1 2591.8 2632.3 2632.6 2632.8 2633.9 2597.8 2661.9 2663.0 2673.4 2687.8 2627.4 2645.7 2654.8 2677.0 2689.3 2570.7 2607.5 2608.0 2625.8 2627.8 13998.9 14144.9 14185.4 14573.6 14589.1 7812.8 8112.2 8122.4 8132.5 8132.7 5171.3 5285.7 5385.3 5398.4 5421.6 1895.5 1939.9 1941.1 1971.5 1971.7 23347.5 23480.6 23522.4 23585.5 23606.5 6406.6 6473.4 6650.7 6664.9 6676.3 15944.0 15950.6 15968.2 15971.4 15982.7 7569.1 7687.9 7708.4 7709.7 7716.3 5857.7 6033.8 6325.4 6330.1 7265.2 5045.6 5258.3 5314.4 5344.0 5358.8 1544.2 1565.8 1568.0 1578.3 1601.7 896.4 924.5 931.6 939.8 944.0 7461.0 7507.9 7538.5 7574.4 7668.7 734.6 740.9 743.9 746.3 752.2 4624.6 4631.4 4638.2 4654.0 4657.9 18652.0 19350.9 19430.2 19479.2 20407.5 19909.1 20184.5 20281.5 20341.7 20345.7 10662.6 11319.5 11330.9 11398.3 11409.6 8420.5 8672.3 8672.6 8686.1 8961.8 17067.0 17263.2 17502.8 17526.6 17676.9 17562.6 17623.4 17710.3 18009.8 18024.5 11591.2 11937.3 11974.8 11991.5 11991.5 13031.3 13247.2 13363.9 13376.1 13382.4 11022.7 11082.4 11955.9 12072.7 12268.9 11524.1 11587.8 11760.8 11864.4 12041.9 9879.5 9956.4 9994.7 10000.7 10003.1 7044.8 7050.5 7171.4 7469.7 7517.3 7447.8 7511.2 7616.5 7706.5 7787.8 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#4] prototype.html Cycles:180 Average:5436.19 Median:6008.86 stddev:1517.33 (25.3%) stddev-sans-first:1475.19 19:25:44 INFO - PID 9463 | Values: 475.4 497.0 500.5 507.8 523.7 6166.4 6169.8 6177.2 6191.0 6238.1 6025.1 6048.3 6130.0 6136.5 6147.9 5047.8 5063.0 5072.4 5084.9 5104.6 4803.6 5052.4 5055.9 5095.2 5152.9 4869.3 4883.2 4885.9 4904.0 4907.5 4865.7 4896.3 4907.7 4909.8 4926.2 4260.3 4317.2 4347.4 4372.9 4403.4 5864.9 5873.6 5913.8 5943.6 5992.6 5517.2 5586.4 5597.7 5603.9 5622.5 6398.8 6399.5 6411.8 6423.3 6507.8 4787.8 4800.6 4822.9 4835.8 4868.4 6422.0 6574.4 6644.0 6650.8 6687.0 4833.4 4906.6 4908.2 4909.8 4928.4 4992.5 5002.0 5020.7 5021.2 5022.5 5585.4 5600.9 5635.5 5642.2 5662.0 6477.7 6494.4 6511.0 6548.2 6552.2 1742.6 1742.8 1759.3 1763.5 1773.5 1154.5 1183.5 1202.8 1217.6 1217.8 5659.9 5662.7 5667.0 5673.9 5736.7 6512.0 6530.1 6558.3 6608.8 6715.3 5647.2 5652.2 5692.5 5727.7 5771.5 3529.1 3532.5 3560.4 3570.5 3591.5 6340.0 6344.6 6418.1 6440.5 6488.6 6693.0 6732.0 6761.8 6776.1 6809.8 6387.6 6388.7 6438.9 6465.7 6505.2 6579.2 6589.8 6639.6 6652.4 6663.0 6467.0 6565.6 6567.2 6581.4 6585.9 5738.6 6356.4 6386.4 6407.6 6416.7 4896.8 4932.8 4946.2 4975.3 4979.1 6399.5 6412.4 6594.5 6596.0 6596.8 6425.9 6478.3 6482.3 6492.3 6501.3 6428.8 6461.5 6483.6 6532.5 6540.1 6418.8 6437.0 6459.5 6488.3 6509.6 6476.8 6484.5 6511.5 6552.9 6587.4 6300.8 6345.8 6349.4 6356.5 6404.0 19:25:44 INFO - PID 9463 | 19:25:44 INFO - PID 9463 | [#5] yui.html Cycles:180 Average:22628.51 Median:18588.04 stddev:31296.83 (168.4%) stddev-sans-first:31342.09 19:25:44 INFO - PID 9463 | Values: 896.6 908.6 918.1 919.3 948.3 16281.3 16823.5 16915.6 16918.8 22450.8 18371.6 18544.8 18584.3 18591.7 18600.0 973.2 1029.0 1030.6 1039.3 1063.2 1038.7 1040.5 1041.6 1048.0 1048.1 1091.6 1097.2 1098.4 1105.0 1105.3 1102.2 1102.7 1102.8 1102.9 1103.3 796.6 797.6 801.6 802.8 805.2 18672.1 19091.8 19166.0 19350.9 19473.4 21482.1 21697.9 21916.7 22109.9 22163.0 16538.6 16672.2 16763.5 17351.9 17928.5 3735.5 3736.1 3740.2 3745.7 3760.3 134464.0 134744.3 134903.0 137348.3 140711.3 15709.0 16203.9 16275.1 16583.9 16611.3 30603.0 31221.0 31451.5 31552.2 31554.5 8573.1 8800.2 8840.0 8912.9 8995.0 4239.2 4330.5 4411.2 4414.4 4423.4 5182.7 5344.4 5349.9 5353.7 5703.3 1111.9 1125.3 1131.1 1132.2 1135.9 446.2 446.5 449.5 449.7 449.9 10717.7 10883.3 11184.3 11558.6 11568.3 521.2 526.6 531.5 541.5 542.0 5040.0 5102.1 5126.4 5226.8 5291.4 97546.0 100133.5 101728.5 101899.0 104295.0 86890.0 87673.0 92190.5 93470.0 94846.5 73078.0 75176.6 75392.6 76422.0 77049.6 10187.6 10272.5 10282.6 10286.0 10385.8 36924.8 38071.8 38822.4 38935.6 38990.8 46608.8 64676.4 65836.7 66347.7 68106.7 16953.8 17082.6 17093.7 17283.9 17341.0 16645.8 18633.9 19265.9 19370.1 19376.3 15927.0 15965.8 16053.8 16087.5 16252.3 16358.7 16567.5 16913.5 17066.7 17159.7 16929.2 17058.4 17117.3 17511.4 17674.6 11587.5 11723.8 11812.6 11968.4 12133.3 12162.6 13102.7 13228.7 13481.9 13526.2 19:25:44 INFO - PID 9463 | -------- Summary: end -------- 19:25:44 INFO - PID 9463 | 19:25:45 INFO - TEST-INFO | 9463: exit 0 19:25:45 INFO - TEST-OK | dromaeo_css | took 1113102ms 19:25:45 INFO - TEST-START | kraken 19:25:45 INFO - Initialising browser for kraken test... 19:25:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36567/getInfo.html -profile /tmp/tmpvmzsip/profile 19:25:45 INFO - TEST-INFO | started process 9839 (/builds/slave/test/build/application/firefox/firefox http://localhost:36567/getInfo.html) 19:25:51 INFO - TEST-INFO | 9839: exit 0 19:25:51 INFO - Browser initialized. 19:25:51 INFO - Running cycle 1/1 for kraken test... 19:25:51 INFO - TEST-INFO | started process 10063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvmzsip/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:25:52 INFO - PID 10063 | 19:25:52 INFO - PID 10063 | (/builds/slave/test/build/application/firefox/firefox:10118): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:25:52 INFO - PID 10063 | 19:26:03 INFO - PID 10063 | RSS: Main: 173387776 19:26:03 INFO - PID 10063 | 19:26:03 INFO - PID 10063 | serialization: Helvetica 19:26:03 INFO - PID 10063 | serialization: Arial 19:26:05 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36567/tests/kraken/driver.html?testName=audio-beat-detection) 19:26:06 INFO - PID 10063 | RSS: Main: 178065408 19:26:06 INFO - PID 10063 | 19:26:06 INFO - PID 10063 | serialization: Helvetica 19:26:06 INFO - PID 10063 | serialization: Arial 19:26:09 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36567/tests/kraken/driver.html?testName=audio-dft) 19:26:10 INFO - PID 10063 | RSS: Main: 179142656 19:26:10 INFO - PID 10063 | 19:26:10 INFO - PID 10063 | serialization: Helvetica 19:26:10 INFO - PID 10063 | serialization: Arial 19:26:13 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36567/tests/kraken/driver.html?testName=audio-fft) 19:26:13 INFO - PID 10063 | RSS: Main: 173871104 19:26:13 INFO - PID 10063 | 19:26:13 INFO - PID 10063 | serialization: Helvetica 19:26:13 INFO - PID 10063 | serialization: Arial 19:26:15 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36567/tests/kraken/driver.html?testName=audio-oscillator) 19:26:16 INFO - PID 10063 | RSS: Main: 174641152 19:26:16 INFO - PID 10063 | 19:26:16 INFO - PID 10063 | serialization: Helvetica 19:26:16 INFO - PID 10063 | serialization: Arial 19:26:18 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:26:19 INFO - PID 10063 | RSS: Main: 174678016 19:26:19 INFO - PID 10063 | 19:26:19 INFO - PID 10063 | serialization: Helvetica 19:26:19 INFO - PID 10063 | serialization: Arial 19:26:22 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36567/tests/kraken/driver.html?testName=imaging-darkroom) 19:26:23 INFO - PID 10063 | RSS: Main: 177582080 19:26:23 INFO - PID 10063 | 19:26:23 INFO - PID 10063 | serialization: Helvetica 19:26:23 INFO - PID 10063 | serialization: Arial 19:26:26 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36567/tests/kraken/driver.html?testName=imaging-desaturate) 19:26:27 INFO - PID 10063 | RSS: Main: 176857088 19:26:27 INFO - PID 10063 | 19:26:27 INFO - PID 10063 | serialization: Helvetica 19:26:27 INFO - PID 10063 | serialization: Arial 19:26:30 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36567/tests/kraken/driver.html?testName=json-parse-financial) 19:26:30 INFO - PID 10063 | RSS: Main: 177483776 19:26:30 INFO - PID 10063 | 19:26:31 INFO - PID 10063 | serialization: Helvetica 19:26:31 INFO - PID 10063 | serialization: Arial 19:26:32 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:26:33 INFO - PID 10063 | RSS: Main: 177520640 19:26:33 INFO - PID 10063 | 19:26:33 INFO - PID 10063 | serialization: Helvetica 19:26:33 INFO - PID 10063 | serialization: Arial 19:26:35 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:26:35 INFO - PID 10063 | RSS: Main: 174780416 19:26:35 INFO - PID 10063 | 19:26:35 INFO - PID 10063 | serialization: Helvetica 19:26:35 INFO - PID 10063 | serialization: Arial 19:26:38 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:26:38 INFO - PID 10063 | RSS: Main: 174465024 19:26:38 INFO - PID 10063 | 19:26:38 INFO - PID 10063 | serialization: Helvetica 19:26:38 INFO - PID 10063 | serialization: Arial 19:26:41 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:26:42 INFO - PID 10063 | RSS: Main: 174850048 19:26:42 INFO - PID 10063 | 19:26:42 INFO - PID 10063 | serialization: Helvetica 19:26:42 INFO - PID 10063 | serialization: Arial 19:26:45 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:26:46 INFO - PID 10063 | RSS: Main: 174788608 19:26:46 INFO - PID 10063 | 19:26:46 INFO - PID 10063 | serialization: Helvetica 19:26:46 INFO - PID 10063 | serialization: Arial 19:26:47 INFO - PID 10063 | Cycle 1(1): loaded http://localhost:36567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36567/tests/kraken/driver.html?testName=ai-astar) 19:26:48 INFO - PID 10063 | RSS: Main: 176480256 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | __start_tp_report 19:26:48 INFO - PID 10063 | _x_x_mozilla_page_load 19:26:48 INFO - PID 10063 | _x_x_mozilla_page_load_details 19:26:48 INFO - PID 10063 | |i|pagename|runs| 19:26:48 INFO - PID 10063 | |0;ai-astar;97;112;104;107;106;111;109;98;105;111 19:26:48 INFO - PID 10063 | |1;audio-beat-detection;142;127;145;179;117;143;154;117;172;121 19:26:48 INFO - PID 10063 | |2;audio-dft;163;162;162;165;166;172;164;176;164;163 19:26:48 INFO - PID 10063 | |3;audio-fft;84;75;74;168;78;78;75;75;160;76 19:26:48 INFO - PID 10063 | |4;audio-oscillator;79;78;138;79;82;79;136;79;82;134 19:26:48 INFO - PID 10063 | |5;imaging-gaussian-blur;113;113;113;115;115;113;114;114;114;114 19:26:48 INFO - PID 10063 | |6;imaging-darkroom;151;153;154;152;152;152;151;149;152;158 19:26:48 INFO - PID 10063 | |7;imaging-desaturate;95;94;95;94;94;95;94;94;96;99 19:26:48 INFO - PID 10063 | |8;json-parse-financial;61;63;53;54;53;54;54;56;54;57 19:26:48 INFO - PID 10063 | |9;json-stringify-tinderbox;55;58;58;57;54;55;53;59;57;54 19:26:48 INFO - PID 10063 | |10;stanford-crypto-aes;79;77;78;85;95;103;78;81;79;78 19:26:48 INFO - PID 10063 | |11;stanford-crypto-ccm;128;125;127;144;130;131;130;137;131;190 19:26:48 INFO - PID 10063 | |12;stanford-crypto-pbkdf2;175;172;181;178;176;181;171;180;172;182 19:26:48 INFO - PID 10063 | |13;stanford-crypto-sha256-iterative;71;68;70;69;66;64;67;73;66;69 19:26:48 INFO - PID 10063 | __end_tp_report 19:26:48 INFO - PID 10063 | __start_cc_report 19:26:48 INFO - PID 10063 | _x_x_mozilla_cycle_collect,995 19:26:48 INFO - PID 10063 | __end_cc_report 19:26:48 INFO - PID 10063 | __startTimestamp1502072808109__endTimestamp 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | ------- Summary: start ------- 19:26:48 INFO - PID 10063 | Number of tests: 14 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#0] ai-astar Cycles:10 Average:106.00 Median:111.00 stddev:5.23 (4.7%) stddev-sans-first:4.42 19:26:48 INFO - PID 10063 | Values: 97.0 112.0 104.0 107.0 106.0 111.0 109.0 98.0 105.0 111.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:144.00 stddev:21.95 (15.2%) stddev-sans-first:23.29 19:26:48 INFO - PID 10063 | Values: 142.0 127.0 145.0 179.0 117.0 143.0 154.0 117.0 172.0 121.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#2] audio-dft Cycles:10 Average:165.70 Median:164.50 stddev:4.64 (2.8%) stddev-sans-first:4.82 19:26:48 INFO - PID 10063 | Values: 163.0 162.0 162.0 165.0 166.0 172.0 164.0 176.0 164.0 163.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#3] audio-fft Cycles:10 Average:94.30 Median:75.50 stddev:36.89 (48.9%) stddev-sans-first:38.94 19:26:48 INFO - PID 10063 | Values: 84.0 75.0 74.0 168.0 78.0 78.0 75.0 75.0 160.0 76.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:79.00 stddev:27.24 (34.5%) stddev-sans-first:28.13 19:26:48 INFO - PID 10063 | Values: 79.0 78.0 138.0 79.0 82.0 79.0 136.0 79.0 82.0 134.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 19:26:48 INFO - PID 10063 | Values: 113.0 113.0 113.0 115.0 115.0 113.0 114.0 114.0 114.0 114.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.00 stddev:2.37 (1.6%) stddev-sans-first:2.46 19:26:48 INFO - PID 10063 | Values: 151.0 153.0 154.0 152.0 152.0 152.0 151.0 149.0 152.0 158.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.56 (1.6%) stddev-sans-first:1.66 19:26:48 INFO - PID 10063 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 96.0 99.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:3.48 (6.3%) stddev-sans-first:3.16 19:26:48 INFO - PID 10063 | Values: 61.0 63.0 53.0 54.0 53.0 54.0 54.0 56.0 54.0 57.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:57.00 stddev:2.05 (3.6%) stddev-sans-first:2.15 19:26:48 INFO - PID 10063 | Values: 55.0 58.0 58.0 57.0 54.0 55.0 53.0 59.0 57.0 54.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:79.00 stddev:8.78 (11.1%) stddev-sans-first:9.18 19:26:48 INFO - PID 10063 | Values: 79.0 77.0 78.0 85.0 95.0 103.0 78.0 81.0 79.0 78.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:131.00 stddev:19.30 (14.7%) stddev-sans-first:20.17 19:26:48 INFO - PID 10063 | Values: 128.0 125.0 127.0 144.0 130.0 131.0 130.0 137.0 131.0 190.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:179.00 stddev:4.18 (2.3%) stddev-sans-first:4.39 19:26:48 INFO - PID 10063 | Values: 175.0 172.0 181.0 178.0 176.0 181.0 171.0 180.0 172.0 182.0 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:2.67 (3.9%) stddev-sans-first:2.65 19:26:48 INFO - PID 10063 | Values: 71.0 68.0 70.0 69.0 66.0 64.0 67.0 73.0 66.0 69.0 19:26:48 INFO - PID 10063 | -------- Summary: end -------- 19:26:48 INFO - PID 10063 | 19:26:48 INFO - PID 10063 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:26:48 INFO - TEST-INFO | 10063: exit 0 19:26:49 INFO - TEST-OK | kraken | took 63597ms 19:26:49 INFO - SUITE-END | took 1176s 19:26:49 INFO - Completed test suite (00:19:36) 19:26:49 INFO - javascript benchmark 19:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8550.237434196448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3169.176014236299, 3175.7776955613103, 3207.8556464959074, 3209.3420848726014, 3216.7909085909414, 6104.664243466607, 6170.382961703833, 6206.255249370076, 6219.502439804816, 6242.18851549298, 6170.228721409824, 6266.185395898538, 6290.119383286332, 6394.904076438846, 6428.26075001375, 5712.22884910537, 5759.395263497336, 5761.279840019997, 5799.623024503394, 5816.214811000503, 850.7137131582195, 5513.862153446155, 5643.746031428595, 5692.0608099663505, 5821.446962538574, 5717.685527295997, 5742.109972954198, 5752.079667253241, 5787.710614469281, 5800.4489573490455, 5733.655980641175, 5742.3396309424115, 5794.043982742843, 5802.33273173582, 5827.067669172912, 5633.464820842013, 5763.855903602402, 5770.422957704196, 5773.0, 5775.768969241225, 6173.104899789505, 6197.256329240475, 6222.937770622281, 6298.937010629881, 6301.527385446064, 6593.175853018372, 6657.334266573353, 6706.463482921404, 6708.463322934153, 6783.525153239275, 6701.29636388182, 6721.798346049626, 6755.9324406755795, 6765.323467653196, 6767.323267673193, 6261.311255761862, 6270.65511396873, 6280.937190628035, 6292.5595208335435, 6302.779402720883, 6833.863322733518, 6836.179658441019, 6845.8973115403305, 6938.965305173543, 6944.097267355211, 6480.870382592322, 6525.608463492205, 6567.4417674497245, 6589.24223714279, 6618.966905165444, 6686.197656281277, 6699.9665001674675, 6705.798826035227, 6705.966470167716, 6707.5975441473665, 6574.57265277765, 6684.832879177962, 6686.264510903797, 6702.698378572976, 6706.597604143767, 5839.620424672383, 6625.3374662534325, 6681.866362672719, 6702.832429189211, 6705.899411508832, 5389.730513474311, 5405.324334458192, 5462.2079798429, 5476.452354764571, 5479.0959491684225, 4556.589906908394, 4606.654500912445, 4629.8148074077335, 4675.368825208621, 4702.835400761025, 5741.138829175574, 5754.913676294859, 5764.74058667361, 5765.8558536036935, 5767.913481297784, 6793.932060679429, 6811.25076241613, 6815.522913396114, 6819.556728812611, 6825.146856642919, 5791.913121303184, 5809.564282678816, 5819.214406055128, 5827.79602713903, 5832.125181222766, 5920.082387229986, 5933.732982015819, 5964.105384192406, 6002.669853158118, 6020.337762846083, 6557.9344206557325, 6564.212294524592, 6611.933880661132, 6645.235797883209, 6652.800415987528, 6685.699143538455, 6756.223034351113, 6760.3239676032, 6856.5200435969, 6859.897101543381, 6584.04531342943, 6594.538382313192, 6606.10817539626, 6609.933900660932, 6612.0, 6701.095352127595, 6702.698378572878, 6707.564008339442, 6745.156855393076, 6745.93254067453, 6770.187577490536, 6784.864302714017, 6795.218549866631, 6891.586504809728, 6893.448524118159, 6464.741410343721, 6568.507361947969, 6568.901466477911, 6571.277159512545, 6622.768203112868, 6493.967530162319, 6501.674916254263, 6515.576487528296, 6515.641639709672, 6535.281119076993, 6378.489720822416, 6450.516211284079, 6452.451541619015, 6458.321876202931, 6458.677066146768, 5762.625429347079, 6472.385123413268, 6554.279029306867, 6649.700763465559, 6694.062831203538, 6355.745770169141, 6394.104825324552, 6398.680065996775, 6474.158359413246, 6476.287608362982], "value": 6093.508928447293, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2364568191693, 850.7065062553419, 888.8711136885152, 891.0777345447461, 1133.2463911498853, 29563.55654665179, 40760.0, 41586.79206603963, 41617.0, 41708.0, 41506.58493415065, 41678.37482437766, 41792.37311440331, 41798.164036719245, 41952.58047419525, 7506.474546781727, 7727.343175830061, 7728.806779830493, 7739.342155916754, 7750.4962177458565, 7615.5811430371305, 7679.69281228753, 7722.073351197864, 7737.303642672158, 7745.0, 7719.922800771977, 7755.844883102334, 7762.107357653857, 7772.26163514468, 7774.766756997299, 7686.385089192851, 7700.6919723211, 7711.113221979488, 7714.768556943301, 7733.96133019337, 7543.924560754432, 7563.9621801890635, 7590.848183036308, 7625.0, 7630.084389873251, 37714.81142594297, 37752.81123594392, 37864.62135378639, 37875.81062094672, 38023.42964855529, 3631.2011357501306, 3658.158623516606, 3661.176235347026, 3666.4866918631415, 3666.5416822897137, 30164.0950771475, 30423.543646845315, 30556.847215764003, 30632.081037568907, 30703.0, 5048.7728052237735, 5053.166227572447, 5061.139606266906, 5083.008813281412, 5116.027954688634, 185728.0, 186990.0, 187724.0, 188349.0, 189801.0, 48544.0, 48553.0, 48565.271520927214, 48651.756741216064, 48681.0, 49777.0, 50083.499165008616, 50203.497965020615, 50315.24527132096, 50355.24467132996, 14509.637259068608, 14791.926040369945, 14811.925940370445, 16451.67096658084, 16538.25577849, 13907.0, 13913.0, 13926.094803837717, 13927.164370137823, 13940.58178254654, 14284.785728214085, 14353.64115897111, 14384.712305753827, 14514.274286285643, 14576.562703118923, 5905.844366806171, 6001.0, 6045.72794224261, 6050.2437195350585, 6056.788012419544, 987.2595553334999, 1015.4212099103588, 1017.5268500147467, 1031.3554028732042, 1031.437866362834, 22588.369099996966, 23073.42316442069, 23203.187888423825, 23348.649770253458, 23508.294751157493, 1105.5065991466927, 1121.4056550028497, 1127.3912087472836, 1131.9660410187707, 1144.0618692671928, 12106.334151621746, 12162.878371216351, 12223.572174973833, 12237.877621223673, 12283.508659653693, 217322.0, 217583.0, 218018.0, 218159.0, 219008.0, 52457.47542524526, 52665.7366713164, 52842.0, 53079.469205308225, 53252.0, 1443.4082026369138, 1483.2954346685237, 1494.3648949196547, 1511.4105498855456, 1511.6749898771816, 22954.655680164477, 23038.42403939915, 23211.419714507272, 23323.416914577272, 23326.533469330858, 36130.63869361378, 36282.4557631641, 36295.455568167024, 36303.0, 36330.636693632725, 186614.0, 186731.0, 186781.0, 187473.0, 187835.0, 33050.33899322048, 34027.0, 35855.82072089623, 35959.64040359668, 36004.639953600126, 45261.32108018317, 46475.0, 46766.0, 47035.0, 47397.52602474069, 34242.48636270408, 34317.82841085878, 34454.31091378209, 34527.482087769204, 34561.65438345585, 33701.49447758334, 34070.8296458526, 34126.31747365089, 34209.0, 34667.47998780071, 37404.81297593495, 37698.62301376951, 37703.434448483844, 37779.244415112094, 37914.43128353132, 32727.836360818044, 32980.340393192484, 33024.66975330312, 33148.502772458916, 33492.832535837166, 24588.139415120386, 24593.631095533223, 24641.630375544024, 24940.0, 25183.49633007293], "value": 17307.73037742324, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.0, 583.2301362201895, 595.1192235491474, 596.1415561591311, 609.2567068176824, 21579.784202157975, 22435.0, 22448.102075916962, 22461.101555937763, 23518.412039698975, 26525.336866578346, 26728.0, 26755.732442675566, 27042.459150816972, 27121.0, 6557.082008518799, 6728.562643428186, 6729.158855143107, 6729.25978142404, 6731.461483081342, 4093.1199792044704, 5822.524682441578, 6526.869462610745, 6591.967040164816, 6602.603843769365, 4124.381342798574, 6807.115075040238, 6827.317268273157, 6827.897581536281, 6831.521793474459, 6796.864062718767, 6810.727570897158, 6823.317668233161, 6823.658817059128, 6824.965875170592, 6670.899936500957, 6677.098591690156, 6678.332166783332, 6681.799546013627, 6691.297413771533, 31048.53427198594, 31281.217969550715, 31727.27862860331, 32091.518627220612, 32183.034508964534, 1951.5608987977732, 1999.1603526518898, 2010.497375656086, 2011.6077364913847, 2012.5371164632218, 20630.0, 21214.5757084859, 21297.893510532347, 21310.36068917935, 21384.25155119579, 2495.4510007798253, 2509.924702258935, 2511.259178542316, 2615.3461634591354, 2624.3045592917892, 145927.0, 149978.25010874876, 150865.0, 150975.0, 152120.23939880342, 21391.358259252247, 22538.661920071212, 23158.884205578863, 23215.53568928612, 23524.64713029306, 45248.0, 45508.72456377234, 45563.772181138884, 45590.31614525785, 45604.771976139906, 11498.827517587242, 11524.135689823297, 11631.59289424866, 11712.941435292769, 11918.225315354473, 8099.514029158269, 9760.219182465386, 9793.657221997197, 9839.655612053544, 9945.502724863727, 9347.719568412958, 11527.365994870363, 11605.419729013684, 11684.357360345262, 11761.117916156323, 3838.9059118151195, 3843.9231215376094, 3868.323043467382, 4065.5527891931865, 4475.261581839025, 958.0993865766296, 983.233078199006, 984.4880662055691, 992.3648864726581, 998.9250806189419, 20416.387508374773, 20699.27552535654, 20718.48203794887, 20728.48178795542, 21093.78906210949, 1044.8641676581997, 1061.8585021102347, 1064.9361038337724, 1068.3109394440542, 1071.3678929431674, 13859.0, 14506.782398264035, 14611.0, 14802.407903683732, 15012.47456339023, 480184.0, 481299.0, 492136.0, 492392.0, 499612.0, 117418.0, 127409.0, 128260.0, 128526.0, 129347.35326323497, 1238.58507400022, 1271.7456508698297, 1324.9668758280927, 1327.5486334646266, 1331.6737399337223, 21524.0, 21987.23044693428, 21993.780062199174, 22079.33761987143, 22150.556988860455, 60103.0, 61884.96983788851, 62671.0, 63064.684676576326, 63237.36762632315, 74093.0, 74274.0, 74395.6280218617, 74722.0, 75757.72726818205, 14873.256337183315, 15128.924355378153, 15196.696066078837, 15213.391464341303, 15217.239138042833, 23456.0, 23772.0, 23797.405064873517, 23800.166994155123, 23834.88082559576, 18684.906575467037, 18763.437096887115, 18829.058547072866, 18949.0, 18958.715619265447, 17008.829911700726, 17071.317147314465, 17404.651906962044, 17767.289308428037, 18243.361482348053, 18631.906840465712, 19090.0, 19305.0, 19522.8047719521, 19632.312869049514, 15076.396944122112, 15122.319495622503, 15194.0, 15225.923870380577, 15238.847611523743, 18825.811741882408, 18871.339503117324, 18873.0, 19027.33404330842, 19120.521986950436], "value": 13130.782683721707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.6260247130801, 1406.648337915521, 1410.5274732964456, 1418.751718449271, 1424.9430022799086, 13944.0, 14894.329755161016, 14933.925330373333, 14999.0, 14999.550013499613, 14519.49181778638, 14725.116493010426, 14729.631759205999, 14764.704705905875, 14787.408503659868, 2651.992242947682, 2654.3629528913116, 2717.171262764856, 2770.0858716623466, 2771.071690983523, 2591.7796987256106, 2632.315597944529, 2632.578787394017, 2632.8157029007975, 2633.894644214229, 2597.844129352245, 2661.8535980521065, 2662.986685066572, 2673.3851214220645, 2687.784977201829, 2627.408833012576, 2645.722199169079, 2654.8407095574134, 2676.9732302677016, 2689.260453375318, 2570.717221105677, 2607.4654695787317, 2608.0, 2625.8030647701307, 2627.78977681785, 13998.93000535001, 14144.929275353661, 14185.361658725382, 14573.562793116223, 14589.124652520883, 7812.843743125162, 8112.188781121899, 8122.431429799916, 8132.512049277003, 8132.715354962607, 5171.276021357013, 5285.682859028432, 5385.3268341457315, 5398.406175320712, 5421.620486565942, 1895.469268604793, 1939.864209505335, 1941.1264930781206, 1971.5366888781125, 1971.684530475117, 23347.53304933892, 23480.64779028316, 23522.411939701473, 23585.528289434285, 23606.527869442514, 6406.551541392151, 6473.352664733583, 6650.73397064112, 6664.86670266592, 6676.26561078281, 15944.0, 15950.601234968986, 15968.201589920458, 15971.440999565191, 15982.680346393006, 7569.129550101698, 7687.923120768833, 7708.38332933364, 7709.691612335444, 7716.2669546393, 5857.736401861926, 6033.78881739137, 6325.399087086719, 6330.05049242608, 7265.237150099163, 5045.621578381562, 5258.290130832365, 5314.415414304423, 5344.0, 5358.812441564526, 1544.2124516496667, 1565.7807906893045, 1568.0278227498795, 1578.3134336563633, 1601.7357136072417, 896.4262871762078, 924.5469719837231, 931.6087243357806, 939.7697564096703, 944.004075700143, 7460.962695186489, 7507.887381689279, 7538.547687138789, 7574.356179724785, 7668.693252269958, 734.5996431944603, 740.9333160015625, 743.8884167374937, 746.2574738135589, 752.1838804896748, 4624.630029597624, 4631.397918270671, 4638.2115040443205, 4653.95346046542, 4657.930131048037, 18652.0, 19350.903245483965, 19430.2227910882, 19479.220831166876, 20407.4898127548, 19909.10409031597, 20184.495387615134, 20281.492962675755, 20341.694874576893, 20345.694814577793, 10662.626808061681, 11319.490622921989, 11330.886691132982, 11398.316101033965, 11409.60066397672, 8420.4947703138, 8672.26285765717, 8672.566371681265, 8686.131386861263, 8961.775955601162, 17067.0, 17263.22315495831, 17502.82497175063, 17526.561835954202, 17676.91161544184, 17562.648747025243, 17623.383181588582, 17710.291588336324, 18009.819901800813, 18024.459266222035, 11591.188616796744, 11937.343446110548, 11974.820377694516, 11991.520339186334, 11991.520339186334, 13031.283279419724, 13247.20516768997, 13363.933180334036, 13376.130551514121, 13382.397792099184, 11022.724431889266, 11082.445877706245, 11955.940220299191, 12072.698182545155, 12268.877311226774, 11524.13568982313, 11587.826182607436, 11760.82358764602, 11864.406779661154, 12041.879581204075, 9879.50602469888, 9956.402615843073, 9994.700158995242, 10000.699979000641, 10003.14973227284, 7044.753433629799, 7050.471214658818, 7171.42628589722, 7469.701211951461, 7517.323440890346, 7447.776566703008, 7511.211322811245, 7616.466847320856, 7706.537607743553, 7787.844243115219], "value": 6478.157551389725, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.3796295833935, 496.99751501242497, 500.4920006193712, 507.796881247501, 523.7302789063633, 6166.414190651886, 6169.753209871606, 6177.166082578845, 6191.009438489843, 6238.1266622672865, 6025.126356678279, 6048.3044449888275, 6129.969350153254, 6136.539759518032, 6147.8770424591485, 5047.798088076473, 5063.0, 5072.391313042422, 5084.949150508503, 5104.642675012732, 4803.5676789088975, 5052.393712754456, 5055.924161137567, 5095.184770436731, 5152.92270615941, 4869.344422896214, 4883.169861123618, 4885.8778530536665, 4904.0, 4907.460179380265, 4865.737432094075, 4896.265560165968, 4907.705537667752, 4909.7790599423115, 4926.2118061110405, 4260.318349064135, 4317.15815415994, 4347.434923427563, 4372.934405983913, 4403.361512580658, 5864.941350586482, 5873.647581145145, 5913.846799874026, 5943.64338139713, 5992.602958816465, 5517.206907754996, 5586.413426590231, 5597.692126933017, 5603.887922241533, 5622.522085622686, 6398.776042838478, 6399.456046236029, 6411.807645770635, 6423.293437721847, 6507.772227972046, 4787.832425865078, 4800.639952003614, 4822.927656085161, 4835.791052236941, 4868.391451068616, 6421.967890160566, 6574.441172500296, 6644.0, 6650.83372915681, 6687.0, 4833.3958255218095, 4906.607471402279, 4908.165611845995, 4909.846186146253, 4928.408590969107, 4992.525710057539, 5001.974990125099, 5020.698758074527, 5021.171506701427, 5022.459166287831, 5585.385607583163, 5600.887982240332, 5635.549156067505, 5642.181883626933, 5661.971690141605, 6477.740890364333, 6494.415502604788, 6511.014140687042, 6548.246951600531, 6552.180977377828, 1742.6166243426426, 1742.8082910879793, 1759.3490408548919, 1763.4885883094016, 1773.5122841218767, 1154.486253617149, 1183.5325046606542, 1202.8015377462796, 1217.622537013511, 1217.8369656977566, 5659.915101273484, 5662.66024038559, 5666.97166514173, 5673.886522269531, 5736.6558006519745, 6512.0, 6530.053142294436, 6558.344165583403, 6608.801735947929, 6715.2613212546585, 5647.209390685307, 5652.236948012048, 5692.516136128475, 5727.7422515986045, 5771.538276937835, 3529.094289083866, 3532.5407696999227, 3560.412531932254, 3570.4644303354703, 3591.4612808078996, 6340.0, 6344.587601805868, 6418.133551970518, 6440.452561532228, 6488.610683359014, 6692.966535167293, 6732.0, 6761.763338283136, 6776.085228494188, 6809.761658342033, 6387.616742995435, 6388.744450221939, 6438.903416448757, 6465.739180859781, 6505.154329937267, 6579.2104947406615, 6589.835254118685, 6639.568428052161, 6652.401283884474, 6663.033860090357, 6466.967665161644, 6565.555577772882, 6567.211934567882, 6581.440577550962, 6585.868282634417, 5738.5696072795545, 6356.4279214870885, 6386.425221730066, 6407.615543067431, 6416.743330266737, 4896.755162241945, 4932.778024988812, 4946.233333833262, 4975.328330675457, 4979.128652485873, 6399.488040956619, 6412.39082287182, 6594.505412094208, 6595.98822359185, 6596.80209593713, 6425.903611445926, 6478.319776423407, 6482.319356467503, 6492.253390860112, 6501.34986501365, 6428.821266177022, 6461.515386346136, 6483.610983341015, 6532.542722009413, 6540.117084193573, 6418.775342862978, 6436.967815160894, 6459.48080248694, 6488.286288508166, 6509.576877502947, 6476.773312934213, 6484.4812415005745, 6511.479081673549, 6552.934470655233, 6587.4071333580205, 6300.779472718433, 6345.777897773741, 6349.365063493614, 6356.491480681627, 6404.0], "value": 4988.2912735646705, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.6368620708615, 908.5684299957517, 918.0589895357258, 919.2967379954335, 948.3314263444272, 16281.267342969566, 16823.495295141136, 16915.57711057224, 16918.830811691896, 22450.775492245073, 18371.63256734868, 18544.814551854477, 18584.349547765833, 18591.721124183114, 18600.0, 973.1582181413062, 1029.0121483375967, 1030.6392762533128, 1039.2569312941246, 1063.24509598185, 1038.7143535527714, 1040.5005597313293, 1041.6302212714454, 1048.0410424461609, 1048.09863517375, 1091.612477570463, 1097.248384856372, 1098.4288170151556, 1105.0441368216516, 1105.3312745788803, 1102.1568500097433, 1102.7298311913632, 1102.81803502422, 1102.862142232221, 1103.2773533335599, 796.55791035975, 797.5613412623034, 801.5711594297023, 802.7631848604676, 805.1787177079405, 18672.06639668011, 19091.80908190914, 19166.0, 19350.903245483823, 19473.415797526097, 21482.140714371406, 21697.891510542504, 21916.671249931263, 22109.889450552804, 22163.0, 16538.58653533659, 16672.166391680366, 16763.49709508717, 17351.91324043384, 17928.462146135636, 3735.458358537997, 3736.1220113273357, 3740.214554943465, 3745.700343972476, 3760.2667479841443, 134464.0, 134744.32627836798, 134902.999999999, 137348.31325843307, 140711.29644351816, 15709.0, 16203.918980405258, 16275.10486923207, 16583.91708041452, 16611.252493637814, 30603.0, 31221.0, 31451.52822707661, 31552.211194719857, 31554.526682099327, 8573.099824518336, 8800.163984421597, 8840.027596964328, 8912.910870891337, 8995.0, 4239.236937351307, 4330.523642399334, 4411.228035093845, 4414.448193975753, 4423.447069116361, 5182.663126896739, 5344.438833922382, 5349.866253343697, 5353.652012619167, 5703.287089113861, 1111.9166062545341, 1125.2573301620891, 1131.095123900876, 1132.1678566253797, 1135.914806389524, 446.23470747667903, 446.5311423005831, 449.4651364875787, 449.74139869575123, 449.9010217752089, 10717.732056698645, 10883.346999180074, 11184.328940263611, 11558.595449159238, 11568.30590164576, 521.1921521641441, 526.5787370103901, 531.5375623207757, 541.4991133201852, 541.9701916394636, 5039.974800125976, 5102.056119617882, 5126.359205099363, 5226.843194704165, 5291.365036195682, 97546.0, 100133.49933250288, 101728.49135754273, 101899.0, 104295.0, 86890.0, 87673.0, 92190.53904730434, 93470.0, 94846.5257673721, 73078.0, 75176.62411687906, 75392.62303688447, 76422.0, 77049.61475192588, 10187.592496300065, 10272.486375681336, 10282.588696452358, 10286.0, 10385.844212336971, 36924.815375922946, 38071.809640951615, 38822.4176637345, 38935.6106438932, 38990.80504597459, 46608.76695616636, 64676.353236468916, 65836.67081664561, 66347.66826165839, 68106.65946670235, 16953.830461695226, 17082.572935676708, 17093.658126837643, 17283.91358043252, 17341.046242456785, 16645.750313745546, 18633.90683046576, 19265.90367048156, 19370.12834422426, 19376.321828735927, 15927.0, 15965.760513592073, 16053.759193611872, 16087.517374478784, 16252.349906003627, 16358.672826543641, 16567.50297491077, 16913.49259522167, 17066.658666826843, 17159.7426038607, 16929.15354232308, 17058.402955896483, 17117.315307387566, 17511.38710145139, 17674.558136046187, 11587.478563464832, 11723.824142638037, 11812.645620631394, 11968.401579921143, 12133.332666703416, 12162.574309899112, 13102.672433189247, 13228.735425291248, 13481.932590336986, 13526.18842869431], "value": 8730.498317233716, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.0999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 112.0, 104.0, 107.0, 106.0, 111.0, 109.0, 98.0, 105.0, 111.0], "value": 106.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 127.0, 145.0, 179.0, 117.0, 143.0, 154.0, 117.0, 172.0, 121.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 165.0, 166.0, 172.0, 164.0, 176.0, 164.0, 163.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 74.0, 168.0, 78.0, 78.0, 75.0, 75.0, 160.0, 76.0], "value": 94.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 138.0, 79.0, 82.0, 79.0, 136.0, 79.0, 82.0, 134.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 115.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 154.0, 152.0, 152.0, 152.0, 151.0, 149.0, 152.0, 158.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 96.0, 99.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 53.0, 54.0, 53.0, 54.0, 54.0, 56.0, 54.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 58.0, 57.0, 54.0, 55.0, 53.0, 59.0, 57.0, 54.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 85.0, 95.0, 103.0, 78.0, 81.0, 79.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 127.0, 144.0, 130.0, 131.0, 130.0, 137.0, 131.0, 190.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 181.0, 178.0, 176.0, 181.0, 171.0, 180.0, 172.0, 182.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 69.0, 66.0, 64.0, 67.0, 73.0, 66.0, 69.0], "value": 68.3, "unit": "score"}]}]} 19:26:49 INFO - Return code: 0 19:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:26:49 INFO - # TBPL SUCCESS # 19:26:49 INFO - Running post-action listener: _package_coverage_data 19:26:49 INFO - Running post-action listener: _resource_record_post_action 19:26:49 INFO - [mozharness: 2017-08-07 02:26:49.378376Z] Finished run-tests step (success) 19:26:49 INFO - Running post-run listener: _resource_record_post_run 19:26:49 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429264896; Read time: 8; Write time: 417756 19:26:49 INFO - TinderboxPrint: CPU usage
13.2% 19:26:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:26:49 INFO - TinderboxPrint: I/O write bytes / time
429,264,896 / 417,756 19:26:49 INFO - TinderboxPrint: CPU idle
8,271.5 (86.8%) 19:26:49 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 19:26:49 INFO - TinderboxPrint: Swap in / out
0 / 0 19:26:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106336256; Read time: 0; Write time: 130016 19:26:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:26:49 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 322306048; Read time: 0; Write time: 287692 19:26:50 INFO - Running post-run listener: _upload_blobber_files 19:26:50 INFO - Blob upload gear active. 19:26:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:26:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:26:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:26:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:26:50 INFO - (blobuploader) - INFO - Open directory for files ... 19:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:26:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:51 INFO - (blobuploader) - INFO - Done attempting. 19:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:26:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:51 INFO - (blobuploader) - INFO - Done attempting. 19:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:52 INFO - (blobuploader) - INFO - Done attempting. 19:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:26:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:26:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:26:56 INFO - (blobuploader) - INFO - Done attempting. 19:26:56 INFO - (blobuploader) - INFO - Iteration through files over. 19:26:56 INFO - Return code: 0 19:26:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:26:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:26:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176870f8e23f034b5b1e2da6353ffc9bdde0e743b167f1deb0a463eb91f3ad78d01ff0c4f5eacbad635b34e188f8716845630e20c8ed915fe19d054730ce6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb471e93c39d38279d7ec26eb37a84eeb7b53e1bbd687f506ba103f6d4b81160acc5593b6b5a79f28ce65d980f3525490093735c4664bca41665cc76219e2191", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22c8ccb8487c8429571fc314b285c93790370c03a10d7b00c87b52cda6ca34f92f33ff5f5acba268260991b3b5b9cf3abbbd1729a12edb5bbddfad685b36130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a9df1666a59bf853cbd27e541116b5d2df6b41d3f275c14ae339928e288eed43272379fbaa0af8cd52e536586246707dfb5ecd852c2c069991ae5ee75723df5"} 19:26:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:26:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:26:56 INFO - Contents: 19:26:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176870f8e23f034b5b1e2da6353ffc9bdde0e743b167f1deb0a463eb91f3ad78d01ff0c4f5eacbad635b34e188f8716845630e20c8ed915fe19d054730ce6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb471e93c39d38279d7ec26eb37a84eeb7b53e1bbd687f506ba103f6d4b81160acc5593b6b5a79f28ce65d980f3525490093735c4664bca41665cc76219e2191", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22c8ccb8487c8429571fc314b285c93790370c03a10d7b00c87b52cda6ca34f92f33ff5f5acba268260991b3b5b9cf3abbbd1729a12edb5bbddfad685b36130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a9df1666a59bf853cbd27e541116b5d2df6b41d3f275c14ae339928e288eed43272379fbaa0af8cd52e536586246707dfb5ecd852c2c069991ae5ee75723df5"} 19:26:56 INFO - Running post-run listener: copy_logs_to_upload_dir 19:26:56 INFO - Copying logs to upload dir... 19:26:56 INFO - mkdir: /builds/slave/test/build/upload/logs 19:26:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.801506 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-06 19:26:55.477131) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:26:55.480820) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176870f8e23f034b5b1e2da6353ffc9bdde0e743b167f1deb0a463eb91f3ad78d01ff0c4f5eacbad635b34e188f8716845630e20c8ed915fe19d054730ce6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb471e93c39d38279d7ec26eb37a84eeb7b53e1bbd687f506ba103f6d4b81160acc5593b6b5a79f28ce65d980f3525490093735c4664bca41665cc76219e2191", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22c8ccb8487c8429571fc314b285c93790370c03a10d7b00c87b52cda6ca34f92f33ff5f5acba268260991b3b5b9cf3abbbd1729a12edb5bbddfad685b36130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a9df1666a59bf853cbd27e541116b5d2df6b41d3f275c14ae339928e288eed43272379fbaa0af8cd52e536586246707dfb5ecd852c2c069991ae5ee75723df5"} build_url:https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/RKvT63nbRo-zGQ2y8mYqJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176870f8e23f034b5b1e2da6353ffc9bdde0e743b167f1deb0a463eb91f3ad78d01ff0c4f5eacbad635b34e188f8716845630e20c8ed915fe19d054730ce6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fb471e93c39d38279d7ec26eb37a84eeb7b53e1bbd687f506ba103f6d4b81160acc5593b6b5a79f28ce65d980f3525490093735c4664bca41665cc76219e2191", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e22c8ccb8487c8429571fc314b285c93790370c03a10d7b00c87b52cda6ca34f92f33ff5f5acba268260991b3b5b9cf3abbbd1729a12edb5bbddfad685b36130", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a9df1666a59bf853cbd27e541116b5d2df6b41d3f275c14ae339928e288eed43272379fbaa0af8cd52e536586246707dfb5ecd852c2c069991ae5ee75723df5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 19:26:55.509944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:26:55.510291) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502071553.284307-1728608316 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 19:26:55.594322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:26:55.595088) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 19:26:55.595754) ========= ========= Total master_lag: 0.16 =========