builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1503010887.26 results: success (0) revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.262734) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.263159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.263469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.279372) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.279628) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 16:01:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.8M=0s 2017-08-17 16:01:27 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154288 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.448938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.449255) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017496 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:27.497850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 28 secs) (at 2017-08-17 16:01:27.498145) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 54ad22b649e547a5b20babdecc84f5563a9b7dea --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 54ad22b649e547a5b20babdecc84f5563a9b7dea --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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 16:01:27,569 truncating revision to first 12 chars 2017-08-17 16:01:27,569 Setting DEBUG logging. 2017-08-17 16:01:27,569 attempt 1/10 2017-08-17 16:01:27,569 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/54ad22b649e5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 16:01:28,045 attempt 1/10 2017-08-17 16:01:28,563 current task status: no status available at this point. state: PENDING 2017-08-17 16:01:28,564 sleeping for 11.00s (attempt 1/10) 2017-08-17 16:01:39,575 attempt 2/10 2017-08-17 16:01:40,084 current task status: no status available at this point. state: PENDING 2017-08-17 16:01:40,084 sleeping for 15.50s (attempt 2/10) 2017-08-17 16:01:55,600 attempt 3/10 2017-08-17 16:01:55,934 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-17 16:01:56,199 unpacking tar archive at: mozilla-central-54ad22b649e5/testing/mozharness/ program finished with exit code 0 elapsedTime=28.938384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 28 secs) (at 2017-08-17 16:01:56.449847) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:56.450192) ========= script_repo_revision: 54ad22b649e547a5b20babdecc84f5563a9b7dea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:56.450601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:56.450866) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 16:01:56.461523) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-17 16:01:56.461792) ========= /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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:56 INFO - MultiFileLogger online at 20170817 16:01:56 in /builds/slave/test 16:01:56 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 16:01:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:56 INFO - {'append_to_log': False, 16:01:56 INFO - 'base_work_dir': '/builds/slave/test', 16:01:56 INFO - 'blob_upload_branch': 'Firefox', 16:01:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:56 INFO - 'branch': 'Firefox', 16:01:56 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:56 INFO - 'code_coverage': False, 16:01:56 INFO - 'config_files': ('talos/linux_config.py',), 16:01:56 INFO - 'default_actions': ('clobber', 16:01:56 INFO - 'read-buildbot-config', 16:01:56 INFO - 'download-and-extract', 16:01:56 INFO - 'populate-webroot', 16:01:56 INFO - 'create-virtualenv', 16:01:56 INFO - 'install', 16:01:56 INFO - 'setup-mitmproxy', 16:01:56 INFO - 'run-tests'), 16:01:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:56 INFO - 'disable_ccov_upload': False, 16:01:56 INFO - 'download_minidump_stackwalk': True, 16:01:56 INFO - 'download_symbols': 'ondemand', 16:01:56 INFO - 'enable_stylo': False, 16:01:56 INFO - 'enable_webrender': False, 16:01:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:56 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:56 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:56 INFO - 'gecko_profile': False, 16:01:56 INFO - 'gecko_profile_interval': 0, 16:01:56 INFO - 'installer_path': 'installer.exe', 16:01:56 INFO - 'log_level': 'info', 16:01:56 INFO - 'log_name': 'talos', 16:01:56 INFO - 'log_to_console': True, 16:01:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:56 INFO - 'opt_config_files': (), 16:01:56 INFO - 'pip_index': False, 16:01:56 INFO - 'suite': 'dromaeojs-e10s', 16:01:56 INFO - 'system_bits': '32', 16:01:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:56 INFO - 'title': 'talos-linux64-ix-067', 16:01:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:56 INFO - 'use_talos_json': True, 16:01:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:56 INFO - 'work_dir': 'build'} 16:01:56 INFO - [mozharness: 2017-08-17 23:01:56.638563Z] Running clobber step. 16:01:56 INFO - Running pre-action listener: _resource_record_pre_action 16:01:56 INFO - Running main action method: clobber 16:01:56 INFO - rmtree: /builds/slave/test/build 16:01:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:57 INFO - Running post-action listener: _resource_record_post_action 16:01:57 INFO - [mozharness: 2017-08-17 23:01:57.720776Z] Finished clobber step (success) 16:01:57 INFO - [mozharness: 2017-08-17 23:01:57.720878Z] Running read-buildbot-config step. 16:01:57 INFO - Running pre-action listener: _resource_record_pre_action 16:01:57 INFO - Running main action method: read_buildbot_config 16:01:57 INFO - Using buildbot properties: 16:01:57 INFO - { 16:01:57 INFO - "project": "", 16:01:57 INFO - "product": "firefox", 16:01:57 INFO - "who": "dtownsend@mozilla.com", 16:01:57 INFO - "installer_path": "public/build/target.tar.bz2", 16:01:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:01:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:01:57 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:01:57 INFO - "stage_platform": "linux64-stylosequential", 16:01:57 INFO - "basedir": "/builds/slave/test", 16:01:57 INFO - "buildnumber": 196, 16:01:57 INFO - "platform": "ubuntu64_hw_styloseq", 16:01:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:01:57 INFO - "slavebuilddir": "test", 16:01:57 INFO - "taskId": "GkXBxfO1TiWkLknjfl-leg", 16:01:57 INFO - "branch": "mozilla-central", 16:01:57 INFO - "script_repo_revision": "production", 16:01:57 INFO - "revision": "54ad22b649e547a5b20babdecc84f5563a9b7dea", 16:01:57 INFO - "slavename": "talos-linux64-ix-067", 16:01:57 INFO - "repo_path": "mozilla-central" 16:01:57 INFO - } 16:01:57 INFO - Finding installer, test and symbols from parent task. 16:01:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkXBxfO1TiWkLknjfl-leg'}, attempt #1 16:01:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GkXBxfO1TiWkLknjfl-leg'}, attempt #1 16:01:58 INFO - Task dependencies: aWkJAhYOSgqx_drvisgeVA 16:01:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA'}, attempt #1 16:01:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:01:59 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json 16:01:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip 16:01:59 INFO - Running post-action listener: _resource_record_post_action 16:01:59 INFO - [mozharness: 2017-08-17 23:01:59.052924Z] Finished read-buildbot-config step (success) 16:01:59 INFO - [mozharness: 2017-08-17 23:01:59.053147Z] Running download-and-extract step. 16:01:59 INFO - Running pre-action listener: _resource_record_pre_action 16:01:59 INFO - Running main action method: download_and_extract 16:01:59 INFO - mkdir: /builds/slave/test/build/tests 16:01:59 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')]} 16:01:59 INFO - trying https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json 16:01:59 INFO - Downloading https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:01:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:01:59 INFO - Downloaded 989 bytes. 16:01:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:01:59 INFO - Using the following test package requirements: 16:01:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:01:59 INFO - u'common': [u'target.common.tests.zip'], 16:01:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:01:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:01:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:01:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:01:59 INFO - u'mozbase': [u'target.common.tests.zip'], 16:01:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:01:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:01:59 INFO - u'web-platform': [u'target.common.tests.zip', 16:01:59 INFO - u'target.web-platform.tests.tar.gz'], 16:01:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:01:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:01:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip 16:01:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:01:59 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip into memory 16:02:00 INFO - Content-Length response header: 53999336 16:02:00 INFO - Bytes received: 53999336 16:02:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:02:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip 16:02:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:02:11 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.common.tests.zip into memory 16:02:12 INFO - Content-Length response header: 53999336 16:02:12 INFO - Bytes received: 53999336 16:02:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip 16:02:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:02:25 INFO - Fetch https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.talos.tests.zip into memory 16:02:26 INFO - Content-Length response header: 14496161 16:02:26 INFO - Bytes received: 14496161 16:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:26 INFO - trying https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:02:26 INFO - Downloading https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:02:28 INFO - Downloaded 62367576 bytes. 16:02:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:02:28 INFO - mkdir: /builds/slave/test/properties 16:02:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:02:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:02:28 INFO - Contents: 16:02:28 INFO - build_url:https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 16:02:28 INFO - Running post-action listener: _resource_record_post_action 16:02:28 INFO - Running post-action listener: set_extra_try_arguments 16:02:28 INFO - [mozharness: 2017-08-17 23:02:28.242912Z] Finished download-and-extract step (success) 16:02:28 INFO - [mozharness: 2017-08-17 23:02:28.243010Z] Running populate-webroot step. 16:02:28 INFO - Running pre-action listener: _resource_record_pre_action 16:02:28 INFO - Running main action method: populate_webroot 16:02:28 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:02:28 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:02:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:02:28 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:02:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:28 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:02:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'tests': ['damp', 'tps']}, 16:02:28 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['damp', 'tps']}, 16:02:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:02:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:02:28 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:02:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:02:28 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:02:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:02:28 INFO - 'ts_paint', 16:02:28 INFO - 'tpaint', 16:02:28 INFO - 'sessionrestore', 16:02:28 INFO - 'sessionrestore_many_windows', 16:02:28 INFO - 'sessionrestore_no_auto_restore', 16:02:28 INFO - 'tabpaint']}, 16:02:28 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['a11yr', 16:02:28 INFO - 'ts_paint', 16:02:28 INFO - 'tpaint', 16:02:28 INFO - 'sessionrestore', 16:02:28 INFO - 'sessionrestore_many_windows', 16:02:28 INFO - 'sessionrestore_no_auto_restore', 16:02:28 INFO - 'tabpaint']}, 16:02:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:02:28 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:02:28 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['bloom_basic_singleton']}, 16:02:28 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['bloom_basic']}, 16:02:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:02:28 INFO - 'tsvgr_opacity', 16:02:28 INFO - 'tart', 16:02:28 INFO - 'tscrollx', 16:02:28 INFO - 'tsvg_static']}, 16:02:28 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['tsvgx', 16:02:28 INFO - 'tsvgr_opacity', 16:02:28 INFO - 'tart', 16:02:28 INFO - 'tscrollx', 16:02:28 INFO - 'tsvg_static']}, 16:02:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:02:28 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--stylo'], 16:02:28 INFO - 'tests': ['tp5o']}, 16:02:28 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:02:28 INFO - 'talos_options': ['--mitmproxy', 16:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:02:28 INFO - '--firstNonBlankPaint'], 16:02:28 INFO - 'tests': ['tp6_google', 16:02:28 INFO - 'tp6_youtube', 16:02:28 INFO - 'tp6_amazon', 16:02:28 INFO - 'tp6_facebook']}, 16:02:28 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:02:28 INFO - 'talos_options': ['--stylo', 16:02:28 INFO - '--mitmproxy', 16:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:02:28 INFO - '--firstNonBlankPaint'], 16:02:28 INFO - 'tests': ['tp6_google', 16:02:28 INFO - 'tp6_youtube', 16:02:28 INFO - 'tp6_amazon', 16:02:28 INFO - 'tp6_facebook']}, 16:02:28 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:02:28 INFO - 'talos_options': ['--stylo', 16:02:28 INFO - '--stylo-threads=1', 16:02:28 INFO - '--mitmproxy', 16:02:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:02:28 INFO - '--firstNonBlankPaint'], 16:02:28 INFO - 'tests': ['tp6_google', 16:02:28 INFO - 'tp6_youtube', 16:02:28 INFO - 'tp6_amazon', 16:02:28 INFO - 'tp6_facebook']}, 16:02:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--xperf_path', 16:02:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:28 INFO - 'tests': ['tp5n']}, 16:02:28 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 16:02:28 INFO - 'talos_options': ['--stylo', 16:02:28 INFO - '--xperf_path', 16:02:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:02:28 INFO - 'tests': ['tp5n']}}} 16:02:28 INFO - Running post-action listener: _resource_record_post_action 16:02:28 INFO - [mozharness: 2017-08-17 23:02:28.257422Z] Finished populate-webroot step (success) 16:02:28 INFO - [mozharness: 2017-08-17 23:02:28.257514Z] Running create-virtualenv step. 16:02:28 INFO - Running pre-action listener: _resource_record_pre_action 16:02:28 INFO - Running main action method: create_virtualenv 16:02:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:02:28 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 16:02:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:02:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:02:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:02:28 INFO - Using real prefix '/usr' 16:02:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:02:28 INFO - Installing distribute.............................................................................................................................................................................................done. 16:02:30 INFO - Installing pip.................done. 16:02:30 INFO - Return code: 0 16:02:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:02:31 INFO - Reading from file tmpfile_stdout 16:02:31 INFO - Output received: 16:02:31 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) 16:02:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:02:31 INFO - Using env: {'DISPLAY': ':0', 16:02:31 INFO - 'HOME': '/home/cltbld', 16:02:31 INFO - 'LANG': 'en_US.UTF-8', 16:02:31 INFO - 'LANGUAGE': 'en_US:en', 16:02:31 INFO - 'LOGNAME': 'cltbld', 16:02:31 INFO - 'MAIL': '/var/mail/cltbld', 16:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:31 INFO - 'MOZ_NO_REMOTE': '1', 16:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:31 INFO - 'NO_EM_RESTART': '1', 16:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:31 INFO - 'PWD': '/builds/slave/test', 16:02:31 INFO - 'SHELL': '/bin/bash', 16:02:31 INFO - 'SHLVL': '1', 16:02:31 INFO - 'TERM': 'linux', 16:02:31 INFO - 'TMOUT': '86400', 16:02:31 INFO - 'USER': 'cltbld', 16:02:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:31 INFO - '_': '/tools/buildbot/bin/python'} 16:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:31 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 16:02:31 INFO - Cleaning up... 16:02:31 INFO - Return code: 0 16:02:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:02:31 INFO - Using env: {'DISPLAY': ':0', 16:02:31 INFO - 'HOME': '/home/cltbld', 16:02:31 INFO - 'LANG': 'en_US.UTF-8', 16:02:31 INFO - 'LANGUAGE': 'en_US:en', 16:02:31 INFO - 'LOGNAME': 'cltbld', 16:02:31 INFO - 'MAIL': '/var/mail/cltbld', 16:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:31 INFO - 'MOZ_NO_REMOTE': '1', 16:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:31 INFO - 'NO_EM_RESTART': '1', 16:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:31 INFO - 'PWD': '/builds/slave/test', 16:02:31 INFO - 'SHELL': '/bin/bash', 16:02:31 INFO - 'SHLVL': '1', 16:02:31 INFO - 'TERM': 'linux', 16:02:31 INFO - 'TMOUT': '86400', 16:02:31 INFO - 'USER': 'cltbld', 16:02:31 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:31 INFO - '_': '/tools/buildbot/bin/python'} 16:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:31 INFO - Downloading/unpacking psutil>=3.1.1 16:02:31 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 16:02:31 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 16:02:31 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 16:02:31 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 16:02:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:02:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:32 INFO - Installing collected packages: psutil 16:02:32 INFO - Running setup.py install for psutil 16:02:32 INFO - building 'psutil._psutil_linux' extension 16:02:32 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 16:02:32 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 16:02:32 INFO - building 'psutil._psutil_posix' extension 16:02:32 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 16:02:33 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 16:02:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:02:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:02:33 INFO - Successfully installed psutil 16:02:33 INFO - Cleaning up... 16:02:33 INFO - Return code: 0 16:02:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:02:33 INFO - Using env: {'DISPLAY': ':0', 16:02:33 INFO - 'HOME': '/home/cltbld', 16:02:33 INFO - 'LANG': 'en_US.UTF-8', 16:02:33 INFO - 'LANGUAGE': 'en_US:en', 16:02:33 INFO - 'LOGNAME': 'cltbld', 16:02:33 INFO - 'MAIL': '/var/mail/cltbld', 16:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:33 INFO - 'MOZ_NO_REMOTE': '1', 16:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:33 INFO - 'NO_EM_RESTART': '1', 16:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:33 INFO - 'PWD': '/builds/slave/test', 16:02:33 INFO - 'SHELL': '/bin/bash', 16:02:33 INFO - 'SHLVL': '1', 16:02:33 INFO - 'TERM': 'linux', 16:02:33 INFO - 'TMOUT': '86400', 16:02:33 INFO - 'USER': 'cltbld', 16:02:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:33 INFO - '_': '/tools/buildbot/bin/python'} 16:02:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:02:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:02:34 INFO - Installing collected packages: mozsystemmonitor 16:02:34 INFO - Running setup.py install for mozsystemmonitor 16:02:34 INFO - Successfully installed mozsystemmonitor 16:02:34 INFO - Cleaning up... 16:02:34 INFO - Return code: 0 16:02:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:02:34 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')]} 16:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:34 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')]} 16:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:34 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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:34 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 16:02:34 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 16:02:34 INFO - Using env: {'DISPLAY': ':0', 16:02:34 INFO - 'HOME': '/home/cltbld', 16:02:34 INFO - 'LANG': 'en_US.UTF-8', 16:02:34 INFO - 'LANGUAGE': 'en_US:en', 16:02:34 INFO - 'LOGNAME': 'cltbld', 16:02:34 INFO - 'MAIL': '/var/mail/cltbld', 16:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:34 INFO - 'MOZ_NO_REMOTE': '1', 16:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:34 INFO - 'NO_EM_RESTART': '1', 16:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:34 INFO - 'PWD': '/builds/slave/test', 16:02:34 INFO - 'SHELL': '/bin/bash', 16:02:34 INFO - 'SHLVL': '1', 16:02:34 INFO - 'TERM': 'linux', 16:02:34 INFO - 'TMOUT': '86400', 16:02:34 INFO - 'USER': 'cltbld', 16:02:34 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:34 INFO - '_': '/tools/buildbot/bin/python'} 16:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:02:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:02:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:02: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 16:02: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 16:02: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 16:02: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 16:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:02:36 INFO - warning: no files found matching '*.txt' 16:02:36 INFO - no previously-included directories found matching 'build' 16:02:36 INFO - no previously-included directories found matching 'dist' 16:02:36 INFO - no previously-included directories found matching '.git*' 16:02:36 INFO - Installing collected packages: jsonschema, functools32 16:02:36 INFO - Running setup.py install for functools32 16:02:36 INFO - warning: no files found matching '*.txt' 16:02:36 INFO - no previously-included directories found matching 'build' 16:02:36 INFO - no previously-included directories found matching 'dist' 16:02:36 INFO - no previously-included directories found matching '.git*' 16:02:36 INFO - Successfully installed jsonschema functools32 16:02:36 INFO - Cleaning up... 16:02:36 INFO - Return code: 0 16:02:36 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02: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')]} 16:02:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:02:37 INFO - Using env: {'DISPLAY': ':0', 16:02:37 INFO - 'HOME': '/home/cltbld', 16:02:37 INFO - 'LANG': 'en_US.UTF-8', 16:02:37 INFO - 'LANGUAGE': 'en_US:en', 16:02:37 INFO - 'LOGNAME': 'cltbld', 16:02:37 INFO - 'MAIL': '/var/mail/cltbld', 16:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:37 INFO - 'MOZ_NO_REMOTE': '1', 16:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:37 INFO - 'NO_EM_RESTART': '1', 16:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:37 INFO - 'PWD': '/builds/slave/test', 16:02:37 INFO - 'SHELL': '/bin/bash', 16:02:37 INFO - 'SHLVL': '1', 16:02:37 INFO - 'TERM': 'linux', 16:02:37 INFO - 'TMOUT': '86400', 16:02:37 INFO - 'USER': 'cltbld', 16:02:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:37 INFO - '_': '/tools/buildbot/bin/python'} 16:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:02:37 INFO - Cleaning up... 16:02:37 INFO - Return code: 0 16:02:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:02:37 INFO - Using env: {'DISPLAY': ':0', 16:02:37 INFO - 'HOME': '/home/cltbld', 16:02:37 INFO - 'LANG': 'en_US.UTF-8', 16:02:37 INFO - 'LANGUAGE': 'en_US:en', 16:02:37 INFO - 'LOGNAME': 'cltbld', 16:02:37 INFO - 'MAIL': '/var/mail/cltbld', 16:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:37 INFO - 'MOZ_NO_REMOTE': '1', 16:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:37 INFO - 'NO_EM_RESTART': '1', 16:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:37 INFO - 'PWD': '/builds/slave/test', 16:02:37 INFO - 'SHELL': '/bin/bash', 16:02:37 INFO - 'SHLVL': '1', 16:02:37 INFO - 'TERM': 'linux', 16:02:37 INFO - 'TMOUT': '86400', 16:02:37 INFO - 'USER': 'cltbld', 16:02:37 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:37 INFO - '_': '/tools/buildbot/bin/python'} 16:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:02:37 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 16:02:37 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 16:02:37 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 16:02:37 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 16:02:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:02:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:02:39 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 16:02:39 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 16:02:39 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 16:02:39 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 16:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:02:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:02: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 16:02: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 16:02: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 16:02: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 16:02:40 INFO - Downloading docopt-0.6.1.tar.gz 16:02:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:02:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:02:40 INFO - Running setup.py install for blobuploader 16:02:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:02:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:02:40 INFO - Running setup.py install for requests 16:02:40 INFO - Running setup.py install for docopt 16:02:40 INFO - Successfully installed blobuploader requests docopt 16:02:40 INFO - Cleaning up... 16:02:40 INFO - Return code: 0 16:02:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02: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')]} 16:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:40 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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:40 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 16:02:40 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 16:02:40 INFO - Using env: {'DISPLAY': ':0', 16:02:40 INFO - 'HOME': '/home/cltbld', 16:02:40 INFO - 'LANG': 'en_US.UTF-8', 16:02:40 INFO - 'LANGUAGE': 'en_US:en', 16:02:40 INFO - 'LOGNAME': 'cltbld', 16:02:40 INFO - 'MAIL': '/var/mail/cltbld', 16:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:40 INFO - 'MOZ_NO_REMOTE': '1', 16:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:40 INFO - 'NO_EM_RESTART': '1', 16:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:40 INFO - 'PWD': '/builds/slave/test', 16:02:40 INFO - 'SHELL': '/bin/bash', 16:02:40 INFO - 'SHLVL': '1', 16:02:40 INFO - 'TERM': 'linux', 16:02:40 INFO - 'TMOUT': '86400', 16:02:40 INFO - 'USER': 'cltbld', 16:02:40 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:40 INFO - '_': '/tools/buildbot/bin/python'} 16:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:41 INFO - Running setup.py (path:/tmp/pip-glULAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:41 INFO - Running setup.py (path:/tmp/pip-ehbbko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:41 INFO - Running setup.py (path:/tmp/pip-415F91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:41 INFO - Running setup.py (path:/tmp/pip-EENqdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:41 INFO - Running setup.py (path:/tmp/pip-MnH0gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:41 INFO - Running setup.py (path:/tmp/pip-L5W7T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:41 INFO - Running setup.py (path:/tmp/pip-1KC5_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:41 INFO - Running setup.py (path:/tmp/pip-AHfBNE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:41 INFO - Running setup.py (path:/tmp/pip-knJ8U4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:41 INFO - Running setup.py (path:/tmp/pip-l3Dsl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:41 INFO - Running setup.py (path:/tmp/pip-QxvRaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:41 INFO - Running setup.py (path:/tmp/pip-UXME4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:41 INFO - Running setup.py (path:/tmp/pip-Iy_na2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:42 INFO - Running setup.py (path:/tmp/pip-ewG2F8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:42 INFO - Running setup.py (path:/tmp/pip-nIW7cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:42 INFO - Running setup.py (path:/tmp/pip-A3zD5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:42 INFO - Running setup.py (path:/tmp/pip-xyDnD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:02:42 INFO - Running setup.py install for manifestparser 16:02:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:02:42 INFO - Running setup.py install for mozcrash 16:02:42 INFO - Running setup.py install for mozdebug 16:02:42 INFO - Running setup.py install for mozdevice 16:02:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:02:42 INFO - Running setup.py install for mozfile 16:02:42 INFO - Running setup.py install for mozhttpd 16:02:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:02:42 INFO - Running setup.py install for mozinfo 16:02:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for mozInstall 16:02:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for mozleak 16:02:43 INFO - Running setup.py install for mozlog 16:02:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for moznetwork 16:02:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for mozprocess 16:02:43 INFO - Running setup.py install for mozprofile 16:02:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for mozrunner 16:02:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:02:43 INFO - Running setup.py install for mozscreenshot 16:02:43 INFO - Running setup.py install for moztest 16:02:43 INFO - Running setup.py install for mozversion 16:02:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:02:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:02:44 INFO - Cleaning up... 16:02:44 INFO - Return code: 0 16:02:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02: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')]} 16:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:44 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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:44 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 16:02:44 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 16:02:44 INFO - Using env: {'DISPLAY': ':0', 16:02:44 INFO - 'HOME': '/home/cltbld', 16:02:44 INFO - 'LANG': 'en_US.UTF-8', 16:02:44 INFO - 'LANGUAGE': 'en_US:en', 16:02:44 INFO - 'LOGNAME': 'cltbld', 16:02:44 INFO - 'MAIL': '/var/mail/cltbld', 16:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:44 INFO - 'MOZ_NO_REMOTE': '1', 16:02:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:44 INFO - 'NO_EM_RESTART': '1', 16:02:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:44 INFO - 'PWD': '/builds/slave/test', 16:02:44 INFO - 'SHELL': '/bin/bash', 16:02:44 INFO - 'SHLVL': '1', 16:02:44 INFO - 'TERM': 'linux', 16:02:44 INFO - 'TMOUT': '86400', 16:02:44 INFO - 'USER': 'cltbld', 16:02:44 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:44 INFO - '_': '/tools/buildbot/bin/python'} 16:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:02:44 INFO - Running setup.py (path:/tmp/pip-qYSmlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:02:44 INFO - Running setup.py (path:/tmp/pip-nxxjrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:02:44 INFO - Running setup.py (path:/tmp/pip-DxtsCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:02:44 INFO - Running setup.py (path:/tmp/pip-FRF2qD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:02:44 INFO - Running setup.py (path:/tmp/pip-cG8UGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:02:44 INFO - Running setup.py (path:/tmp/pip-Lbswht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:02:44 INFO - Running setup.py (path:/tmp/pip-l37waI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:02:44 INFO - Running setup.py (path:/tmp/pip-eKUOKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:02:44 INFO - Running setup.py (path:/tmp/pip-N7AP6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:02:44 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)) 16:02:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:02:44 INFO - Running setup.py (path:/tmp/pip-BSPqUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:02:45 INFO - Running setup.py (path:/tmp/pip-JvYLDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:02:45 INFO - Running setup.py (path:/tmp/pip-kWAR8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:02:45 INFO - Running setup.py (path:/tmp/pip-BGI4nU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:02:45 INFO - Running setup.py (path:/tmp/pip-gKaXnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:45 INFO - Running setup.py (path:/tmp/pip-EaoGxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:02:45 INFO - Running setup.py (path:/tmp/pip-WnYV4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:02:45 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)) 16:02:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:02:45 INFO - Running setup.py (path:/tmp/pip-BBsSkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 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)) 16:02:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:02:45 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 16:02:45 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 16:02:45 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 16:02:45 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 16:02:46 INFO - Downloading blessings-1.6.tar.gz 16:02:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:02:46 INFO - Installing collected packages: blessings 16:02:46 INFO - Running setup.py install for blessings 16:02:46 INFO - Successfully installed blessings 16:02:46 INFO - Cleaning up... 16:02:47 INFO - Return code: 0 16:02:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:02:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:47 INFO - Reading from file tmpfile_stdout 16:02:47 INFO - Current package versions: 16:02:47 INFO - argparse == 1.2.1 16:02:47 INFO - blessings == 1.6 16:02:47 INFO - blobuploader == 1.2.4 16:02:47 INFO - docopt == 0.6.1 16:02:47 INFO - functools32 == 3.2.3-2 16:02:47 INFO - jsonschema == 2.5.1 16:02:47 INFO - manifestparser == 1.1 16:02:47 INFO - mozInstall == 1.13 16:02:47 INFO - mozcrash == 1.0 16:02:47 INFO - mozdebug == 0.1 16:02:47 INFO - mozdevice == 0.51 16:02:47 INFO - mozfile == 1.2 16:02:47 INFO - mozhttpd == 0.7 16:02:47 INFO - mozinfo == 0.10 16:02:47 INFO - mozleak == 0.1 16:02:47 INFO - mozlog == 3.5 16:02:47 INFO - moznetwork == 0.27 16:02:47 INFO - mozprocess == 0.25 16:02:47 INFO - mozprofile == 0.28 16:02:47 INFO - mozrunner == 6.13 16:02:47 INFO - mozscreenshot == 0.1 16:02:47 INFO - mozsystemmonitor == 0.3 16:02:47 INFO - moztest == 0.8 16:02:47 INFO - mozversion == 1.4 16:02:47 INFO - psutil == 3.1.1 16:02:47 INFO - requests == 1.2.3 16:02:47 INFO - wsgiref == 0.1.2 16:02:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:02: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')]} 16:02:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02: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')]} 16:02:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:47 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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:47 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 16:02:47 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 16:02:47 INFO - Using env: {'DISPLAY': ':0', 16:02:47 INFO - 'HOME': '/home/cltbld', 16:02:47 INFO - 'LANG': 'en_US.UTF-8', 16:02:47 INFO - 'LANGUAGE': 'en_US:en', 16:02:47 INFO - 'LOGNAME': 'cltbld', 16:02:47 INFO - 'MAIL': '/var/mail/cltbld', 16:02:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:47 INFO - 'MOZ_NO_REMOTE': '1', 16:02:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:47 INFO - 'NO_EM_RESTART': '1', 16:02:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:47 INFO - 'PWD': '/builds/slave/test', 16:02:47 INFO - 'SHELL': '/bin/bash', 16:02:47 INFO - 'SHLVL': '1', 16:02:47 INFO - 'TERM': 'linux', 16:02:47 INFO - 'TMOUT': '86400', 16:02:47 INFO - 'USER': 'cltbld', 16:02:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:47 INFO - '_': '/tools/buildbot/bin/python'} 16:02:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 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)) 16:02:47 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:02:47 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 16:02:47 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 16:02:47 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 16:02:47 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 16:02:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:02:48 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)) 16:02:48 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)) 16:02:48 INFO - Installing collected packages: simplejson 16:02:48 INFO - Running setup.py install for simplejson 16:02:48 INFO - building 'simplejson._speedups' extension 16:02:48 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 16:02:49 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 16:02:49 INFO - Successfully installed simplejson 16:02:49 INFO - Cleaning up... 16:02:49 INFO - Return code: 0 16:02:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:02:49 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 0x23dd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2684ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', '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 16:02:49 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 16:02:49 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 16:02:49 INFO - Using env: {'DISPLAY': ':0', 16:02:49 INFO - 'HOME': '/home/cltbld', 16:02:49 INFO - 'LANG': 'en_US.UTF-8', 16:02:49 INFO - 'LANGUAGE': 'en_US:en', 16:02:49 INFO - 'LOGNAME': 'cltbld', 16:02:49 INFO - 'MAIL': '/var/mail/cltbld', 16:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:49 INFO - 'MOZ_NO_REMOTE': '1', 16:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:49 INFO - 'NO_EM_RESTART': '1', 16:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:49 INFO - 'PWD': '/builds/slave/test', 16:02:49 INFO - 'SHELL': '/bin/bash', 16:02:49 INFO - 'SHLVL': '1', 16:02:49 INFO - 'TERM': 'linux', 16:02:49 INFO - 'TMOUT': '86400', 16:02:49 INFO - 'USER': 'cltbld', 16:02:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:49 INFO - '_': '/tools/buildbot/bin/python'} 16:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:02:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:02:50 INFO - Cleaning up... 16:02:50 INFO - Return code: 0 16:02:50 INFO - Running post-action listener: _resource_record_post_action 16:02:50 INFO - Running post-action listener: _start_resource_monitoring 16:02:50 INFO - Starting resource monitoring. 16:02:50 INFO - [mozharness: 2017-08-17 23:02:50.179209Z] Finished create-virtualenv step (success) 16:02:50 INFO - [mozharness: 2017-08-17 23:02:50.179720Z] Running install step. 16:02:50 INFO - Running pre-action listener: _resource_record_pre_action 16:02:50 INFO - Running main action method: install 16:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:02:50 INFO - Reading from file tmpfile_stdout 16:02:50 INFO - Detecting whether we're running mozinstall >=1.0... 16:02:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:02:50 INFO - Reading from file tmpfile_stdout 16:02:50 INFO - Output received: 16:02:50 INFO - Usage: mozinstall [options] installer 16:02:50 INFO - Options: 16:02:50 INFO - -h, --help show this help message and exit 16:02:50 INFO - -d DEST, --destination=DEST 16:02:50 INFO - Directory to install application into. [default: 16:02:50 INFO - "/builds/slave/test"] 16:02:50 INFO - --app=APP Application being installed. [default: firefox] 16:02:50 INFO - mkdir: /builds/slave/test/build/application 16:02:50 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'] 16:02:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:03:08 INFO - Reading from file tmpfile_stdout 16:03:08 INFO - Output received: 16:03:08 INFO - /builds/slave/test/build/application/firefox/firefox 16:03:08 INFO - Running post-action listener: _resource_record_post_action 16:03:08 INFO - [mozharness: 2017-08-17 23:03:08.570747Z] Finished install step (success) 16:03:08 INFO - [mozharness: 2017-08-17 23:03:08.570998Z] Running setup-mitmproxy step. 16:03:08 INFO - Running pre-action listener: _resource_record_pre_action 16:03:08 INFO - Running main action method: setup_mitmproxy 16:03:08 INFO - Skipping: mitmproxy is not required 16:03:08 INFO - Running post-action listener: _resource_record_post_action 16:03:08 INFO - [mozharness: 2017-08-17 23:03:08.572135Z] Finished setup-mitmproxy step (success) 16:03:08 INFO - [mozharness: 2017-08-17 23:03:08.572356Z] Running run-tests step. 16:03:08 INFO - Running pre-action listener: _resource_record_pre_action 16:03:08 INFO - Running pre-action listener: _set_gcov_prefix 16:03:08 INFO - Running main action method: run_tests 16:03:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:03:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:03:08 INFO - Python 2.7.3 16:03:08 INFO - Return code: 0 16:03:08 INFO - grabbing minidump binary from tooltool 16:03:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:03:08 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 0x26820b0>, '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 0x2682fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2683440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:03:08 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 16:03:08 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 16:03:08 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 16:03:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:03:08 INFO - Return code: 0 16:03:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:03:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:03:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:03:08 INFO - ENV: RUST_BACKTRACE is now full 16:03:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:03:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:03:08 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/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:03:08 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/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:03:08 INFO - Using env: {'DISPLAY': ':0', 16:03:08 INFO - 'HOME': '/home/cltbld', 16:03:08 INFO - 'LANG': 'en_US.UTF-8', 16:03:08 INFO - 'LANGUAGE': 'en_US:en', 16:03:08 INFO - 'LOGNAME': 'cltbld', 16:03:08 INFO - 'MAIL': '/var/mail/cltbld', 16:03:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:03:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:03:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:03:08 INFO - 'MOZ_NO_REMOTE': '1', 16:03:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:03:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:03:08 INFO - 'NO_EM_RESTART': '1', 16:03:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:03:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:03:08 INFO - 'PWD': '/builds/slave/test', 16:03:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:03:08 INFO - 'RUST_BACKTRACE': 'full', 16:03:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:03:08 INFO - 'SHELL': '/bin/bash', 16:03:08 INFO - 'SHLVL': '1', 16:03:08 INFO - 'STYLO_FORCE_ENABLED': '1', 16:03:08 INFO - 'TERM': 'linux', 16:03:08 INFO - 'TMOUT': '86400', 16:03:08 INFO - 'USER': 'cltbld', 16:03:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407', 16:03:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:03:08 INFO - '_': '/tools/buildbot/bin/python'} 16:03:08 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/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:03:08 INFO - mozversion application_buildid: 20170817221603 16:03:08 INFO - mozversion application_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:03:08 INFO - mozversion application_display_name: Nightly 16:03:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:03:08 INFO - mozversion application_name: Firefox 16:03:08 INFO - mozversion application_remotingname: firefox 16:03:08 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:03:08 INFO - mozversion application_vendor: Mozilla 16:03:08 INFO - mozversion application_version: 57.0a1 16:03:08 INFO - mozversion platform_buildid: 20170817221603 16:03:08 INFO - mozversion platform_changeset: 54ad22b649e547a5b20babdecc84f5563a9b7dea 16:03:08 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:03:08 INFO - mozversion platform_version: 57.0a1 16:03:08 INFO - using testdate: 1503010988 16:03:08 INFO - actual date: 1503010988 16:03:08 INFO - starting webserver on 'localhost:42594' 16:03:08 INFO - SUITE-START | Running 2 tests 16:03:08 INFO - TEST-START | dromaeo_css 16:03:08 INFO - Initialising browser for dromaeo_css test... 16:03:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42594/getInfo.html -profile /tmp/tmpXVYLhb/profile 16:03:08 INFO - TEST-INFO | started process 4177 (/builds/slave/test/build/application/firefox/firefox http://localhost:42594/getInfo.html) 16:03:14 INFO - TEST-INFO | 4177: exit 0 16:03:14 INFO - Browser initialized. 16:03:14 INFO - Running cycle 1/1 for dromaeo_css test... 16:03:14 INFO - TEST-INFO | started process 4372 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXVYLhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:03:15 INFO - PID 4372 | 16:03:15 INFO - PID 4372 | (/builds/slave/test/build/application/firefox/firefox:4426): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:03:15 INFO - PID 4372 | 16:03:26 INFO - PID 4372 | RSS: Main: 166641664 16:03:26 INFO - PID 4372 | 16:06:24 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42594/tests/dromaeo/cssquery-ext.html) 16:06:26 INFO - PID 4372 | RSS: Main: 173854720 16:06:26 INFO - PID 4372 | 16:09:28 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-ext.html (next: http://localhost:42594/tests/dromaeo/cssquery-jquery.html) 16:09:28 INFO - PID 4372 | RSS: Main: 171757568 16:09:28 INFO - PID 4372 | 16:12:30 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42594/tests/dromaeo/cssquery-mootools.html) 16:12:31 INFO - PID 4372 | RSS: Main: 173391872 16:12:31 INFO - PID 4372 | 16:15:33 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42594/tests/dromaeo/cssquery-prototype.html) 16:15:33 INFO - PID 4372 | RSS: Main: 173297664 16:15:33 INFO - PID 4372 | 16:18:37 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42594/tests/dromaeo/cssquery-yui.html) 16:18:38 INFO - PID 4372 | RSS: Main: 174829568 16:18:38 INFO - PID 4372 | 16:21:39 INFO - PID 4372 | Cycle 1(1): loaded http://localhost:42594/tests/dromaeo/cssquery-yui.html (next: http://localhost:42594/tests/dromaeo/cssquery-dojo.html) 16:21:40 INFO - PID 4372 | RSS: Main: 176934912 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | __start_tp_report 16:21:40 INFO - PID 4372 | _x_x_mozilla_page_load 16:21:40 INFO - PID 4372 | _x_x_mozilla_page_load_details 16:21:40 INFO - PID 4372 | |i|pagename|runs| 16:21:40 INFO - PID 4372 | |0;dojo.html;3173.6984986426282;3183.4906414973607;3195.8242296673684;3219.1308346746364;3227.9515807262896;6086.117512960618;6158.107074474198;6172.753089876405;6230.376962303767;6238.812835614927;6026.156338112668;6129.908051379221;6152.230971128609;6156.353582873801;6172.259328880541;5603.915941260864;5611.410801865796;5630.831075067734;5656.575756818234;5729.570282228829;5694.174344720013;5701.885962280752;5710.5717071219615;5715.5427565794635;5740.397258287882;5394.703291318976;5572.7770889164385;5589.133684278943;5606.383297837235;5615.438456154393;5513.61404701671;5596.748146333425;5610.270664813589;5661.009323368436;5680;5500.917486237709;5520.641158324696;5559.63862348946;5594.384617692051;5627.831165065055;5957.314908785502;5996.760129594811;6022.337542870281;6035.849103772397;6053.152558641794;6415.294317625057;6428.292887782341;6459.160309159826;6459.967700161516;6468.611883287018;6479.676016199218;6480.57876238043;6489.221293444817;6502.154719886432;6514.5114116441455;5997.370276120988;6011.338752737195;6036.366181550918;6069.939300607026;6154.323024467305;6718.126643536407;6854.971754236804;6879.140107486564;6897.55165914214;6902.102726645604;6470.9029364559565;6480.157579514633;6484.448821850101;6576.868462630816;6579.144711187515;6449.774257900951;6598.670066496752;6644.96677516619;6690.632015239111;6710.16122984627;6501.707423165969;6530.542861999709;6585.86828263432;6589.110470086573;6593.6703164841565;6590.604563726191;6637.900431493532;6642.701078451481;6650.767223147167;6651.068850360954;5317.069512835238;5374.435684253175;5442.374126975448;5446.428125046813;5468.890622187534;4571.725696458223;4590.655700822452;4601.079784043205;4607.539246075366;4623.653226008063;5770.19217309577;5771.8557036074435;5785.016547186989;5789.739461724233;5789.9710501447225;6574.309697481695;6583.440407565315;6597.30728273534;6661.633610151488;6662.766803161963;5733.3406658234;5767.596268261265;5776.220210271559;5789.015867302569;5792.82621521355;5803.941960580424;5835.737391817378;5839.795607153814;5849.093390524476;5853.209816674779;6026.337102918676;6378.330275321117;6425.710843012076;6475.676216189266;6488.513361497907;6379.138816259931;6417.422431981144;6448.580842245239;6514.902276465762;6556.082148499309;6258.311585725658;6295.464885484785;6381.1704478417505;6386.90419643715;6393.6483493408305;6364.299927008118;6372.776952806629;6383.776567820104;6390.169277993831;6418.133551970611;6558.540902136805;6596.934030659632;6608.041833934149;6628.734850605922;6638.269790322964;6330.638912633806;6336.20797400325;6336.461400780985;6356.269029061532;6389.840253993501;6353.650549219652;6363.840903977438;6424;6442.774502892376;6443;6359.841003974938;6364.840878978062;6366.427021567896;6379.202599675041;6383.553151279366;6383.96808015957;6385.648789316632;6398.744050237939;6438.806835794933;6484.1894763154605;6188.350223226496;6231.9688401557705;6247.219097612799;6266.122742816101;6326.272478664829 16:21:40 INFO - PID 4372 | |1;ext.html;834.6577903059747;834.8872902158207;850.9446885952412;887.7736177274794;890.8530092534733;40976.38535421971;41543.169136617325;41661;41846.7907660462;41859.58140418603;39219.41170882439;39452.21095578094;39491.60508394915;39540;39591.80204098976;6837.931620683792;6947.201071876749;6960.825979350531;6961.234264230956;6970;6863.313668633146;6939.5836249824915;6942.097527321441;6944.201416837052;6949.861002779941;6931.584104953719;6946.826329341781;6963.05998690178;6964.059851920002;6964.547304425221;6838.418734407582;6896.517243792937;6929.029935808991;6935.3411425914455;6940.375366217039;6210.5963112398;6318.652474113922;6333.240011198685;6335.5565110442285;6342.016987366966;34987.30025399503;35169.12077198065;35203.295934081434;35283.4707479388;35328;3386.0519054664733;3439;3439.638837922007;3439.8280085995852;3439.9656003439895;28256;28286.434271314458;28289.858550707115;28310;28333.291667708265;4453.398791163184;4485.932711009337;4498.730076195438;4560.5895469407915;4567.566081222279;228693;230061.9999999983;231571.9999999983;231809;232720;50087.24869126966;50366.748166258934;50429.74785126124;50462.74768626133;50550;54077.45922540803;54165.729171353894;54266.728666356415;54299.18551221735;54336.913261734546;16721.498355049367;16825.242864071148;16836.6632667346;16841.326346945985;16851.494455166365;13675.794863077062;13698.589042328746;13700.520481783089;13734.519291824938;13751.862481375058;14812.481563145238;14852.92573537147;14868.405263789544;14952.177630230442;14975.251237438084;5856.648601083949;5908.202392676933;5952.494038006731;5969.134475501115;5971.253593300838;980.3186785184229;1010.782681723433;1012.0436187802457;1017.0338178730088;1021.341234903483;22712.886435568045;23039.42401439944;23178.3046508605;23189.884050579978;23319.650205246933;1115.4311301236428;1121.4168632311316;1123.095907794217;1127.3574062784135;1132.5526417065378;12395;12403.193792403465;12448.502059917502;12452.252864828139;12573.811392829115;255731;255766;255960;256762;256968;40382.39426408606;41581.79209103935;41680.374794378105;53630.73184634052;54011.729941350044;1464.5752731707898;1473.9115653060637;1481.1927499512792;1490.2548725637182;1500.0849481816083;28026.579601306403;28049.439011219252;28281;28412.147635570967;28960.275993100342;37509.62490375061;37557.81221093877;37577;37591.24817503689;37734.62265377311;185547;185547;185548;185667;185946.07026964778;35428.64571354254;35567.28865422729;35612.465813012306;35642.821785890905;37852.62147378491;47670.523294768;47770;47969.5203047979;48148.27777583269;48289;34504.30991380108;34928.47607285842;35247.471287931214;35792.64207357997;35876.64123358837;35003;35076.473852891715;35077.298454030264;35271.470927936614;35486.645133548336;37715.43426848654;37971.62028379681;38129.42805857859;38237.23525529418;38258.0435489115;33815.32369352649;33872.830635846665;33891.830540847135;34303.14242143966;34400.31199375948;23953.880230598734;24367.26898193057;24536.509269814145;24806.37984050413;25054 16:21:40 INFO - PID 4372 | |2;jquery.html;556.8858384031274;568.7374029654169;580.5558747558116;581.9243498345215;600.8828278485696;22404.88797556014;22673.433164170885;23540.646890296637;23572.882135589298;23707.881460592715;26176.86911565444;26592;26718.19845404636;26762.5985610216;26785.464290714175;6562.934370656304;6722.966385168067;6726.159230096238;6730.158730158731;6730.831729206784;6012.458878700916;6496.220453545581;6559.868802623969;6570.211574611053;6577.605343679371;6528.31452697467;6540.901886471706;6541.476681865463;6549.443297319734;6557.639329836857;6447.387498187712;6511.9348806512035;6520.347965203489;6524.608523488606;6529.934700652981;6055.697215139269;6061.333253342129;6061.575689701723;6073.787417440369;6077.878442431127;28884.133475995543;30250.09249722512;30255.697443025507;30640.08079757611;30973.84513077443;1948.5518330783857;1982.0486166639948;1982.6133903888604;1982.7620685517686;1992.1135094882784;19497;19901.9004904976;19974.400767976986;20068.899655501627;20099.296524621568;2328.592496313155;2337.7311609164994;2378.5005148918576;2385.642153676945;2443.926682199537;138598;141800.2909985454;142050.28974855162;145956.27021864822;146010;14583.416663333348;14789.482368117064;14935.775963360558;14993.875459340376;15137.924310378377;23064.4233894154;23743.40641483942;23888.880555597112;23947.203959703093;24015.759842401352;10139.138173255209;10148.898511014795;10189.23580731448;10317.690469285933;10431.217658675478;9511.476868772284;9519.857202141973;9580.233581313478;9594.904050959402;9650.517474126265;9188.356815023018;9263.861042084374;9315.34792564514;9637.084476974676;9737.951310243403;2607.2569317744733;2628.290361602395;2686.5835795451735;2709.403931135147;2753.9654406294876;963.6964356227905;981.9018098190267;1000.9449480278655;1012.2863381316155;1016.2632091733434;20077.196912123643;20136.597268054556;20341.389758307276;20345.389638310873;20562;1038.159091136182;1038.6520515627199;1043.5877828257796;1048.7797562511805;1049.6536143072767;11229.66311010671;11457.14071444645;11469.54121835134;11506.252093613888;11613.245139065933;514540;517592;524255;530194;540763;114777;128335;129445;131890;132896;1230.1266101068163;1271.5994461744706;1298.487097596463;1306.294600915495;1308.0908768406057;21544.784552154277;21549.24577639775;21561.568768624227;21931;22252.666210007188;54401.18398224109;57455.99999999833;57754;58603;60121.69939150451;81745.59127204325;82446.58776706317;83303.16696832955;86051.5697421509;86916;21722.89138554297;21815.345539633836;22335.77664223337;22851.20020799264;22863.19978800734;24133.637995430432;24353.756462435147;24409.743910056215;24769;24974.250772476855;18430.447086587425;19054.14256358495;19066.713999289743;19134.61730765349;19371.225150993803;16901.91549042296;16909.577260568585;16998;17259;17619.55951101233;17620.38328658542;17863.374781882572;17878.821211787716;18666.906665466584;19780.604387911873;21493.570128597654;21727.565448691254;21774.891125544273;21982.670259946433;22023.33929982039;17321.653566928842;17698.823011769717;17871.374501892373;18251.269949201884;18470.076496175407 16:21:40 INFO - PID 4372 | |3;mootools.html;1373.732122236164;1439.1365180891466;1439.8128243328372;1445.2845841308554;1445.3568162167837;12105;13657.65855853604;14233.217173055491;14242.145471271731;14287.71424571508;12199.939000305008;13301.334933253347;14253.857461425408;14407;14419.134851908893;2528.6839145106906;2603.4662894106664;2609.112901613451;2610.151700697281;2612.1510509084624;2534.3284029732135;2603.7526434988645;2623.4097328101216;2714.050082471139;2715.8642067896626;2641.7886569074426;2671.8129730918845;2671.8530480823547;2673.879675414611;2674.3447855275485;2590.352411897026;2613.451175253199;2633.262686447788;2634.038575919785;2653.787696984237;2556.782673472757;2561.398071453207;2593.844369337846;2619.0571394298036;2632.1840229528907;14196.432142714279;14286.571402857828;14287.428502859873;14287.499937502138;14302.928485357506;7564.773056808304;7807.726729564438;7840;7840.13758486566;7847.155918359181;4808.543188397097;4885.926711099336;5073.036123136592;5079;5137.897242055175;1784.616307493895;1813.7551430556837;1840.7330937014058;1848.8705790594663;1855.2578968412743;23527.17654882088;23724.7627523726;23922.64116038261;23979.640305395435;24061;6518.445932095825;6557.770478033246;6715.7985260442265;6733.764318248838;6737.29258427858;15222.771658425132;15244.695106097815;15264.694706106038;15272;15640.905136640553;7413.1104267488245;7578.772636820904;7619.580923049175;7624.733134340382;7633.69465221385;6913.1358580177475;6965.059716938148;6984.755533556301;7124.358807707331;7151.964240178766;5021.548060674484;5212;5374.48942350476;5409.83770486886;5422.674639521641;1396.6648004479055;1457.890658200639;1503.6541595433112;1539.7921280627197;1549.3570168380222;900.6307413960245;919.0441940381928;920.2270093121809;923.630547780893;936.2042264075482;7980.760577182694;8071.192880711999;8171.95914020438;8211.917880821115;8234.917650823416;974.9951250243845;986.7566865749064;997.115451796106;997.5411310796969;1002.2032484175098;4404.713693609905;4626.467956185014;5106.874754046121;5232.162853943427;5294.338207724035;19147.425577232705;19950.30173943905;19975.300864469675;20011.199552017755;20030.39908802738;18865.339713109974;19457.90271048664;19466.90266548658;19564.90217548903;19747.111379987935;10953.83569246462;11118.166137539716;11128.777424451466;11137.164712646583;11212.439378031066;7802.609869506388;8152.510849349058;8244.051934027424;8394;8674.869876951725;16979.490615281065;16994;17465.476035718948;17626.383076592258;17715.468535943943;17629.559261018065;17836.91081544584;17840.55398615045;17849.196786144395;17965.191566379282;11484.88515114838;11693.356865372487;11707.239029463057;11721.882781172078;11754.177207595387;12703.93648031754;12754.872451275369;12959.740805183656;12992.415341309475;13017.934910325766;10488.790224195322;10721.571137154426;10940.39827809478;11115.44422778874;11335.773284534098;10155.289129760846;10292.330998485373;10389;10394.16846652251;10499.79000419972;9284.767880802763;9332.766680833034;9337.253019758538;9341.673041443517;9343;7116.323949224816;7180.066591343092;7188.856222875409;7201;7268.636568171676;7032.718691252293;7137.607431591312;7147.142342918883;7173.605451700207;7212.711491540489 16:21:40 INFO - PID 4372 | |4;prototype.html;496.5679858523084;506.49097656854855;521.1323146960311;526.3920172201109;530.5463828426695;6207.596506227098;6216.191895053642;6229.688515574215;6232.875342493147;6248.750049998001;6127.264728232618;6141.477974372184;6143.631382117076;6149.938500614992;6209.982719526928;4815.446223684268;4900.926486102711;4941.67879087859;4964.975175124119;5101.362329708786;4887.364642596457;4937.851864444055;4957.702537847741;4981.9750901245625;5003.274525193845;4884.291777692232;4901.509849015088;4905.03798480607;4938.530839570235;4982.352294201749;4893.070316639827;4916;4919.950800491985;4924.679895806797;4993.6005119590345;4483.282674772021;4488.820447182142;4495.820167193341;4504.549545045502;4542.682012259143;5985.34161242263;6019.247594050744;6031.819045428644;6080.2877769728375;6148.262208534959;5640.858978525529;5660.915086273709;5704;5736.311642602873;5744.368119506851;6493.837654058639;6537.64042977636;6575.572587781827;6583.637899915503;6599.604023758542;4842.782074806642;4851.490593487668;4863.465018847924;4888.853334399973;4900.901981960376;6601.7359305627715;6616.933830661632;6675.732970681167;6731.798046058626;6919.965400173017;4959.851204463872;4970.652054356233;4998;5023.874403139951;5046.924296135561;5031.7987280509105;5046.495350464924;5086.72023038729;5091.87270318245;5110.233464980209;5674.233978412862;5694.9430505695245;5701.458361455655;5707.543396528268;5747.827565173052;6572.868542629216;6615.768448104293;6618.617297772798;6619.139511863427;6687.598744075371;1764.6823571757207;1768.2308195934809;1779.590694140329;1787.4905651889148;1787.8748487605742;1173.4543437301695;1222.7554489102215;1231.1689609513721;1246.2148846227;1247.2828123828835;5660.5471562274915;5690.516306113944;5757.165211044459;5781.034448287603;5831.358550559435;6671.933280667228;6674;6773.93226067733;6802.795916122524;6819.965900170468;5715.5427565794635;5717.914231286534;5734.856628584319;5787.2476578045425;5809.854753631109;3571.7320351275443;3583.4624806279267;3597.712183025352;3603.3153700796765;3606.00834770435;6521.934780652227;6575.408213260734;6575.4410875076155;6593.6703164841565;6601.471882249409;6799.864002720017;6898.860349039997;6938.722451101899;6945.756898508528;6947.201071876698;6559.868802623921;6569;6593.901091483632;6609.768658096944;6637.966810165918;6191.907121393093;6549.279579246184;6619.635920024445;6651.301613330531;6713.295104014008;6630.867382652416;6648;6674.8998765017595;6693.564918280296;6719.26088130315;6350.983842585349;6489.8702025960165;6540.574862633914;6543.70553325092;6604.306547812411;4913.361263035782;4996.975619997965;5005.474425185449;5036.773345199548;5051.696898185974;6521.934780652133;6586.353411647088;6608.207015158212;6761.966190169214;6828.487863410165;6378.375677633679;6390.5526613136635;6423.197100362455;6487.578307410004;6557;6381.840453988688;6387.776427825004;6402.35976402356;6443.7422503101225;6494.935050649433;6323.241211054703;6378.266499352449;6400.967995160181;6408.166938297992;6466.773662921775;6545.803625891231;6562.934370656423;6577.4409175218725;6586.901196481961;6597.406233439014;6389.648569328731;6438.323975982455;6459.354064593503;6461.386168314003;6473.579217350857 16:21:40 INFO - PID 4372 | |5;yui.html;905.2441211588323;920.1074957291427;926.6895589977357;938.4791440750386;946.1910066892808;18739.3441229557;19747.506312342182;19780;19843.20627174913;22041.669374959387;21698.783012169875;22267.665985010237;22362.329130126083;22441.887790561024;22491.887540562275;1038.4340534408745;1056.133970144478;1057.7831544533353;1058.386136041098;1058.5395353021422;968.8788901387327;1053.2469284461608;1057.4501259345136;1060.5015642647943;1060.7825395793843;1111.372074777752;1119.8600174978128;1121.6410748560463;1121.7812526557325;1121.8429419881181;1113.059464752283;1113.9554417823276;1115.4478533126073;1116.2298014370099;1116.6482557994207;806.4838503357855;817.1134319263606;817.7996390884211;818.6520728690283;818.6970820796344;19821.9008904956;19993.10031048592;19993.300234491722;20118.396448106432;20460.590788184152;22338.553228935492;22413.103475860946;22495.762733049676;22841.42896427586;22901.31296061121;16666.083365414896;16833.66332673352;16901;16901.323947042103;17147.228374723167;3657.9451308230396;3659.6157403472785;3676.283124790667;3676.889693309205;3680.650338217865;122781;125821.37089314587;128403.35798321042;129313;130114;17350.219240134225;17860.642787144443;18045.097745112693;18070.18684159216;18189.27242910295;31152.221194469865;31249.218769530944;31299.374012519624;31387.686123138934;32198.517022244687;7966.920330796734;8357.12250213731;8697.391182617283;9178.173964343241;9299.442033478013;4342.5657434256955;4405.207062728676;4425.3140763181755;4429.069895322018;4472.351509031172;5202.08963431398;5274.7626356814035;5284.154535274338;5302.681839089667;5331.493508116722;972.4748635736764;987.0622908237203;1004.4023805835516;1012.3166862367872;1016.2632091733582;637.4358692557121;679.5311235247763;688.0814113158889;691.2672567078912;693.8855088910374;11882.762344753057;12000.63998080059;12244.81632775509;12388.876111238953;12634.305113218677;636.9968150159219;641.586176915896;644.9967750161313;647.2427260105687;663.2505269046044;5303.416624171338;5362.51737343641;5413.53984911287;5413.675179489243;6041.426064523863;104967;106584.46707766411;108003;108195;114809;94606;98698.50650746844;99392.50303748435;100054;103751.48124259482;87663.56168219118;87692;87979.12020879837;91018;93032.53483732673;11945.16383853122;12248.326342050916;12828.679283017998;12911.9024882886;12964.8055279169;38630;39443.40834887536;39966.20067598573;40340.1931961365;41463.58536414597;67144.66427668025;71202;71266;72088.63955680188;73101;15665.68668626644;19025.42923712291;19139.71290430617;19157.521061973563;19578.608427831077;19430.90284548568;19691.70462443036;21460.678089828976;22024.559508810056;22352.329430117123;18279;18819.247230110643;18886;19133.712994305373;19800.504987375432;17388.652226955644;18979.620407592047;19727.605447890674;19746.60506789885;19933.501662458555;18517.166727497566;18695.719564206276;18852.34016809405;19061.90469047646;19173.424797256106;12536.244925710225;12663.176893501894;12667.239965602093;13088.607341779762;13739.793903091662;13973.231472268717;14775.482858100346;14840.62898427548;15105.773413399027;15226.619334516283 16:21:40 INFO - PID 4372 | __end_tp_report 16:21:40 INFO - PID 4372 | __start_cc_report 16:21:40 INFO - PID 4372 | _x_x_mozilla_cycle_collect,355 16:21:40 INFO - PID 4372 | __end_cc_report 16:21:40 INFO - PID 4372 | __startTimestamp1503012100183__endTimestamp 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | ------- Summary: start ------- 16:21:40 INFO - PID 4372 | Number of tests: 6 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#0] dojo.html Cycles:165 Average:6052.99 Median:6326.27 stddev:690.29 (10.9%) stddev-sans-first:654.41 16:21:40 INFO - PID 4372 | Values: 3173.7 3183.5 3195.8 3219.1 3228.0 6086.1 6158.1 6172.8 6230.4 6238.8 6026.2 6129.9 6152.2 6156.4 6172.3 5603.9 5611.4 5630.8 5656.6 5729.6 5694.2 5701.9 5710.6 5715.5 5740.4 5394.7 5572.8 5589.1 5606.4 5615.4 5513.6 5596.7 5610.3 5661.0 5680.0 5500.9 5520.6 5559.6 5594.4 5627.8 5957.3 5996.8 6022.3 6035.8 6053.2 6415.3 6428.3 6459.2 6460.0 6468.6 6479.7 6480.6 6489.2 6502.2 6514.5 5997.4 6011.3 6036.4 6069.9 6154.3 6718.1 6855.0 6879.1 6897.6 6902.1 6470.9 6480.2 6484.4 6576.9 6579.1 6449.8 6598.7 6645.0 6690.6 6710.2 6501.7 6530.5 6585.9 6589.1 6593.7 6590.6 6637.9 6642.7 6650.8 6651.1 5317.1 5374.4 5442.4 5446.4 5468.9 4571.7 4590.7 4601.1 4607.5 4623.7 5770.2 5771.9 5785.0 5789.7 5790.0 6574.3 6583.4 6597.3 6661.6 6662.8 5733.3 5767.6 5776.2 5789.0 5792.8 5803.9 5835.7 5839.8 5849.1 5853.2 6026.3 6378.3 6425.7 6475.7 6488.5 6379.1 6417.4 6448.6 6514.9 6556.1 6258.3 6295.5 6381.2 6386.9 6393.6 6364.3 6372.8 6383.8 6390.2 6418.1 6558.5 6596.9 6608.0 6628.7 6638.3 6330.6 6336.2 6336.5 6356.3 6389.8 6353.7 6363.8 6424.0 6442.8 6443.0 6359.8 6364.8 6366.4 6379.2 6383.6 6384.0 6385.6 6398.7 6438.8 6484.2 6188.4 6232.0 6247.2 6266.1 6326.3 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#1] ext.html Cycles:180 Average:39406.68 Median:35378.32 stddev:58793.06 (166.2%) stddev-sans-first:58886.65 16:21:40 INFO - PID 4372 | Values: 834.7 834.9 850.9 887.8 890.9 40976.4 41543.2 41661.0 41846.8 41859.6 39219.4 39452.2 39491.6 39540.0 39591.8 6837.9 6947.2 6960.8 6961.2 6970.0 6863.3 6939.6 6942.1 6944.2 6949.9 6931.6 6946.8 6963.1 6964.1 6964.5 6838.4 6896.5 6929.0 6935.3 6940.4 6210.6 6318.7 6333.2 6335.6 6342.0 34987.3 35169.1 35203.3 35283.5 35328.0 3386.1 3439.0 3439.6 3439.8 3440.0 28256.0 28286.4 28289.9 28310.0 28333.3 4453.4 4485.9 4498.7 4560.6 4567.6 228693.0 230062.0 231572.0 231809.0 232720.0 50087.2 50366.7 50429.7 50462.7 50550.0 54077.5 54165.7 54266.7 54299.2 54336.9 16721.5 16825.2 16836.7 16841.3 16851.5 13675.8 13698.6 13700.5 13734.5 13751.9 14812.5 14852.9 14868.4 14952.2 14975.3 5856.6 5908.2 5952.5 5969.1 5971.3 980.3 1010.8 1012.0 1017.0 1021.3 22712.9 23039.4 23178.3 23189.9 23319.7 1115.4 1121.4 1123.1 1127.4 1132.6 12395.0 12403.2 12448.5 12452.3 12573.8 255731.0 255766.0 255960.0 256762.0 256968.0 40382.4 41581.8 41680.4 53630.7 54011.7 1464.6 1473.9 1481.2 1490.3 1500.1 28026.6 28049.4 28281.0 28412.1 28960.3 37509.6 37557.8 37577.0 37591.2 37734.6 185547.0 185547.0 185548.0 185667.0 185946.1 35428.6 35567.3 35612.5 35642.8 37852.6 47670.5 47770.0 47969.5 48148.3 48289.0 34504.3 34928.5 35247.5 35792.6 35876.6 35003.0 35076.5 35077.3 35271.5 35486.6 37715.4 37971.6 38129.4 38237.2 38258.0 33815.3 33872.8 33891.8 34303.1 34400.3 23953.9 24367.3 24536.5 24806.4 25054.0 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#2] jquery.html Cycles:180 Average:37308.89 Median:12696.51 stddev:88591.61 (697.8%) stddev-sans-first:88797.16 16:21:40 INFO - PID 4372 | Values: 556.9 568.7 580.6 581.9 600.9 22404.9 22673.4 23540.6 23572.9 23707.9 26176.9 26592.0 26718.2 26762.6 26785.5 6562.9 6723.0 6726.2 6730.2 6730.8 6012.5 6496.2 6559.9 6570.2 6577.6 6528.3 6540.9 6541.5 6549.4 6557.6 6447.4 6511.9 6520.3 6524.6 6529.9 6055.7 6061.3 6061.6 6073.8 6077.9 28884.1 30250.1 30255.7 30640.1 30973.8 1948.6 1982.0 1982.6 1982.8 1992.1 19497.0 19901.9 19974.4 20068.9 20099.3 2328.6 2337.7 2378.5 2385.6 2443.9 138598.0 141800.3 142050.3 145956.3 146010.0 14583.4 14789.5 14935.8 14993.9 15137.9 23064.4 23743.4 23888.9 23947.2 24015.8 10139.1 10148.9 10189.2 10317.7 10431.2 9511.5 9519.9 9580.2 9594.9 9650.5 9188.4 9263.9 9315.3 9637.1 9738.0 2607.3 2628.3 2686.6 2709.4 2754.0 963.7 981.9 1000.9 1012.3 1016.3 20077.2 20136.6 20341.4 20345.4 20562.0 1038.2 1038.7 1043.6 1048.8 1049.7 11229.7 11457.1 11469.5 11506.3 11613.2 514540.0 517592.0 524255.0 530194.0 540763.0 114777.0 128335.0 129445.0 131890.0 132896.0 1230.1 1271.6 1298.5 1306.3 1308.1 21544.8 21549.2 21561.6 21931.0 22252.7 54401.2 57456.0 57754.0 58603.0 60121.7 81745.6 82446.6 83303.2 86051.6 86916.0 21722.9 21815.3 22335.8 22851.2 22863.2 24133.6 24353.8 24409.7 24769.0 24974.3 18430.4 19054.1 19066.7 19134.6 19371.2 16901.9 16909.6 16998.0 17259.0 17619.6 17620.4 17863.4 17878.8 18666.9 19780.6 21493.6 21727.6 21774.9 21982.7 22023.3 17321.7 17698.8 17871.4 18251.3 18470.1 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#3] mootools.html Cycles:180 Average:8786.04 Median:2592.10 stddev:6035.49 (232.8%) stddev-sans-first:6026.72 16:21:40 INFO - PID 4372 | Values: 1373.7 1439.1 1439.8 1445.3 1445.4 12105.0 13657.7 14233.2 14242.1 14287.7 12199.9 13301.3 14253.9 14407.0 14419.1 2528.7 2603.5 2609.1 2610.2 2612.2 2534.3 2603.8 2623.4 2714.1 2715.9 2641.8 2671.8 2671.9 2673.9 2674.3 2590.4 2613.5 2633.3 2634.0 2653.8 2556.8 2561.4 2593.8 2619.1 2632.2 14196.4 14286.6 14287.4 14287.5 14302.9 7564.8 7807.7 7840.0 7840.1 7847.2 4808.5 4885.9 5073.0 5079.0 5137.9 1784.6 1813.8 1840.7 1848.9 1855.3 23527.2 23724.8 23922.6 23979.6 24061.0 6518.4 6557.8 6715.8 6733.8 6737.3 15222.8 15244.7 15264.7 15272.0 15640.9 7413.1 7578.8 7619.6 7624.7 7633.7 6913.1 6965.1 6984.8 7124.4 7152.0 5021.5 5212.0 5374.5 5409.8 5422.7 1396.7 1457.9 1503.7 1539.8 1549.4 900.6 919.0 920.2 923.6 936.2 7980.8 8071.2 8172.0 8211.9 8234.9 975.0 986.8 997.1 997.5 1002.2 4404.7 4626.5 5106.9 5232.2 5294.3 19147.4 19950.3 19975.3 20011.2 20030.4 18865.3 19457.9 19466.9 19564.9 19747.1 10953.8 11118.2 11128.8 11137.2 11212.4 7802.6 8152.5 8244.1 8394.0 8674.9 16979.5 16994.0 17465.5 17626.4 17715.5 17629.6 17836.9 17840.6 17849.2 17965.2 11484.9 11693.4 11707.2 11721.9 11754.2 12703.9 12754.9 12959.7 12992.4 13017.9 10488.8 10721.6 10940.4 11115.4 11335.8 10155.3 10292.3 10389.0 10394.2 10499.8 9284.8 9332.8 9337.3 9341.7 9343.0 7116.3 7180.1 7188.9 7201.0 7268.6 7032.7 7137.6 7147.1 7173.6 7212.7 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#4] prototype.html Cycles:180 Average:5500.64 Median:6142.55 stddev:1538.11 (25.0%) stddev-sans-first:1495.87 16:21:40 INFO - PID 4372 | Values: 496.6 506.5 521.1 526.4 530.5 6207.6 6216.2 6229.7 6232.9 6248.8 6127.3 6141.5 6143.6 6149.9 6210.0 4815.4 4900.9 4941.7 4965.0 5101.4 4887.4 4937.9 4957.7 4982.0 5003.3 4884.3 4901.5 4905.0 4938.5 4982.4 4893.1 4916.0 4920.0 4924.7 4993.6 4483.3 4488.8 4495.8 4504.5 4542.7 5985.3 6019.2 6031.8 6080.3 6148.3 5640.9 5660.9 5704.0 5736.3 5744.4 6493.8 6537.6 6575.6 6583.6 6599.6 4842.8 4851.5 4863.5 4888.9 4900.9 6601.7 6616.9 6675.7 6731.8 6920.0 4959.9 4970.7 4998.0 5023.9 5046.9 5031.8 5046.5 5086.7 5091.9 5110.2 5674.2 5694.9 5701.5 5707.5 5747.8 6572.9 6615.8 6618.6 6619.1 6687.6 1764.7 1768.2 1779.6 1787.5 1787.9 1173.5 1222.8 1231.2 1246.2 1247.3 5660.5 5690.5 5757.2 5781.0 5831.4 6671.9 6674.0 6773.9 6802.8 6820.0 5715.5 5717.9 5734.9 5787.2 5809.9 3571.7 3583.5 3597.7 3603.3 3606.0 6521.9 6575.4 6575.4 6593.7 6601.5 6799.9 6898.9 6938.7 6945.8 6947.2 6559.9 6569.0 6593.9 6609.8 6638.0 6191.9 6549.3 6619.6 6651.3 6713.3 6630.9 6648.0 6674.9 6693.6 6719.3 6351.0 6489.9 6540.6 6543.7 6604.3 4913.4 4997.0 5005.5 5036.8 5051.7 6521.9 6586.4 6608.2 6762.0 6828.5 6378.4 6390.6 6423.2 6487.6 6557.0 6381.8 6387.8 6402.4 6443.7 6494.9 6323.2 6378.3 6401.0 6408.2 6466.8 6545.8 6562.9 6577.4 6586.9 6597.4 6389.6 6438.3 6459.4 6461.4 6473.6 16:21:40 INFO - PID 4372 | 16:21:40 INFO - PID 4372 | [#5] yui.html Cycles:180 Average:24214.37 Median:19963.30 stddev:32387.70 (162.2%) stddev-sans-first:32431.26 16:21:40 INFO - PID 4372 | Values: 905.2 920.1 926.7 938.5 946.2 18739.3 19747.5 19780.0 19843.2 22041.7 21698.8 22267.7 22362.3 22441.9 22491.9 1038.4 1056.1 1057.8 1058.4 1058.5 968.9 1053.2 1057.5 1060.5 1060.8 1111.4 1119.9 1121.6 1121.8 1121.8 1113.1 1114.0 1115.4 1116.2 1116.6 806.5 817.1 817.8 818.7 818.7 19821.9 19993.1 19993.3 20118.4 20460.6 22338.6 22413.1 22495.8 22841.4 22901.3 16666.1 16833.7 16901.0 16901.3 17147.2 3657.9 3659.6 3676.3 3676.9 3680.7 122781.0 125821.4 128403.4 129313.0 130114.0 17350.2 17860.6 18045.1 18070.2 18189.3 31152.2 31249.2 31299.4 31387.7 32198.5 7966.9 8357.1 8697.4 9178.2 9299.4 4342.6 4405.2 4425.3 4429.1 4472.4 5202.1 5274.8 5284.2 5302.7 5331.5 972.5 987.1 1004.4 1012.3 1016.3 637.4 679.5 688.1 691.3 693.9 11882.8 12000.6 12244.8 12388.9 12634.3 637.0 641.6 645.0 647.2 663.3 5303.4 5362.5 5413.5 5413.7 6041.4 104967.0 106584.5 108003.0 108195.0 114809.0 94606.0 98698.5 99392.5 100054.0 103751.5 87663.6 87692.0 87979.1 91018.0 93032.5 11945.2 12248.3 12828.7 12911.9 12964.8 38630.0 39443.4 39966.2 40340.2 41463.6 67144.7 71202.0 71266.0 72088.6 73101.0 15665.7 19025.4 19139.7 19157.5 19578.6 19430.9 19691.7 21460.7 22024.6 22352.3 18279.0 18819.2 18886.0 19133.7 19800.5 17388.7 18979.6 19727.6 19746.6 19933.5 18517.2 18695.7 18852.3 19061.9 19173.4 12536.2 12663.2 12667.2 13088.6 13739.8 13973.2 14775.5 14840.6 15105.8 15226.6 16:21:40 INFO - PID 4372 | -------- Summary: end -------- 16:21:40 INFO - PID 4372 | 16:21:40 INFO - TEST-INFO | 4372: exit 0 16:21:40 INFO - TEST-OK | dromaeo_css | took 1111905ms 16:21:40 INFO - TEST-START | kraken 16:21:40 INFO - Initialising browser for kraken test... 16:21:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42594/getInfo.html -profile /tmp/tmpzSo8ux/profile 16:21:40 INFO - TEST-INFO | started process 4749 (/builds/slave/test/build/application/firefox/firefox http://localhost:42594/getInfo.html) 16:21:46 INFO - TEST-INFO | 4749: exit 0 16:21:46 INFO - Browser initialized. 16:21:46 INFO - Running cycle 1/1 for kraken test... 16:21:46 INFO - TEST-INFO | started process 4939 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzSo8ux/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:21:47 INFO - PID 4939 | 16:21:47 INFO - PID 4939 | (/builds/slave/test/build/application/firefox/firefox:4993): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:21:47 INFO - PID 4939 | 16:21:57 INFO - PID 4939 | RSS: Main: 166404096 16:21:57 INFO - PID 4939 | 16:22:00 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42594/tests/kraken/driver.html?testName=audio-beat-detection) 16:22:01 INFO - PID 4939 | RSS: Main: 173072384 16:22:01 INFO - PID 4939 | 16:22:03 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42594/tests/kraken/driver.html?testName=audio-dft) 16:22:04 INFO - PID 4939 | RSS: Main: 173391872 16:22:04 INFO - PID 4939 | 16:22:07 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42594/tests/kraken/driver.html?testName=audio-fft) 16:22:08 INFO - PID 4939 | RSS: Main: 167776256 16:22:08 INFO - PID 4939 | 16:22:10 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42594/tests/kraken/driver.html?testName=audio-oscillator) 16:22:10 INFO - PID 4939 | RSS: Main: 168275968 16:22:10 INFO - PID 4939 | 16:22:13 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42594/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:22:13 INFO - PID 4939 | RSS: Main: 168886272 16:22:13 INFO - PID 4939 | 16:22:16 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42594/tests/kraken/driver.html?testName=imaging-darkroom) 16:22:17 INFO - PID 4939 | RSS: Main: 171417600 16:22:17 INFO - PID 4939 | 16:22:21 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42594/tests/kraken/driver.html?testName=imaging-desaturate) 16:22:21 INFO - PID 4939 | RSS: Main: 171282432 16:22:21 INFO - PID 4939 | 16:22:24 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42594/tests/kraken/driver.html?testName=json-parse-financial) 16:22:25 INFO - PID 4939 | RSS: Main: 171708416 16:22:25 INFO - PID 4939 | 16:22:26 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42594/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:22:27 INFO - PID 4939 | RSS: Main: 171720704 16:22:27 INFO - PID 4939 | 16:22:29 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:22:30 INFO - PID 4939 | RSS: Main: 171761664 16:22:30 INFO - PID 4939 | 16:22:32 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:22:32 INFO - PID 4939 | RSS: Main: 171962368 16:22:32 INFO - PID 4939 | 16:22:35 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:22:36 INFO - PID 4939 | RSS: Main: 172126208 16:22:36 INFO - PID 4939 | 16:22:39 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:22:39 INFO - PID 4939 | RSS: Main: 172101632 16:22:39 INFO - PID 4939 | 16:22:41 INFO - PID 4939 | Cycle 1(1): loaded http://localhost:42594/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42594/tests/kraken/driver.html?testName=ai-astar) 16:22:42 INFO - PID 4939 | RSS: Main: 173699072 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | __start_tp_report 16:22:42 INFO - PID 4939 | _x_x_mozilla_page_load 16:22:42 INFO - PID 4939 | _x_x_mozilla_page_load_details 16:22:42 INFO - PID 4939 | |i|pagename|runs| 16:22:42 INFO - PID 4939 | |0;ai-astar;101;107;101;108;109;109;108;99;106;109 16:22:42 INFO - PID 4939 | |1;audio-beat-detection;148;119;144;162;120;149;146;120;168;117 16:22:42 INFO - PID 4939 | |2;audio-dft;168;163;162;163;162;161;163;163;168;167 16:22:42 INFO - PID 4939 | |3;audio-fft;76;76;74;171;78;76;74;80;157;76 16:22:42 INFO - PID 4939 | |4;audio-oscillator;79;83;131;88;79;78;134;80;83;130 16:22:42 INFO - PID 4939 | |5;imaging-gaussian-blur;118;114;114;113;114;113;115;114;114;114 16:22:42 INFO - PID 4939 | |6;imaging-darkroom;150;151;152;149;150;156;152;152;151;152 16:22:42 INFO - PID 4939 | |7;imaging-desaturate;101;94;94;94;94;94;99;95;94;95 16:22:42 INFO - PID 4939 | |8;json-parse-financial;55;57;54;62;53;56;55;58;53;57 16:22:42 INFO - PID 4939 | |9;json-stringify-tinderbox;54;53;54;54;54;53;54;55;55;53 16:22:42 INFO - PID 4939 | |10;stanford-crypto-aes;76;76;78;77;79;77;75;81;79;80 16:22:42 INFO - PID 4939 | |11;stanford-crypto-ccm;122;124;134;120;121;122;127;126;127;164 16:22:42 INFO - PID 4939 | |12;stanford-crypto-pbkdf2;180;177;180;175;176;173;180;172;180;174 16:22:42 INFO - PID 4939 | |13;stanford-crypto-sha256-iterative;70;75;71;69;69;66;74;65;74;70 16:22:42 INFO - PID 4939 | __end_tp_report 16:22:42 INFO - PID 4939 | __start_cc_report 16:22:42 INFO - PID 4939 | _x_x_mozilla_cycle_collect,965 16:22:42 INFO - PID 4939 | __end_cc_report 16:22:42 INFO - PID 4939 | __startTimestamp1503012162083__endTimestamp 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | ------- Summary: start ------- 16:22:42 INFO - PID 4939 | Number of tests: 14 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#0] ai-astar Cycles:10 Average:105.70 Median:108.50 stddev:3.86 (3.6%) stddev-sans-first:3.70 16:22:42 INFO - PID 4939 | Values: 101.0 107.0 101.0 108.0 109.0 109.0 108.0 99.0 106.0 109.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#1] audio-beat-detection Cycles:10 Average:139.30 Median:147.00 stddev:18.94 (12.9%) stddev-sans-first:19.83 16:22:42 INFO - PID 4939 | Values: 148.0 119.0 144.0 162.0 120.0 149.0 146.0 120.0 168.0 117.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:2.62 (1.6%) stddev-sans-first:2.35 16:22:42 INFO - PID 4939 | Values: 168.0 163.0 162.0 163.0 162.0 161.0 163.0 163.0 168.0 167.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.19 (48.9%) stddev-sans-first:38.88 16:22:42 INFO - PID 4939 | Values: 76.0 76.0 74.0 171.0 78.0 76.0 74.0 80.0 157.0 76.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.50 stddev:24.46 (30.8%) stddev-sans-first:25.11 16:22:42 INFO - PID 4939 | Values: 79.0 83.0 131.0 88.0 79.0 78.0 134.0 80.0 83.0 130.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:0.60 16:22:42 INFO - PID 4939 | Values: 118.0 114.0 114.0 113.0 114.0 113.0 115.0 114.0 114.0 114.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:152.00 stddev:1.90 (1.3%) stddev-sans-first:1.94 16:22:42 INFO - PID 4939 | Values: 150.0 151.0 152.0 149.0 150.0 156.0 152.0 152.0 151.0 152.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:94.00 stddev:2.50 (2.7%) stddev-sans-first:1.64 16:22:42 INFO - PID 4939 | Values: 101.0 94.0 94.0 94.0 94.0 94.0 99.0 95.0 94.0 95.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.50 stddev:2.71 (4.8%) stddev-sans-first:2.85 16:22:42 INFO - PID 4939 | Values: 55.0 57.0 54.0 62.0 53.0 56.0 55.0 58.0 53.0 57.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#9] json-stringify-tinderbox Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 16:22:42 INFO - PID 4939 | Values: 54.0 53.0 54.0 54.0 54.0 53.0 54.0 55.0 55.0 53.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.50 stddev:1.93 (2.5%) stddev-sans-first:1.94 16:22:42 INFO - PID 4939 | Values: 76.0 76.0 78.0 77.0 79.0 77.0 75.0 81.0 79.0 80.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.50 stddev:13.06 (10.3%) stddev-sans-first:13.62 16:22:42 INFO - PID 4939 | Values: 122.0 124.0 134.0 120.0 121.0 122.0 127.0 126.0 127.0 164.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:178.50 stddev:3.16 (1.8%) stddev-sans-first:3.12 16:22:42 INFO - PID 4939 | Values: 180.0 177.0 180.0 175.0 176.0 173.0 180.0 172.0 180.0 174.0 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:3.33 (4.7%) stddev-sans-first:3.54 16:22:42 INFO - PID 4939 | Values: 70.0 75.0 71.0 69.0 69.0 66.0 74.0 65.0 74.0 70.0 16:22:42 INFO - PID 4939 | -------- Summary: end -------- 16:22:42 INFO - PID 4939 | 16:22:42 INFO - PID 4939 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:22:42 INFO - TEST-INFO | 4939: exit 0 16:22:42 INFO - TEST-OK | kraken | took 61931ms 16:22:42 INFO - SUITE-END | took 1173s 16:22:43 INFO - Completed test suite (00:19:34) 16:22:43 INFO - javascript benchmark 16:22:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8566.099613234652, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.6984986426282, 3183.4906414973607, 3195.8242296673684, 3219.1308346746364, 3227.9515807262896, 6086.117512960618, 6158.107074474198, 6172.753089876405, 6230.376962303767, 6238.812835614927, 6026.156338112668, 6129.908051379221, 6152.230971128609, 6156.353582873801, 6172.259328880541, 5603.915941260864, 5611.410801865796, 5630.831075067734, 5656.575756818234, 5729.570282228829, 5694.174344720013, 5701.885962280752, 5710.5717071219615, 5715.5427565794635, 5740.397258287882, 5394.703291318976, 5572.7770889164385, 5589.133684278943, 5606.383297837235, 5615.438456154393, 5513.61404701671, 5596.748146333425, 5610.270664813589, 5661.009323368436, 5680.0, 5500.917486237709, 5520.641158324696, 5559.63862348946, 5594.384617692051, 5627.831165065055, 5957.314908785502, 5996.760129594811, 6022.337542870281, 6035.849103772397, 6053.152558641794, 6415.294317625057, 6428.292887782341, 6459.160309159826, 6459.967700161516, 6468.611883287018, 6479.676016199218, 6480.57876238043, 6489.221293444817, 6502.154719886432, 6514.5114116441455, 5997.370276120988, 6011.338752737195, 6036.366181550918, 6069.939300607026, 6154.323024467305, 6718.126643536407, 6854.971754236804, 6879.140107486564, 6897.55165914214, 6902.102726645604, 6470.9029364559565, 6480.157579514633, 6484.448821850101, 6576.868462630816, 6579.144711187515, 6449.774257900951, 6598.670066496752, 6644.96677516619, 6690.632015239111, 6710.16122984627, 6501.707423165969, 6530.542861999709, 6585.86828263432, 6589.110470086573, 6593.6703164841565, 6590.604563726191, 6637.900431493532, 6642.701078451481, 6650.767223147167, 6651.068850360954, 5317.069512835238, 5374.435684253175, 5442.374126975448, 5446.428125046813, 5468.890622187534, 4571.725696458223, 4590.655700822452, 4601.079784043205, 4607.539246075366, 4623.653226008063, 5770.19217309577, 5771.8557036074435, 5785.016547186989, 5789.739461724233, 5789.9710501447225, 6574.309697481695, 6583.440407565315, 6597.30728273534, 6661.633610151488, 6662.766803161963, 5733.3406658234, 5767.596268261265, 5776.220210271559, 5789.015867302569, 5792.82621521355, 5803.941960580424, 5835.737391817378, 5839.795607153814, 5849.093390524476, 5853.209816674779, 6026.337102918676, 6378.330275321117, 6425.710843012076, 6475.676216189266, 6488.513361497907, 6379.138816259931, 6417.422431981144, 6448.580842245239, 6514.902276465762, 6556.082148499309, 6258.311585725658, 6295.464885484785, 6381.1704478417505, 6386.90419643715, 6393.6483493408305, 6364.299927008118, 6372.776952806629, 6383.776567820104, 6390.169277993831, 6418.133551970611, 6558.540902136805, 6596.934030659632, 6608.041833934149, 6628.734850605922, 6638.269790322964, 6330.638912633806, 6336.20797400325, 6336.461400780985, 6356.269029061532, 6389.840253993501, 6353.650549219652, 6363.840903977438, 6424.0, 6442.774502892376, 6443.0, 6359.841003974938, 6364.840878978062, 6366.427021567896, 6379.202599675041, 6383.553151279366, 6383.96808015957, 6385.648789316632, 6398.744050237939, 6438.806835794933, 6484.1894763154605, 6188.350223226496, 6231.9688401557705, 6247.219097612799, 6266.122742816101, 6326.272478664829], "value": 6003.468656163313, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [834.6577903059747, 834.8872902158207, 850.9446885952412, 887.7736177274794, 890.8530092534733, 40976.38535421971, 41543.169136617325, 41661.0, 41846.7907660462, 41859.58140418603, 39219.41170882439, 39452.21095578094, 39491.60508394915, 39540.0, 39591.80204098976, 6837.931620683792, 6947.201071876749, 6960.825979350531, 6961.234264230956, 6970.0, 6863.313668633146, 6939.5836249824915, 6942.097527321441, 6944.201416837052, 6949.861002779941, 6931.584104953719, 6946.826329341781, 6963.05998690178, 6964.059851920002, 6964.547304425221, 6838.418734407582, 6896.517243792937, 6929.029935808991, 6935.3411425914455, 6940.375366217039, 6210.5963112398, 6318.652474113922, 6333.240011198685, 6335.5565110442285, 6342.016987366966, 34987.30025399503, 35169.12077198065, 35203.295934081434, 35283.4707479388, 35328.0, 3386.0519054664733, 3439.0, 3439.638837922007, 3439.8280085995852, 3439.9656003439895, 28256.0, 28286.434271314458, 28289.858550707115, 28310.0, 28333.291667708265, 4453.398791163184, 4485.932711009337, 4498.730076195438, 4560.5895469407915, 4567.566081222279, 228693.0, 230061.9999999983, 231571.9999999983, 231809.0, 232720.0, 50087.24869126966, 50366.748166258934, 50429.74785126124, 50462.74768626133, 50550.0, 54077.45922540803, 54165.729171353894, 54266.728666356415, 54299.18551221735, 54336.913261734546, 16721.498355049367, 16825.242864071148, 16836.6632667346, 16841.326346945985, 16851.494455166365, 13675.794863077062, 13698.589042328746, 13700.520481783089, 13734.519291824938, 13751.862481375058, 14812.481563145238, 14852.92573537147, 14868.405263789544, 14952.177630230442, 14975.251237438084, 5856.648601083949, 5908.202392676933, 5952.494038006731, 5969.134475501115, 5971.253593300838, 980.3186785184229, 1010.782681723433, 1012.0436187802457, 1017.0338178730088, 1021.341234903483, 22712.886435568045, 23039.42401439944, 23178.3046508605, 23189.884050579978, 23319.650205246933, 1115.4311301236428, 1121.4168632311316, 1123.095907794217, 1127.3574062784135, 1132.5526417065378, 12395.0, 12403.193792403465, 12448.502059917502, 12452.252864828139, 12573.811392829115, 255731.0, 255766.0, 255960.0, 256762.0, 256968.0, 40382.39426408606, 41581.79209103935, 41680.374794378105, 53630.73184634052, 54011.729941350044, 1464.5752731707898, 1473.9115653060637, 1481.1927499512792, 1490.2548725637182, 1500.0849481816083, 28026.579601306403, 28049.439011219252, 28281.0, 28412.147635570967, 28960.275993100342, 37509.62490375061, 37557.81221093877, 37577.0, 37591.24817503689, 37734.62265377311, 185547.0, 185547.0, 185548.0, 185667.0, 185946.07026964778, 35428.64571354254, 35567.28865422729, 35612.465813012306, 35642.821785890905, 37852.62147378491, 47670.523294768, 47770.0, 47969.5203047979, 48148.27777583269, 48289.0, 34504.30991380108, 34928.47607285842, 35247.471287931214, 35792.64207357997, 35876.64123358837, 35003.0, 35076.473852891715, 35077.298454030264, 35271.470927936614, 35486.645133548336, 37715.43426848654, 37971.62028379681, 38129.42805857859, 38237.23525529418, 38258.0435489115, 33815.32369352649, 33872.830635846665, 33891.830540847135, 34303.14242143966, 34400.31199375948, 23953.880230598734, 24367.26898193057, 24536.509269814145, 24806.37984050413, 25054.0], "value": 17221.945284285495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8858384031274, 568.7374029654169, 580.5558747558116, 581.9243498345215, 600.8828278485696, 22404.88797556014, 22673.433164170885, 23540.646890296637, 23572.882135589298, 23707.881460592715, 26176.86911565444, 26592.0, 26718.19845404636, 26762.5985610216, 26785.464290714175, 6562.934370656304, 6722.966385168067, 6726.159230096238, 6730.158730158731, 6730.831729206784, 6012.458878700916, 6496.220453545581, 6559.868802623969, 6570.211574611053, 6577.605343679371, 6528.31452697467, 6540.901886471706, 6541.476681865463, 6549.443297319734, 6557.639329836857, 6447.387498187712, 6511.9348806512035, 6520.347965203489, 6524.608523488606, 6529.934700652981, 6055.697215139269, 6061.333253342129, 6061.575689701723, 6073.787417440369, 6077.878442431127, 28884.133475995543, 30250.09249722512, 30255.697443025507, 30640.08079757611, 30973.84513077443, 1948.5518330783857, 1982.0486166639948, 1982.6133903888604, 1982.7620685517686, 1992.1135094882784, 19497.0, 19901.9004904976, 19974.400767976986, 20068.899655501627, 20099.296524621568, 2328.592496313155, 2337.7311609164994, 2378.5005148918576, 2385.642153676945, 2443.926682199537, 138598.0, 141800.2909985454, 142050.28974855162, 145956.27021864822, 146010.0, 14583.416663333348, 14789.482368117064, 14935.775963360558, 14993.875459340376, 15137.924310378377, 23064.4233894154, 23743.40641483942, 23888.880555597112, 23947.203959703093, 24015.759842401352, 10139.138173255209, 10148.898511014795, 10189.23580731448, 10317.690469285933, 10431.217658675478, 9511.476868772284, 9519.857202141973, 9580.233581313478, 9594.904050959402, 9650.517474126265, 9188.356815023018, 9263.861042084374, 9315.34792564514, 9637.084476974676, 9737.951310243403, 2607.2569317744733, 2628.290361602395, 2686.5835795451735, 2709.403931135147, 2753.9654406294876, 963.6964356227905, 981.9018098190267, 1000.9449480278655, 1012.2863381316155, 1016.2632091733434, 20077.196912123643, 20136.597268054556, 20341.389758307276, 20345.389638310873, 20562.0, 1038.159091136182, 1038.6520515627199, 1043.5877828257796, 1048.7797562511805, 1049.6536143072767, 11229.66311010671, 11457.14071444645, 11469.54121835134, 11506.252093613888, 11613.245139065933, 514540.0, 517592.0, 524255.0, 530194.0, 540763.0, 114777.0, 128335.0, 129445.0, 131890.0, 132896.0, 1230.1266101068163, 1271.5994461744706, 1298.487097596463, 1306.294600915495, 1308.0908768406057, 21544.784552154277, 21549.24577639775, 21561.568768624227, 21931.0, 22252.666210007188, 54401.18398224109, 57455.99999999833, 57754.0, 58603.0, 60121.69939150451, 81745.59127204325, 82446.58776706317, 83303.16696832955, 86051.5697421509, 86916.0, 21722.89138554297, 21815.345539633836, 22335.77664223337, 22851.20020799264, 22863.19978800734, 24133.637995430432, 24353.756462435147, 24409.743910056215, 24769.0, 24974.250772476855, 18430.447086587425, 19054.14256358495, 19066.713999289743, 19134.61730765349, 19371.225150993803, 16901.91549042296, 16909.577260568585, 16998.0, 17259.0, 17619.55951101233, 17620.38328658542, 17863.374781882572, 17878.821211787716, 18666.906665466584, 19780.604387911873, 21493.570128597654, 21727.565448691254, 21774.891125544273, 21982.670259946433, 22023.33929982039, 17321.653566928842, 17698.823011769717, 17871.374501892373, 18251.269949201884, 18470.076496175407], "value": 12586.029273563188, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.732122236164, 1439.1365180891466, 1439.8128243328372, 1445.2845841308554, 1445.3568162167837, 12105.0, 13657.65855853604, 14233.217173055491, 14242.145471271731, 14287.71424571508, 12199.939000305008, 13301.334933253347, 14253.857461425408, 14407.0, 14419.134851908893, 2528.6839145106906, 2603.4662894106664, 2609.112901613451, 2610.151700697281, 2612.1510509084624, 2534.3284029732135, 2603.7526434988645, 2623.4097328101216, 2714.050082471139, 2715.8642067896626, 2641.7886569074426, 2671.8129730918845, 2671.8530480823547, 2673.879675414611, 2674.3447855275485, 2590.352411897026, 2613.451175253199, 2633.262686447788, 2634.038575919785, 2653.787696984237, 2556.782673472757, 2561.398071453207, 2593.844369337846, 2619.0571394298036, 2632.1840229528907, 14196.432142714279, 14286.571402857828, 14287.428502859873, 14287.499937502138, 14302.928485357506, 7564.773056808304, 7807.726729564438, 7840.0, 7840.13758486566, 7847.155918359181, 4808.543188397097, 4885.926711099336, 5073.036123136592, 5079.0, 5137.897242055175, 1784.616307493895, 1813.7551430556837, 1840.7330937014058, 1848.8705790594663, 1855.2578968412743, 23527.17654882088, 23724.7627523726, 23922.64116038261, 23979.640305395435, 24061.0, 6518.445932095825, 6557.770478033246, 6715.7985260442265, 6733.764318248838, 6737.29258427858, 15222.771658425132, 15244.695106097815, 15264.694706106038, 15272.0, 15640.905136640553, 7413.1104267488245, 7578.772636820904, 7619.580923049175, 7624.733134340382, 7633.69465221385, 6913.1358580177475, 6965.059716938148, 6984.755533556301, 7124.358807707331, 7151.964240178766, 5021.548060674484, 5212.0, 5374.48942350476, 5409.83770486886, 5422.674639521641, 1396.6648004479055, 1457.890658200639, 1503.6541595433112, 1539.7921280627197, 1549.3570168380222, 900.6307413960245, 919.0441940381928, 920.2270093121809, 923.630547780893, 936.2042264075482, 7980.760577182694, 8071.192880711999, 8171.95914020438, 8211.917880821115, 8234.917650823416, 974.9951250243845, 986.7566865749064, 997.115451796106, 997.5411310796969, 1002.2032484175098, 4404.713693609905, 4626.467956185014, 5106.874754046121, 5232.162853943427, 5294.338207724035, 19147.425577232705, 19950.30173943905, 19975.300864469675, 20011.199552017755, 20030.39908802738, 18865.339713109974, 19457.90271048664, 19466.90266548658, 19564.90217548903, 19747.111379987935, 10953.83569246462, 11118.166137539716, 11128.777424451466, 11137.164712646583, 11212.439378031066, 7802.609869506388, 8152.510849349058, 8244.051934027424, 8394.0, 8674.869876951725, 16979.490615281065, 16994.0, 17465.476035718948, 17626.383076592258, 17715.468535943943, 17629.559261018065, 17836.91081544584, 17840.55398615045, 17849.196786144395, 17965.191566379282, 11484.88515114838, 11693.356865372487, 11707.239029463057, 11721.882781172078, 11754.177207595387, 12703.93648031754, 12754.872451275369, 12959.740805183656, 12992.415341309475, 13017.934910325766, 10488.790224195322, 10721.571137154426, 10940.39827809478, 11115.44422778874, 11335.773284534098, 10155.289129760846, 10292.330998485373, 10389.0, 10394.16846652251, 10499.79000419972, 9284.767880802763, 9332.766680833034, 9337.253019758538, 9341.673041443517, 9343.0, 7116.323949224816, 7180.066591343092, 7188.856222875409, 7201.0, 7268.636568171676, 7032.718691252293, 7137.607431591312, 7147.142342918883, 7173.605451700207, 7212.711491540489], "value": 6411.836773186451, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.5679858523084, 506.49097656854855, 521.1323146960311, 526.3920172201109, 530.5463828426695, 6207.596506227098, 6216.191895053642, 6229.688515574215, 6232.875342493147, 6248.750049998001, 6127.264728232618, 6141.477974372184, 6143.631382117076, 6149.938500614992, 6209.982719526928, 4815.446223684268, 4900.926486102711, 4941.67879087859, 4964.975175124119, 5101.362329708786, 4887.364642596457, 4937.851864444055, 4957.702537847741, 4981.9750901245625, 5003.274525193845, 4884.291777692232, 4901.509849015088, 4905.03798480607, 4938.530839570235, 4982.352294201749, 4893.070316639827, 4916.0, 4919.950800491985, 4924.679895806797, 4993.6005119590345, 4483.282674772021, 4488.820447182142, 4495.820167193341, 4504.549545045502, 4542.682012259143, 5985.34161242263, 6019.247594050744, 6031.819045428644, 6080.2877769728375, 6148.262208534959, 5640.858978525529, 5660.915086273709, 5704.0, 5736.311642602873, 5744.368119506851, 6493.837654058639, 6537.64042977636, 6575.572587781827, 6583.637899915503, 6599.604023758542, 4842.782074806642, 4851.490593487668, 4863.465018847924, 4888.853334399973, 4900.901981960376, 6601.7359305627715, 6616.933830661632, 6675.732970681167, 6731.798046058626, 6919.965400173017, 4959.851204463872, 4970.652054356233, 4998.0, 5023.874403139951, 5046.924296135561, 5031.7987280509105, 5046.495350464924, 5086.72023038729, 5091.87270318245, 5110.233464980209, 5674.233978412862, 5694.9430505695245, 5701.458361455655, 5707.543396528268, 5747.827565173052, 6572.868542629216, 6615.768448104293, 6618.617297772798, 6619.139511863427, 6687.598744075371, 1764.6823571757207, 1768.2308195934809, 1779.590694140329, 1787.4905651889148, 1787.8748487605742, 1173.4543437301695, 1222.7554489102215, 1231.1689609513721, 1246.2148846227, 1247.2828123828835, 5660.5471562274915, 5690.516306113944, 5757.165211044459, 5781.034448287603, 5831.358550559435, 6671.933280667228, 6674.0, 6773.93226067733, 6802.795916122524, 6819.965900170468, 5715.5427565794635, 5717.914231286534, 5734.856628584319, 5787.2476578045425, 5809.854753631109, 3571.7320351275443, 3583.4624806279267, 3597.712183025352, 3603.3153700796765, 3606.00834770435, 6521.934780652227, 6575.408213260734, 6575.4410875076155, 6593.6703164841565, 6601.471882249409, 6799.864002720017, 6898.860349039997, 6938.722451101899, 6945.756898508528, 6947.201071876698, 6559.868802623921, 6569.0, 6593.901091483632, 6609.768658096944, 6637.966810165918, 6191.907121393093, 6549.279579246184, 6619.635920024445, 6651.301613330531, 6713.295104014008, 6630.867382652416, 6648.0, 6674.8998765017595, 6693.564918280296, 6719.26088130315, 6350.983842585349, 6489.8702025960165, 6540.574862633914, 6543.70553325092, 6604.306547812411, 4913.361263035782, 4996.975619997965, 5005.474425185449, 5036.773345199548, 5051.696898185974, 6521.934780652133, 6586.353411647088, 6608.207015158212, 6761.966190169214, 6828.487863410165, 6378.375677633679, 6390.5526613136635, 6423.197100362455, 6487.578307410004, 6557.0, 6381.840453988688, 6387.776427825004, 6402.35976402356, 6443.7422503101225, 6494.935050649433, 6323.241211054703, 6378.266499352449, 6400.967995160181, 6408.166938297992, 6466.773662921775, 6545.803625891231, 6562.934370656423, 6577.4409175218725, 6586.901196481961, 6597.406233439014, 6389.648569328731, 6438.323975982455, 6459.354064593503, 6461.386168314003, 6473.579217350857], "value": 5050.020581503093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.2441211588323, 920.1074957291427, 926.6895589977357, 938.4791440750386, 946.1910066892808, 18739.3441229557, 19747.506312342182, 19780.0, 19843.20627174913, 22041.669374959387, 21698.783012169875, 22267.665985010237, 22362.329130126083, 22441.887790561024, 22491.887540562275, 1038.4340534408745, 1056.133970144478, 1057.7831544533353, 1058.386136041098, 1058.5395353021422, 968.8788901387327, 1053.2469284461608, 1057.4501259345136, 1060.5015642647943, 1060.7825395793843, 1111.372074777752, 1119.8600174978128, 1121.6410748560463, 1121.7812526557325, 1121.8429419881181, 1113.059464752283, 1113.9554417823276, 1115.4478533126073, 1116.2298014370099, 1116.6482557994207, 806.4838503357855, 817.1134319263606, 817.7996390884211, 818.6520728690283, 818.6970820796344, 19821.9008904956, 19993.10031048592, 19993.300234491722, 20118.396448106432, 20460.590788184152, 22338.553228935492, 22413.103475860946, 22495.762733049676, 22841.42896427586, 22901.31296061121, 16666.083365414896, 16833.66332673352, 16901.0, 16901.323947042103, 17147.228374723167, 3657.9451308230396, 3659.6157403472785, 3676.283124790667, 3676.889693309205, 3680.650338217865, 122781.0, 125821.37089314587, 128403.35798321042, 129313.0, 130114.0, 17350.219240134225, 17860.642787144443, 18045.097745112693, 18070.18684159216, 18189.27242910295, 31152.221194469865, 31249.218769530944, 31299.374012519624, 31387.686123138934, 32198.517022244687, 7966.920330796734, 8357.12250213731, 8697.391182617283, 9178.173964343241, 9299.442033478013, 4342.5657434256955, 4405.207062728676, 4425.3140763181755, 4429.069895322018, 4472.351509031172, 5202.08963431398, 5274.7626356814035, 5284.154535274338, 5302.681839089667, 5331.493508116722, 972.4748635736764, 987.0622908237203, 1004.4023805835516, 1012.3166862367872, 1016.2632091733582, 637.4358692557121, 679.5311235247763, 688.0814113158889, 691.2672567078912, 693.8855088910374, 11882.762344753057, 12000.63998080059, 12244.81632775509, 12388.876111238953, 12634.305113218677, 636.9968150159219, 641.586176915896, 644.9967750161313, 647.2427260105687, 663.2505269046044, 5303.416624171338, 5362.51737343641, 5413.53984911287, 5413.675179489243, 6041.426064523863, 104967.0, 106584.46707766411, 108003.0, 108195.0, 114809.0, 94606.0, 98698.50650746844, 99392.50303748435, 100054.0, 103751.48124259482, 87663.56168219118, 87692.0, 87979.12020879837, 91018.0, 93032.53483732673, 11945.16383853122, 12248.326342050916, 12828.679283017998, 12911.9024882886, 12964.8055279169, 38630.0, 39443.40834887536, 39966.20067598573, 40340.1931961365, 41463.58536414597, 67144.66427668025, 71202.0, 71266.0, 72088.63955680188, 73101.0, 15665.68668626644, 19025.42923712291, 19139.71290430617, 19157.521061973563, 19578.608427831077, 19430.90284548568, 19691.70462443036, 21460.678089828976, 22024.559508810056, 22352.329430117123, 18279.0, 18819.247230110643, 18886.0, 19133.712994305373, 19800.504987375432, 17388.652226955644, 18979.620407592047, 19727.605447890674, 19746.60506789885, 19933.501662458555, 18517.166727497566, 18695.719564206276, 18852.34016809405, 19061.90469047646, 19173.424797256106, 12536.244925710225, 12663.176893501894, 12667.239965602093, 13088.607341779762, 13739.793903091662, 13973.231472268717, 14775.482858100346, 14840.62898427548, 15105.773413399027, 15226.619334516283], "value": 9376.095296927819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 101.0, 108.0, 109.0, 109.0, 108.0, 99.0, 106.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 119.0, 144.0, 162.0, 120.0, 149.0, 146.0, 120.0, 168.0, 117.0], "value": 139.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 162.0, 163.0, 162.0, 161.0, 163.0, 163.0, 168.0, 167.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 171.0, 78.0, 76.0, 74.0, 80.0, 157.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 131.0, 88.0, 79.0, 78.0, 134.0, 80.0, 83.0, 130.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 114.0, 113.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 149.0, 150.0, 156.0, 152.0, 152.0, 151.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 54.0, 62.0, 53.0, 56.0, 55.0, 58.0, 53.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 53.0, 54.0, 55.0, 55.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 77.0, 79.0, 77.0, 75.0, 81.0, 79.0, 80.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 124.0, 134.0, 120.0, 121.0, 122.0, 127.0, 126.0, 127.0, 164.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 177.0, 180.0, 175.0, 176.0, 173.0, 180.0, 172.0, 180.0, 174.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 71.0, 69.0, 69.0, 66.0, 74.0, 65.0, 74.0, 70.0], "value": 70.3, "unit": "score"}]}]} 16:22:43 INFO - Return code: 0 16:22:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:22:43 INFO - # TBPL SUCCESS # 16:22:43 INFO - Running post-action listener: _package_coverage_data 16:22:43 INFO - Running post-action listener: _resource_record_post_action 16:22:43 INFO - [mozharness: 2017-08-17 23:22:43.356925Z] Finished run-tests step (success) 16:22:43 INFO - Running post-run listener: _resource_record_post_run 16:22:43 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 479232; Write bytes: 444243968; Read time: 300; Write time: 239156 16:22:43 INFO - TinderboxPrint: CPU usage
13.1% 16:22:43 INFO - TinderboxPrint: I/O read bytes / time
479,232 / 300 16:22:43 INFO - TinderboxPrint: I/O write bytes / time
444,243,968 / 239,156 16:22:43 INFO - TinderboxPrint: CPU idle
8,262.6 (86.9%) 16:22:43 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 16:22:43 INFO - TinderboxPrint: Swap in / out
0 / 0 16:22:43 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116572160; Read time: 28; Write time: 73596 16:22:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:22:43 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 471040; Write bytes: 327143424; Read time: 260; Write time: 165560 16:22:44 INFO - Running post-run listener: _upload_blobber_files 16:22:44 INFO - Blob upload gear active. 16:22:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:22:44 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 16:22:44 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'] 16:22:44 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 16:22:44 INFO - (blobuploader) - INFO - Open directory for files ... 16:22:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:22:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:45 INFO - (blobuploader) - INFO - Done attempting. 16:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:22:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:45 INFO - (blobuploader) - INFO - Done attempting. 16:22:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:22:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:22:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:52 INFO - (blobuploader) - INFO - Done attempting. 16:22:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:22:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:22:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:22:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:22:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:22:53 INFO - (blobuploader) - INFO - Done attempting. 16:22:53 INFO - (blobuploader) - INFO - Iteration through files over. 16:22:53 INFO - Return code: 0 16:22:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:22:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:22:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d22df30699f570c7df6b9c698443f7cc547f10f73f138c3c6ace2f8e5030b6eabf11f2afd18e7c448fd41db28dc00cde3f03aa8d272078b226985249807715", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71c89c92a442359970ee4d38d540ea043a58681db2df0b4318ba47a2548f522a65d442d74a4d79c8b89794c49ce3f51ff364e52c8c5ec2485ab694d5ed09254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be9b84c404d0f0fdd6ace06b73476939d200cb3b78d2c490f137bfcb26b03f71859a80126967887bd5fa7b99e21ff84f487c44b82f56bab34abe145e122fc6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71626cb82f959b03bb406d1ba1d4ac1425bd35292bb17269faa0e9452c81ef71bd6d224f46a93ffaba48d4635efb3b6544699547b93f9c8cef3c533be6147d5c"} 16:22:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:22:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:22:53 INFO - Contents: 16:22:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d22df30699f570c7df6b9c698443f7cc547f10f73f138c3c6ace2f8e5030b6eabf11f2afd18e7c448fd41db28dc00cde3f03aa8d272078b226985249807715", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71c89c92a442359970ee4d38d540ea043a58681db2df0b4318ba47a2548f522a65d442d74a4d79c8b89794c49ce3f51ff364e52c8c5ec2485ab694d5ed09254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be9b84c404d0f0fdd6ace06b73476939d200cb3b78d2c490f137bfcb26b03f71859a80126967887bd5fa7b99e21ff84f487c44b82f56bab34abe145e122fc6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71626cb82f959b03bb406d1ba1d4ac1425bd35292bb17269faa0e9452c81ef71bd6d224f46a93ffaba48d4635efb3b6544699547b93f9c8cef3c533be6147d5c"} 16:22:53 INFO - Running post-run listener: copy_logs_to_upload_dir 16:22:53 INFO - Copying logs to upload dir... 16:22:53 INFO - mkdir: /builds/slave/test/build/upload/logs 16:22:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.385103 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-17 16:22:53.845745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:22:53.849703) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d22df30699f570c7df6b9c698443f7cc547f10f73f138c3c6ace2f8e5030b6eabf11f2afd18e7c448fd41db28dc00cde3f03aa8d272078b226985249807715", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71c89c92a442359970ee4d38d540ea043a58681db2df0b4318ba47a2548f522a65d442d74a4d79c8b89794c49ce3f51ff364e52c8c5ec2485ab694d5ed09254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be9b84c404d0f0fdd6ace06b73476939d200cb3b78d2c490f137bfcb26b03f71859a80126967887bd5fa7b99e21ff84f487c44b82f56bab34abe145e122fc6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71626cb82f959b03bb406d1ba1d4ac1425bd35292bb17269faa0e9452c81ef71bd6d224f46a93ffaba48d4635efb3b6544699547b93f9c8cef3c533be6147d5c"} build_url:https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011914 build_url: 'https://queue.taskcluster.net/v1/task/aWkJAhYOSgqx_drvisgeVA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86d22df30699f570c7df6b9c698443f7cc547f10f73f138c3c6ace2f8e5030b6eabf11f2afd18e7c448fd41db28dc00cde3f03aa8d272078b226985249807715", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e71c89c92a442359970ee4d38d540ea043a58681db2df0b4318ba47a2548f522a65d442d74a4d79c8b89794c49ce3f51ff364e52c8c5ec2485ab694d5ed09254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3be9b84c404d0f0fdd6ace06b73476939d200cb3b78d2c490f137bfcb26b03f71859a80126967887bd5fa7b99e21ff84f487c44b82f56bab34abe145e122fc6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71626cb82f959b03bb406d1ba1d4ac1425bd35292bb17269faa0e9452c81ef71bd6d224f46a93ffaba48d4635efb3b6544699547b93f9c8cef3c533be6147d5c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 16:22:53.877211) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:22:53.877553) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1503010886.258089-955361407 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 16:22:53.960486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:22:53.960845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 16:22:53.961142) ========= ========= Total master_lag: 0.15 =========