builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1503943954.79 results: success (0) revision: 3529b653ede26f990eb7320649015294ad0f8e76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.788825) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.789245) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.789513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.805215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.805473) ========= 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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-28 11:12:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-08-28 11:12:35 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085020 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.905591) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.905893) ========= 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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014990 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:34.958093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-28 11:12:34.961449) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3529b653ede26f990eb7320649015294ad0f8e76 --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 3529b653ede26f990eb7320649015294ad0f8e76 --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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-28 11:12:35,303 truncating revision to first 12 chars 2017-08-28 11:12:35,303 Setting DEBUG logging. 2017-08-28 11:12:35,303 attempt 1/10 2017-08-28 11:12:35,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3529b653ede2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-28 11:12:36,009 unpacking tar archive at: mozilla-central-3529b653ede2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-28 11:12:36.028003) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:36.031402) ========= script_repo_revision: 3529b653ede26f990eb7320649015294ad0f8e76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:36.031760) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:36.032030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-28 11:12:36.043805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-28 11:12:36.044070) ========= /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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:12:36 INFO - MultiFileLogger online at 20170828 11:12:36 in /builds/slave/test 11:12:36 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 11:12:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:12:36 INFO - {'append_to_log': False, 11:12:36 INFO - 'base_work_dir': '/builds/slave/test', 11:12:36 INFO - 'blob_upload_branch': 'Firefox', 11:12:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:12:36 INFO - 'branch': 'Firefox', 11:12:36 INFO - 'buildbot_json_path': 'buildprops.json', 11:12:36 INFO - 'code_coverage': False, 11:12:36 INFO - 'config_files': ('talos/linux_config.py',), 11:12:36 INFO - 'default_actions': ('clobber', 11:12:36 INFO - 'read-buildbot-config', 11:12:36 INFO - 'download-and-extract', 11:12:36 INFO - 'populate-webroot', 11:12:36 INFO - 'create-virtualenv', 11:12:36 INFO - 'install', 11:12:36 INFO - 'setup-mitmproxy', 11:12:36 INFO - 'run-tests'), 11:12:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:12:36 INFO - 'disable_ccov_upload': False, 11:12:36 INFO - 'download_minidump_stackwalk': True, 11:12:36 INFO - 'download_symbols': 'ondemand', 11:12:36 INFO - 'enable_stylo': False, 11:12:36 INFO - 'enable_webrender': False, 11:12:36 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:12:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:12:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:12:36 INFO - 'gecko_profile': False, 11:12:36 INFO - 'gecko_profile_interval': 0, 11:12:36 INFO - 'installer_path': 'installer.exe', 11:12:36 INFO - 'log_level': 'info', 11:12:36 INFO - 'log_name': 'talos', 11:12:36 INFO - 'log_to_console': True, 11:12:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:12:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:12:36 INFO - 'opt_config_files': (), 11:12:36 INFO - 'pip_index': False, 11:12:36 INFO - 'suite': 'dromaeojs-e10s', 11:12:36 INFO - 'system_bits': '32', 11:12:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:12:36 INFO - 'title': 'talos-linux64-ix-082', 11:12:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:12:36 INFO - 'use_talos_json': True, 11:12:36 INFO - 'verify': 'False', 11:12:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:12:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:12:36 INFO - 'work_dir': 'build'} 11:12:36 INFO - [mozharness: 2017-08-28 18:12:36.525524Z] Running clobber step. 11:12:36 INFO - Running pre-action listener: _resource_record_pre_action 11:12:36 INFO - Running main action method: clobber 11:12:36 INFO - rmtree: /builds/slave/test/build 11:12:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:12:37 INFO - Running post-action listener: _resource_record_post_action 11:12:37 INFO - [mozharness: 2017-08-28 18:12:37.614400Z] Finished clobber step (success) 11:12:37 INFO - [mozharness: 2017-08-28 18:12:37.614498Z] Running read-buildbot-config step. 11:12:37 INFO - Running pre-action listener: _resource_record_pre_action 11:12:37 INFO - Running main action method: read_buildbot_config 11:12:37 INFO - Using buildbot properties: 11:12:37 INFO - { 11:12:37 INFO - "project": "", 11:12:37 INFO - "product": "firefox", 11:12:37 INFO - "who": "ffxbld@noreply.mozilla.org", 11:12:37 INFO - "installer_path": "public/build/target.tar.bz2", 11:12:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:12:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:12:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:12:37 INFO - "stage_platform": "linux64-stylosequential", 11:12:37 INFO - "basedir": "/builds/slave/test", 11:12:37 INFO - "buildnumber": 175, 11:12:37 INFO - "platform": "ubuntu64_hw_styloseq", 11:12:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:12:37 INFO - "slavebuilddir": "test", 11:12:37 INFO - "taskId": "A30Lix17Ri6I6HwdjJ0bEg", 11:12:37 INFO - "branch": "mozilla-central", 11:12:37 INFO - "script_repo_revision": "production", 11:12:37 INFO - "revision": "3529b653ede26f990eb7320649015294ad0f8e76", 11:12:37 INFO - "slavename": "talos-linux64-ix-082", 11:12:37 INFO - "repo_path": "mozilla-central" 11:12:37 INFO - } 11:12:37 INFO - Finding installer, test and symbols from parent task. 11:12:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A30Lix17Ri6I6HwdjJ0bEg'}, attempt #1 11:12:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A30Lix17Ri6I6HwdjJ0bEg'}, attempt #1 11:12:38 INFO - Task dependencies: RmbeUV6sREG6fr33Z_wCNQ 11:12:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ'}, attempt #1 11:12:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 11:12:39 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.test_packages.json 11:12:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.crashreporter-symbols.zip 11:12:39 INFO - Running post-action listener: _resource_record_post_action 11:12:39 INFO - [mozharness: 2017-08-28 18:12:39.080773Z] Finished read-buildbot-config step (success) 11:12:39 INFO - [mozharness: 2017-08-28 18:12:39.080990Z] Running download-and-extract step. 11:12:39 INFO - Running pre-action listener: _resource_record_pre_action 11:12:39 INFO - Running main action method: download_and_extract 11:12:39 INFO - mkdir: /builds/slave/test/build/tests 11:12:39 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')]} 11:12:39 INFO - trying https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.test_packages.json 11:12:39 INFO - Downloading https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:12:39 INFO - Downloaded 989 bytes. 11:12:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:12:39 INFO - Using the following test package requirements: 11:12:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:12:39 INFO - u'common': [u'target.common.tests.zip'], 11:12:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:12:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:12:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:12:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:12:39 INFO - u'mozbase': [u'target.common.tests.zip'], 11:12:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:12:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:12:39 INFO - u'web-platform': [u'target.common.tests.zip', 11:12:39 INFO - u'target.web-platform.tests.tar.gz'], 11:12:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:12:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:12:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip 11:12:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:12:39 INFO - Fetch https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip into memory 11:12:40 INFO - Content-Length response header: 54977948 11:12:40 INFO - Bytes received: 54977948 11:12:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip 11:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.common.tests.zip into memory 11:12:52 INFO - Content-Length response header: 54977948 11:12:52 INFO - Bytes received: 54977948 11:13:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.talos.tests.zip 11:13:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:13:05 INFO - Fetch https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.talos.tests.zip into memory 11:13:06 INFO - Content-Length response header: 14496611 11:13:06 INFO - Bytes received: 14496611 11:13:06 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')]} 11:13:06 INFO - trying https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 11:13:06 INFO - Downloading https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:13:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:13:07 INFO - Downloaded 61154343 bytes. 11:13:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 11:13:07 INFO - mkdir: /builds/slave/test/properties 11:13:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:13:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:13:07 INFO - Contents: 11:13:07 INFO - build_url:https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 11:13:07 INFO - Running post-action listener: _resource_record_post_action 11:13:07 INFO - Running post-action listener: find_tests_for_verification 11:13:07 INFO - Running post-action listener: set_extra_try_arguments 11:13:07 INFO - [mozharness: 2017-08-28 18:13:07.887484Z] Finished download-and-extract step (success) 11:13:07 INFO - [mozharness: 2017-08-28 18:13:07.887620Z] Running populate-webroot step. 11:13:07 INFO - Running pre-action listener: _resource_record_pre_action 11:13:07 INFO - Running main action method: populate_webroot 11:13:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:13:07 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:13:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:13:07 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:13:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:07 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:13:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'tests': ['damp', 'tps']}, 11:13:07 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['damp', 'tps']}, 11:13:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:13:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:13:07 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:13:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:13:07 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:13:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_many_windows', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['a11yr', 11:13:07 INFO - 'ts_paint', 11:13:07 INFO - 'tpaint', 11:13:07 INFO - 'sessionrestore', 11:13:07 INFO - 'sessionrestore_many_windows', 11:13:07 INFO - 'sessionrestore_no_auto_restore', 11:13:07 INFO - 'tabpaint']}, 11:13:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:13:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:13:07 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['bloom_basic_singleton']}, 11:13:07 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['bloom_basic']}, 11:13:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:13:07 INFO - 'tsvgr_opacity', 11:13:07 INFO - 'tart', 11:13:07 INFO - 'tscrollx', 11:13:07 INFO - 'tsvg_static']}, 11:13:07 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['tsvgx', 11:13:07 INFO - 'tsvgr_opacity', 11:13:07 INFO - 'tart', 11:13:07 INFO - 'tscrollx', 11:13:07 INFO - 'tsvg_static']}, 11:13:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:13:07 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--stylo'], 11:13:07 INFO - 'tests': ['tp5o']}, 11:13:07 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:07 INFO - 'talos_options': ['--mitmproxy', 11:13:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:07 INFO - '--firstNonBlankPaint'], 11:13:07 INFO - 'tests': ['tp6_google', 11:13:07 INFO - 'tp6_youtube', 11:13:07 INFO - 'tp6_amazon', 11:13:07 INFO - 'tp6_facebook']}, 11:13:07 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:07 INFO - 'talos_options': ['--stylo', 11:13:07 INFO - '--mitmproxy', 11:13:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:07 INFO - '--firstNonBlankPaint'], 11:13:07 INFO - 'tests': ['tp6_google', 11:13:07 INFO - 'tp6_youtube', 11:13:07 INFO - 'tp6_amazon', 11:13:07 INFO - 'tp6_facebook']}, 11:13:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:13:07 INFO - 'talos_options': ['--stylo', 11:13:07 INFO - '--stylo-threads=1', 11:13:07 INFO - '--mitmproxy', 11:13:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:13:07 INFO - '--firstNonBlankPaint'], 11:13:07 INFO - 'tests': ['tp6_google', 11:13:07 INFO - 'tp6_youtube', 11:13:07 INFO - 'tp6_amazon', 11:13:07 INFO - 'tp6_facebook']}, 11:13:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--xperf_path', 11:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:07 INFO - 'tests': ['tp5n']}, 11:13:07 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:13:07 INFO - 'talos_options': ['--stylo', 11:13:07 INFO - '--xperf_path', 11:13:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:13:07 INFO - 'tests': ['tp5n']}}} 11:13:07 INFO - Running post-action listener: _resource_record_post_action 11:13:07 INFO - [mozharness: 2017-08-28 18:13:07.904027Z] Finished populate-webroot step (success) 11:13:07 INFO - [mozharness: 2017-08-28 18:13:07.904117Z] Running create-virtualenv step. 11:13:07 INFO - Running pre-action listener: _resource_record_pre_action 11:13:07 INFO - Running main action method: create_virtualenv 11:13:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:13:07 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:13:07 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:13:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:13:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:13:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:13:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:13:08 INFO - Installing pip...............done. 11:13:08 INFO - Return code: 0 11:13:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:13:08 INFO - Reading from file tmpfile_stdout 11:13:08 INFO - Output received: 11:13:08 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:13:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:13:08 INFO - Using env: {'DISPLAY': ':0', 11:13:08 INFO - 'HOME': '/home/cltbld', 11:13:08 INFO - 'LANG': 'en_US.UTF-8', 11:13:08 INFO - 'LANGUAGE': 'en_US:en', 11:13:08 INFO - 'LOGNAME': 'cltbld', 11:13:08 INFO - 'MAIL': '/var/mail/cltbld', 11:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:08 INFO - 'MOZ_NO_REMOTE': '1', 11:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:08 INFO - 'NO_EM_RESTART': '1', 11:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:08 INFO - 'PWD': '/builds/slave/test', 11:13:08 INFO - 'SHELL': '/bin/bash', 11:13:08 INFO - 'SHLVL': '1', 11:13:08 INFO - 'TERM': 'linux', 11:13:08 INFO - 'TMOUT': '86400', 11:13:08 INFO - 'USER': 'cltbld', 11:13:08 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:08 INFO - '_': '/tools/buildbot/bin/python'} 11:13:10 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:13:10 INFO - Downloading/unpacking pip>=1.5 11:13:10 INFO - Running setup.py egg_info for package pip 11:13:10 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:10 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:10 INFO - Installing collected packages: pip 11:13:10 INFO - Found existing installation: pip 1.1 11:13:10 INFO - Uninstalling pip: 11:13:10 INFO - Successfully uninstalled pip 11:13:10 INFO - Running setup.py install for pip 11:13:10 INFO - warning: no files found matching 'pip/cacert.pem' 11:13:10 INFO - warning: no files found matching '*.html' under directory 'docs' 11:13:10 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:13:10 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:13:10 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:13:10 INFO - Successfully installed pip 11:13:10 INFO - Cleaning up... 11:13:10 INFO - Return code: 0 11:13:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:13:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:13:10 INFO - Using env: {'DISPLAY': ':0', 11:13:10 INFO - 'HOME': '/home/cltbld', 11:13:10 INFO - 'LANG': 'en_US.UTF-8', 11:13:10 INFO - 'LANGUAGE': 'en_US:en', 11:13:10 INFO - 'LOGNAME': 'cltbld', 11:13:10 INFO - 'MAIL': '/var/mail/cltbld', 11:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:10 INFO - 'MOZ_NO_REMOTE': '1', 11:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:10 INFO - 'NO_EM_RESTART': '1', 11:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:10 INFO - 'PWD': '/builds/slave/test', 11:13:10 INFO - 'SHELL': '/bin/bash', 11:13:10 INFO - 'SHLVL': '1', 11:13:10 INFO - 'TERM': 'linux', 11:13:10 INFO - 'TMOUT': '86400', 11:13:10 INFO - 'USER': 'cltbld', 11:13:10 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:10 INFO - '_': '/tools/buildbot/bin/python'} 11:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:10 INFO - Downloading/unpacking psutil>=3.1.1 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:11 INFO - Installing collected packages: psutil 11:13:11 INFO - Running setup.py install for psutil 11:13:11 INFO - building 'psutil._psutil_linux' extension 11:13:11 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 11:13:11 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 11:13:11 INFO - building 'psutil._psutil_posix' extension 11:13:11 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 11:13:11 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 11:13:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:13:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:13:12 INFO - Successfully installed psutil 11:13:12 INFO - Cleaning up... 11:13:12 INFO - Return code: 0 11:13:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:13:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:13:12 INFO - Using env: {'DISPLAY': ':0', 11:13:12 INFO - 'HOME': '/home/cltbld', 11:13:12 INFO - 'LANG': 'en_US.UTF-8', 11:13:12 INFO - 'LANGUAGE': 'en_US:en', 11:13:12 INFO - 'LOGNAME': 'cltbld', 11:13:12 INFO - 'MAIL': '/var/mail/cltbld', 11:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:12 INFO - 'MOZ_NO_REMOTE': '1', 11:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:12 INFO - 'NO_EM_RESTART': '1', 11:13:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:12 INFO - 'PWD': '/builds/slave/test', 11:13:12 INFO - 'SHELL': '/bin/bash', 11:13:12 INFO - 'SHLVL': '1', 11:13:12 INFO - 'TERM': 'linux', 11:13:12 INFO - 'TMOUT': '86400', 11:13:12 INFO - 'USER': 'cltbld', 11:13:12 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:12 INFO - '_': '/tools/buildbot/bin/python'} 11:13:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:13:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:13:13 INFO - Installing collected packages: mozsystemmonitor 11:13:13 INFO - Running setup.py install for mozsystemmonitor 11:13:13 INFO - Successfully installed mozsystemmonitor 11:13:13 INFO - Cleaning up... 11:13:13 INFO - Return code: 0 11:13:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:13:13 INFO - Using env: {'DISPLAY': ':0', 11:13:13 INFO - 'HOME': '/home/cltbld', 11:13:13 INFO - 'LANG': 'en_US.UTF-8', 11:13:13 INFO - 'LANGUAGE': 'en_US:en', 11:13:13 INFO - 'LOGNAME': 'cltbld', 11:13:13 INFO - 'MAIL': '/var/mail/cltbld', 11:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:13 INFO - 'MOZ_NO_REMOTE': '1', 11:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:13 INFO - 'NO_EM_RESTART': '1', 11:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:13 INFO - 'PWD': '/builds/slave/test', 11:13:13 INFO - 'SHELL': '/bin/bash', 11:13:13 INFO - 'SHLVL': '1', 11:13:13 INFO - 'TERM': 'linux', 11:13:13 INFO - 'TMOUT': '86400', 11:13:13 INFO - 'USER': 'cltbld', 11:13:13 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:13 INFO - '_': '/tools/buildbot/bin/python'} 11:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:13 INFO - Downloading/unpacking jsonschema==2.5.1 11:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:13:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:14 INFO - Downloading functools32-3.2.3-2.tar.gz 11:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:13:15 INFO - warning: no files found matching '*.txt' 11:13:15 INFO - no previously-included directories found matching 'build' 11:13:15 INFO - no previously-included directories found matching 'dist' 11:13:15 INFO - no previously-included directories found matching '.git*' 11:13:15 INFO - Installing collected packages: jsonschema, functools32 11:13:15 INFO - Running setup.py install for functools32 11:13:15 INFO - warning: no files found matching '*.txt' 11:13:15 INFO - no previously-included directories found matching 'build' 11:13:15 INFO - no previously-included directories found matching 'dist' 11:13:15 INFO - no previously-included directories found matching '.git*' 11:13:15 INFO - Successfully installed jsonschema functools32 11:13:15 INFO - Cleaning up... 11:13:15 INFO - Return code: 0 11:13:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:13:15 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')]} 11:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:15 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')]} 11:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:15 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:15 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 11:13:15 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 11:13:15 INFO - Using env: {'DISPLAY': ':0', 11:13:15 INFO - 'HOME': '/home/cltbld', 11:13:15 INFO - 'LANG': 'en_US.UTF-8', 11:13:15 INFO - 'LANGUAGE': 'en_US:en', 11:13:15 INFO - 'LOGNAME': 'cltbld', 11:13:15 INFO - 'MAIL': '/var/mail/cltbld', 11:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:15 INFO - 'MOZ_NO_REMOTE': '1', 11:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:15 INFO - 'NO_EM_RESTART': '1', 11:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:15 INFO - 'PWD': '/builds/slave/test', 11:13:15 INFO - 'SHELL': '/bin/bash', 11:13:15 INFO - 'SHLVL': '1', 11:13:15 INFO - 'TERM': 'linux', 11:13:15 INFO - 'TMOUT': '86400', 11:13:15 INFO - 'USER': 'cltbld', 11:13:15 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:15 INFO - '_': '/tools/buildbot/bin/python'} 11:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:13:15 INFO - Cleaning up... 11:13:15 INFO - Return code: 0 11:13:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:13:15 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')]} 11:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:15 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')]} 11:13:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:15 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:15 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 11:13:15 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 11:13:15 INFO - Using env: {'DISPLAY': ':0', 11:13:15 INFO - 'HOME': '/home/cltbld', 11:13:15 INFO - 'LANG': 'en_US.UTF-8', 11:13:15 INFO - 'LANGUAGE': 'en_US:en', 11:13:15 INFO - 'LOGNAME': 'cltbld', 11:13:15 INFO - 'MAIL': '/var/mail/cltbld', 11:13:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:15 INFO - 'MOZ_NO_REMOTE': '1', 11:13:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:15 INFO - 'NO_EM_RESTART': '1', 11:13:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:15 INFO - 'PWD': '/builds/slave/test', 11:13:15 INFO - 'SHELL': '/bin/bash', 11:13:15 INFO - 'SHLVL': '1', 11:13:15 INFO - 'TERM': 'linux', 11:13:15 INFO - 'TMOUT': '86400', 11:13:15 INFO - 'USER': 'cltbld', 11:13:15 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:15 INFO - '_': '/tools/buildbot/bin/python'} 11:13:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:15 INFO - Downloading/unpacking blobuploader==1.2.4 11:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:16 INFO - Downloading blobuploader-1.2.4.tar.gz 11:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:13:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:13:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:13:17 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 11:13:17 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 11:13:17 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 11:13:17 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 11:13:17 INFO - Downloading docopt-0.6.1.tar.gz 11:13:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:13:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:13:17 INFO - Running setup.py install for blobuploader 11:13:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:13:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:13:17 INFO - Running setup.py install for requests 11:13:17 INFO - Running setup.py install for docopt 11:13:17 INFO - Successfully installed blobuploader requests docopt 11:13:17 INFO - Cleaning up... 11:13:17 INFO - Return code: 0 11:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:17 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:17 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 11:13:17 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 11:13:17 INFO - Using env: {'DISPLAY': ':0', 11:13:17 INFO - 'HOME': '/home/cltbld', 11:13:17 INFO - 'LANG': 'en_US.UTF-8', 11:13:17 INFO - 'LANGUAGE': 'en_US:en', 11:13:17 INFO - 'LOGNAME': 'cltbld', 11:13:17 INFO - 'MAIL': '/var/mail/cltbld', 11:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:17 INFO - 'MOZ_NO_REMOTE': '1', 11:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:17 INFO - 'NO_EM_RESTART': '1', 11:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:17 INFO - 'PWD': '/builds/slave/test', 11:13:17 INFO - 'SHELL': '/bin/bash', 11:13:17 INFO - 'SHLVL': '1', 11:13:17 INFO - 'TERM': 'linux', 11:13:17 INFO - 'TMOUT': '86400', 11:13:17 INFO - 'USER': 'cltbld', 11:13:17 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:17 INFO - '_': '/tools/buildbot/bin/python'} 11:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:18 INFO - Running setup.py (path:/tmp/pip-lWMY6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:18 INFO - Running setup.py (path:/tmp/pip-PaZ5im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:18 INFO - Running setup.py (path:/tmp/pip-_FDixf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:18 INFO - Running setup.py (path:/tmp/pip-WGzbKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:18 INFO - Running setup.py (path:/tmp/pip-pG2AVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:18 INFO - Running setup.py (path:/tmp/pip-cAaC7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:18 INFO - Running setup.py (path:/tmp/pip-7y78Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:18 INFO - Running setup.py (path:/tmp/pip-jFI03Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:18 INFO - Running setup.py (path:/tmp/pip-70qhr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:18 INFO - Running setup.py (path:/tmp/pip-JfiXD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:18 INFO - Running setup.py (path:/tmp/pip-wzSlkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:18 INFO - Running setup.py (path:/tmp/pip-KLE6qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:18 INFO - Running setup.py (path:/tmp/pip-WSGrKm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:19 INFO - Running setup.py (path:/tmp/pip-Oqa9hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:19 INFO - Running setup.py (path:/tmp/pip-f1o8hQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:19 INFO - Running setup.py (path:/tmp/pip-H4aOPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:19 INFO - Running setup.py (path:/tmp/pip-QsxDxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:13:19 INFO - Running setup.py install for manifestparser 11:13:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:13:19 INFO - Running setup.py install for mozcrash 11:13:19 INFO - Running setup.py install for mozdebug 11:13:19 INFO - Running setup.py install for mozdevice 11:13:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:13:19 INFO - Running setup.py install for mozfile 11:13:19 INFO - Running setup.py install for mozhttpd 11:13:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:13:19 INFO - Running setup.py install for mozinfo 11:13:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:13:19 INFO - Running setup.py install for mozInstall 11:13:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Running setup.py install for mozleak 11:13:20 INFO - Running setup.py install for mozlog 11:13:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Running setup.py install for moznetwork 11:13:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Running setup.py install for mozprocess 11:13:20 INFO - Running setup.py install for mozprofile 11:13:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Running setup.py install for mozrunner 11:13:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:13:20 INFO - Running setup.py install for mozscreenshot 11:13:20 INFO - Running setup.py install for moztest 11:13:20 INFO - Running setup.py install for mozversion 11:13:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:13:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:13:21 INFO - Cleaning up... 11:13:21 INFO - Return code: 0 11:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:21 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')]} 11:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:21 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')]} 11:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:21 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:21 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 11:13:21 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 11:13:21 INFO - Using env: {'DISPLAY': ':0', 11:13:21 INFO - 'HOME': '/home/cltbld', 11:13:21 INFO - 'LANG': 'en_US.UTF-8', 11:13:21 INFO - 'LANGUAGE': 'en_US:en', 11:13:21 INFO - 'LOGNAME': 'cltbld', 11:13:21 INFO - 'MAIL': '/var/mail/cltbld', 11:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:21 INFO - 'MOZ_NO_REMOTE': '1', 11:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:21 INFO - 'NO_EM_RESTART': '1', 11:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:21 INFO - 'PWD': '/builds/slave/test', 11:13:21 INFO - 'SHELL': '/bin/bash', 11:13:21 INFO - 'SHLVL': '1', 11:13:21 INFO - 'TERM': 'linux', 11:13:21 INFO - 'TMOUT': '86400', 11:13:21 INFO - 'USER': 'cltbld', 11:13:21 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:21 INFO - '_': '/tools/buildbot/bin/python'} 11:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:13:21 INFO - Running setup.py (path:/tmp/pip-m5GJoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:13:21 INFO - Running setup.py (path:/tmp/pip-qXp_6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:13:21 INFO - Running setup.py (path:/tmp/pip-Cpjqyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:13:21 INFO - Running setup.py (path:/tmp/pip-0agnxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:13:21 INFO - Running setup.py (path:/tmp/pip-1nbLGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:13:21 INFO - Running setup.py (path:/tmp/pip-AzljQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:13:21 INFO - Running setup.py (path:/tmp/pip-6E_17U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:13:21 INFO - Running setup.py (path:/tmp/pip-kG049e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:13:21 INFO - Running setup.py (path:/tmp/pip-x02O_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:13:21 INFO - Running setup.py (path:/tmp/pip-x3OXE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:13:21 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)) 11:13:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:13:21 INFO - Running setup.py (path:/tmp/pip-HW485Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:13:22 INFO - Running setup.py (path:/tmp/pip-ppf8pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:13:22 INFO - Running setup.py (path:/tmp/pip-Tx7bDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:13:22 INFO - Running setup.py (path:/tmp/pip-JkSNmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:22 INFO - Running setup.py (path:/tmp/pip-IWQtpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:13:22 INFO - Running setup.py (path:/tmp/pip-My1Y6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:13:22 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)) 11:13:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:13:22 INFO - Running setup.py (path:/tmp/pip-RZmPcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:13:22 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)) 11:13:22 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)) 11:13:22 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)) 11:13:22 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)) 11:13:22 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)) 11:13:22 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)) 11:13:22 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)) 11:13:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:13:23 INFO - Downloading blessings-1.6.tar.gz 11:13:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:13:23 INFO - Installing collected packages: blessings 11:13:23 INFO - Running setup.py install for blessings 11:13:23 INFO - Successfully installed blessings 11:13:23 INFO - Cleaning up... 11:13:23 INFO - Return code: 0 11:13:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:24 INFO - Reading from file tmpfile_stdout 11:13:24 INFO - Current package versions: 11:13:24 INFO - argparse == 1.2.1 11:13:24 INFO - blessings == 1.6 11:13:24 INFO - blobuploader == 1.2.4 11:13:24 INFO - docopt == 0.6.1 11:13:24 INFO - functools32 == 3.2.3-2 11:13:24 INFO - jsonschema == 2.5.1 11:13:24 INFO - manifestparser == 1.1 11:13:24 INFO - mozInstall == 1.13 11:13:24 INFO - mozcrash == 1.0 11:13:24 INFO - mozdebug == 0.1 11:13:24 INFO - mozdevice == 0.51 11:13:24 INFO - mozfile == 1.2 11:13:24 INFO - mozhttpd == 0.7 11:13:24 INFO - mozinfo == 0.10 11:13:24 INFO - mozleak == 0.1 11:13:24 INFO - mozlog == 3.5 11:13:24 INFO - moznetwork == 0.27 11:13:24 INFO - mozprocess == 0.25 11:13:24 INFO - mozprofile == 0.28 11:13:24 INFO - mozrunner == 6.13 11:13:24 INFO - mozscreenshot == 0.1 11:13:24 INFO - mozsystemmonitor == 0.3 11:13:24 INFO - moztest == 0.8 11:13:24 INFO - mozversion == 1.4 11:13:24 INFO - psutil == 3.1.1 11:13:24 INFO - requests == 1.2.3 11:13:24 INFO - wsgiref == 0.1.2 11:13:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:13:24 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')]} 11:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13:24 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')]} 11:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:24 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:24 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 11:13:24 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 11:13:24 INFO - Using env: {'DISPLAY': ':0', 11:13:24 INFO - 'HOME': '/home/cltbld', 11:13:24 INFO - 'LANG': 'en_US.UTF-8', 11:13:24 INFO - 'LANGUAGE': 'en_US:en', 11:13:24 INFO - 'LOGNAME': 'cltbld', 11:13:24 INFO - 'MAIL': '/var/mail/cltbld', 11:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:24 INFO - 'MOZ_NO_REMOTE': '1', 11:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:24 INFO - 'NO_EM_RESTART': '1', 11:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:24 INFO - 'PWD': '/builds/slave/test', 11:13:24 INFO - 'SHELL': '/bin/bash', 11:13:24 INFO - 'SHLVL': '1', 11:13:24 INFO - 'TERM': 'linux', 11:13:24 INFO - 'TMOUT': '86400', 11:13:24 INFO - 'USER': 'cltbld', 11:13:24 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:24 INFO - '_': '/tools/buildbot/bin/python'} 11:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 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)) 11:13:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:13:24 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 11:13:24 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 11:13:24 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 11:13:24 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 11:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:13:25 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)) 11:13:25 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)) 11:13:25 INFO - Installing collected packages: simplejson 11:13:25 INFO - Running setup.py install for simplejson 11:13:25 INFO - building 'simplejson._speedups' extension 11:13:25 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 11:13:26 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 11:13:26 INFO - Successfully installed simplejson 11:13:26 INFO - Cleaning up... 11:13:26 INFO - Return code: 0 11:13:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:13: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')]} 11:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:13: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')]} 11:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:13:26 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 0x137a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1545a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16e8f90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, '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': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', '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 11:13:26 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 11:13:26 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 11:13:26 INFO - Using env: {'DISPLAY': ':0', 11:13:26 INFO - 'HOME': '/home/cltbld', 11:13:26 INFO - 'LANG': 'en_US.UTF-8', 11:13:26 INFO - 'LANGUAGE': 'en_US:en', 11:13:26 INFO - 'LOGNAME': 'cltbld', 11:13:26 INFO - 'MAIL': '/var/mail/cltbld', 11:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:26 INFO - 'MOZ_NO_REMOTE': '1', 11:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:26 INFO - 'NO_EM_RESTART': '1', 11:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:26 INFO - 'PWD': '/builds/slave/test', 11:13:26 INFO - 'SHELL': '/bin/bash', 11:13:26 INFO - 'SHLVL': '1', 11:13:26 INFO - 'TERM': 'linux', 11:13:26 INFO - 'TMOUT': '86400', 11:13:26 INFO - 'USER': 'cltbld', 11:13:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:26 INFO - '_': '/tools/buildbot/bin/python'} 11:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:13:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:13:26 INFO - Cleaning up... 11:13:26 INFO - Return code: 0 11:13:26 INFO - Running post-action listener: _resource_record_post_action 11:13:26 INFO - Running post-action listener: _start_resource_monitoring 11:13:26 INFO - Starting resource monitoring. 11:13:26 INFO - [mozharness: 2017-08-28 18:13:26.732631Z] Finished create-virtualenv step (success) 11:13:26 INFO - [mozharness: 2017-08-28 18:13:26.733151Z] Running install step. 11:13:26 INFO - Running pre-action listener: _resource_record_pre_action 11:13:26 INFO - Running main action method: install 11:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:13:26 INFO - Reading from file tmpfile_stdout 11:13:26 INFO - Detecting whether we're running mozinstall >=1.0... 11:13:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:13:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:13:27 INFO - Reading from file tmpfile_stdout 11:13:27 INFO - Output received: 11:13:27 INFO - Usage: mozinstall [options] installer 11:13:27 INFO - Options: 11:13:27 INFO - -h, --help show this help message and exit 11:13:27 INFO - -d DEST, --destination=DEST 11:13:27 INFO - Directory to install application into. [default: 11:13:27 INFO - "/builds/slave/test"] 11:13:27 INFO - --app=APP Application being installed. [default: firefox] 11:13:27 INFO - mkdir: /builds/slave/test/build/application 11:13:27 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'] 11:13:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:13:44 INFO - Reading from file tmpfile_stdout 11:13:44 INFO - Output received: 11:13:44 INFO - /builds/slave/test/build/application/firefox/firefox 11:13:44 INFO - Running post-action listener: _resource_record_post_action 11:13:44 INFO - [mozharness: 2017-08-28 18:13:44.780970Z] Finished install step (success) 11:13:44 INFO - [mozharness: 2017-08-28 18:13:44.781219Z] Running setup-mitmproxy step. 11:13:44 INFO - Running pre-action listener: _resource_record_pre_action 11:13:44 INFO - Running main action method: setup_mitmproxy 11:13:44 INFO - Skipping: mitmproxy is not required 11:13:44 INFO - Running post-action listener: _resource_record_post_action 11:13:44 INFO - [mozharness: 2017-08-28 18:13:44.782344Z] Finished setup-mitmproxy step (success) 11:13:44 INFO - [mozharness: 2017-08-28 18:13:44.782562Z] Running run-tests step. 11:13:44 INFO - Running pre-action listener: _resource_record_pre_action 11:13:44 INFO - Running pre-action listener: _set_gcov_prefix 11:13:44 INFO - Running main action method: run_tests 11:13:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:13:44 INFO - Python 2.7.3 11:13:44 INFO - Return code: 0 11:13:44 INFO - grabbing minidump binary from tooltool 11:13: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')]} 11:13:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x16e6130>, '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 0x16e7030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16e74c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:13:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:13:44 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:13:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 11:13:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:13:44 INFO - Return code: 0 11:13:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:13:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:13:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:13:44 INFO - ENV: RUST_BACKTRACE is now full 11:13:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:13:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:13:44 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/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 11:13:44 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/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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 11:13:44 INFO - Using env: {'DISPLAY': ':0', 11:13:44 INFO - 'HOME': '/home/cltbld', 11:13:44 INFO - 'LANG': 'en_US.UTF-8', 11:13:44 INFO - 'LANGUAGE': 'en_US:en', 11:13:44 INFO - 'LOGNAME': 'cltbld', 11:13:44 INFO - 'MAIL': '/var/mail/cltbld', 11:13:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:44 INFO - 'MOZ_NO_REMOTE': '1', 11:13:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:44 INFO - 'NO_EM_RESTART': '1', 11:13:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:44 INFO - 'PWD': '/builds/slave/test', 11:13:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:44 INFO - 'RUST_BACKTRACE': 'full', 11:13:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:44 INFO - 'SHELL': '/bin/bash', 11:13:44 INFO - 'SHLVL': '1', 11:13:44 INFO - 'STYLO_FORCE_ENABLED': '1', 11:13:44 INFO - 'TERM': 'linux', 11:13:44 INFO - 'TMOUT': '86400', 11:13:44 INFO - 'USER': 'cltbld', 11:13:44 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:44 INFO - '_': '/tools/buildbot/bin/python'} 11:13:44 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/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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 11:13:45 INFO - mozversion application_buildid: 20170828172502 11:13:45 INFO - mozversion application_changeset: 3529b653ede26f990eb7320649015294ad0f8e76 11:13:45 INFO - mozversion application_display_name: Nightly 11:13:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:13:45 INFO - mozversion application_name: Firefox 11:13:45 INFO - mozversion application_remotingname: firefox 11:13:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:13:45 INFO - mozversion application_vendor: Mozilla 11:13:45 INFO - mozversion application_version: 57.0a1 11:13:45 INFO - mozversion platform_buildid: 20170828172502 11:13:45 INFO - mozversion platform_changeset: 3529b653ede26f990eb7320649015294ad0f8e76 11:13:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:13:45 INFO - mozversion platform_version: 57.0a1 11:13:45 INFO - using testdate: 1503944025 11:13:45 INFO - actual date: 1503944025 11:13:45 INFO - starting webserver on 'localhost:43173' 11:13:45 INFO - SUITE-START | Running 2 tests 11:13:45 INFO - TEST-START | dromaeo_css 11:13:45 INFO - Initialising browser for dromaeo_css test... 11:13:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43173/getInfo.html -profile /tmp/tmpKYVcFU/profile 11:13:45 INFO - TEST-INFO | started process 7206 (/builds/slave/test/build/application/firefox/firefox http://localhost:43173/getInfo.html) 11:13:50 INFO - TEST-INFO | 7206: exit 0 11:13:50 INFO - Browser initialized. 11:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 11:13:50 INFO - Using env: {'DISPLAY': ':0', 11:13:50 INFO - 'HOME': '/home/cltbld', 11:13:50 INFO - 'JSGC_DISABLE_POISONING': '1', 11:13:50 INFO - 'LANG': 'en_US.UTF-8', 11:13:50 INFO - 'LANGUAGE': 'en_US:en', 11:13:50 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:13:50 INFO - 'LOGNAME': 'cltbld', 11:13:50 INFO - 'MAIL': '/var/mail/cltbld', 11:13:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:13:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:13:50 INFO - 'MOZ_CRASHREPORTER': '1', 11:13:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:13:50 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:13:50 INFO - 'MOZ_NO_REMOTE': '1', 11:13:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:13:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:13:50 INFO - 'NO_EM_RESTART': '1', 11:13:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:13:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:13:50 INFO - 'PWD': '/builds/slave/test', 11:13:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:13:50 INFO - 'RUST_BACKTRACE': 'full', 11:13:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:13:50 INFO - 'SHELL': '/bin/bash', 11:13:50 INFO - 'SHLVL': '1', 11:13:50 INFO - 'STYLO_FORCE_ENABLED': '1', 11:13:50 INFO - 'TERM': 'linux', 11:13:50 INFO - 'TMOUT': '86400', 11:13:50 INFO - 'USER': 'cltbld', 11:13:50 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:13:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:13:50 INFO - '_': '/tools/buildbot/bin/python'} 11:13:50 INFO - TEST-INFO | started process 7388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKYVcFU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:13:51 INFO - PID 7388 | 11:13:51 INFO - PID 7388 | (/builds/slave/test/build/application/firefox/firefox:7437): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:13:51 INFO - PID 7388 | 11:14:01 INFO - PID 7388 | RSS: Main: 175538176 11:14:01 INFO - PID 7388 | 11:17:00 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43173/tests/dromaeo/cssquery-ext.html) 11:17:01 INFO - PID 7388 | RSS: Main: 178024448 11:17:01 INFO - PID 7388 | 11:20:03 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-ext.html (next: http://localhost:43173/tests/dromaeo/cssquery-jquery.html) 11:20:04 INFO - PID 7388 | RSS: Main: 173924352 11:20:04 INFO - PID 7388 | 11:23:06 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43173/tests/dromaeo/cssquery-mootools.html) 11:23:06 INFO - PID 7388 | RSS: Main: 176590848 11:23:06 INFO - PID 7388 | 11:26:08 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43173/tests/dromaeo/cssquery-prototype.html) 11:26:09 INFO - PID 7388 | RSS: Main: 175362048 11:26:09 INFO - PID 7388 | 11:29:12 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43173/tests/dromaeo/cssquery-yui.html) 11:29:13 INFO - PID 7388 | RSS: Main: 176377856 11:29:13 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | Cycle 1(1): loaded http://localhost:43173/tests/dromaeo/cssquery-yui.html (next: http://localhost:43173/tests/dromaeo/cssquery-dojo.html) 11:32:15 INFO - PID 7388 | RSS: Main: 177532928 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | __start_tp_report 11:32:15 INFO - PID 7388 | _x_x_mozilla_page_load 11:32:15 INFO - PID 7388 | _x_x_mozilla_page_load_details 11:32:15 INFO - PID 7388 | |i|pagename|runs| 11:32:15 INFO - PID 7388 | |0;dojo.html;3328.9167770805725;3350.5476760637307;3356.563646725925;3388.373150967073;3395.117269509928;6267.498600111991;6319.77880774173;6333.936660633392;6370.4903607711385;6446.548741588091;6187.35032821554;6310.652914089723;6317.620942743439;6334;6345.206849143857;5773.336066352371;5785.479306862381;5789.2763404574425;5791.507721843648;5819.883602327951;5826.388229235933;5829.154772557977;5838.795642152526;5858.41415858415;5889.293284805808;5859.238299021121;5875.1187321901625;5876.647401155944;5909.852253693671;5964.761409543613;5658.405867383948;5736.741846616912;5763.452472015152;5768.509676677488;5821.243238379005;5570.832875013756;5685.147227915804;5752.654840709529;5756.971215143939;5807.709614519299;6252.155958945529;6317.905231421532;6349.301576826545;6418.614883107029;6451.83870403239;6825.590464572141;6832.009358642969;6893.172819261721;6917.619530925797;6937.202221744514;6748;6768.187817461887;6845.794626161223;6874.725010999554;6919.550229235134;6390.13733146024;6413.070104834773;6423.7430502779835;6457.1605691260775;6461.289258181596;7038.472114591426;7044.401225895754;7059.682314295869;7131.358177764027;7144;6524.184476940382;6597.977313516412;6715.3620406061345;6736.326367363323;6829.965850170717;6708.463322934153;6788.76239331621;6831.180258369028;6855.211650660138;6875.209350924608;6697.464202863856;6839.384455399038;6868.484863635247;6879.931200687929;6895.931130674753;6821.113255276782;6824.21521525021;6836.418904393182;6910.723571057101;6935.306469353125;5329.333833270841;5374.167004114369;5382.973085134628;5441.347038355423;5462.317210348707;4774.259989701602;4833.4441539223435;4846.75766211688;4869.63477739171;4876.536729010738;5822.417758224228;5903.321118071391;5904.173415721716;5946.405359464019;6046.304674962347;6754.729810807513;6811.863762724718;6821.795346139624;6830.35111664401;6914.51598388108;5941.881162376728;5965.28416590012;5968.313643930916;6002.519798416116;6006.339302676702;5897.67562784051;5900.527957763368;5969.31352894414;5989.670568118708;5991.730372133177;6657.667116644052;6657.833554161185;6732.966335168293;6739.393454589111;6758.695858686371;6619.172603424572;6660.333966603301;6700.597964122168;6742.359475849787;6769.458443324621;6631.469482441489;6639.4688424924925;6655.134832471747;6662.233843108104;6667.933320666925;6675.732970681119;6701.262861085374;6718.966405167943;6792.049113124068;6802.285759995327;6719;6731.697073631796;6817.216020157547;6866.759663411756;6954.930450695429;6556.606603603799;6559.0817285579105;6559.27847936717;6561.245456772342;6691.631960242234;6611.537192396486;6612.074309596756;6684.398404143651;6703.195616526048;6709.496787740842;6481.4166724994975;6528.412442880163;6581.868362632817;6600.570962887589;6627.204735431779;6519.706613202323;6608.801735947929;6637.535372523877;6649.900251496329;6665.566738162004;6531.542792004514;6537.477001839937;6541.672916354068;6549.541532092708;6556.18047744032 11:32:15 INFO - PID 7388 | |1;ext.html;745.3925051083366;823.8064054947087;848.2365870716357;1046.9790604187917;1065.275612583443;27287.590686139698;27710.861445692768;27747;36110.63889361105;36874.26251474969;36490.452643210374;36819.263614727686;36838.81580592093;36890;36909.81545092271;7015.684294206748;7495.287947644965;7528.322450979411;7533.359664428516;7674.424418168632;7401.629918504053;7509.6620652070515;7511.436642251826;7512.887306690404;7518.360939320164;7488.288612581823;7524.849503009937;7536.811579710524;7541.472096953188;7570.772876813677;7481.551106933602;7511.849763004737;7515.924840751604;7572.318491335751;7577.772666820004;7485.363744081759;7509.399248060196;7520;7525.924740752577;7549.924500755032;33327.33345333104;33450.163745906306;33455;33520.329593407994;33649.83175084109;3264.281857991238;3286.359159963808;3287.1453422110185;3287.901362959115;3299.158714527804;29008.709912900813;29032.564511532342;29056.564151537743;29096;29098;4856.61147108234;5047.167217409123;5089.51649593288;5109.105906466353;5113.130767769489;189048.1095189044;189431;189807;191683;191857;41511.37732934008;41773.79113104415;42559.787201063795;42988.570114298454;43030.78484607557;44210.33684494735;44248.77875610666;44383.77808110939;44583;44757.55242447599;13740.381682824296;13855.23796191199;13913.30433478322;13962.930185349009;13986.790198147037;9690.12788849007;9814.411135331902;11302.491387887565;11390.37352945596;11416.657500275005;12992.285424301754;13073.738525229632;13076.215427074216;13110.934445327903;13117;5313.908290616204;5334.946650533522;5391.649542779707;5407.486288802557;5434.157705555645;889.5463313709926;920.1524312990847;937.8499440089689;941.2752180820867;945.413843417072;20793;21047.263345782823;21146.471338216666;21681.241156559445;21879.890600546896;1009.2632378363835;1013.2957594471771;1019.2559431614962;1025.3284098915221;1030.8659874216303;11302;11312;11580.131490138105;14106.647333816736;15115.31981060855;244488;246127;246393;248560;248777;48246.27630585544;48440;48528.7573562137;48554;48591;1264.2793607643555;1303.2897071096274;1303.48512337628;1307.7646023715631;1307.901907356952;24772.50454990854;24956.50086998286;24957.87521062383;25247.87376063108;25381;33249.50125748164;33402;33422.498662519596;33436.33127337488;33457.66542334643;214077;214953;215111;215474;215768;30357.848210758806;30708.692913070583;31139.37721245608;32547.34905301928;32551.674483254865;38790;39519.407208892466;39588.40617390799;39739.60260397359;40159.3976090353;29511.704882950897;29842.403151937273;30773.8461307701;30956.53565196569;30975.225619359695;29818;30006.69993300039;30150;30237.848810755804;30537.847310763304;33927.66072339245;33981.15047123842;34024.48963265504;34030.65969340275;34214.486782698776;29186.854065729534;29481.557776633796;29795.702042979294;29918;30272.84863575668;20796.58406831885;21100.683489747975;21223.893880531115;21334.679979800625;21598.8920055405 11:32:15 INFO - PID 7388 | |2;jquery.html;529.4943329120688;533.8558589180924;538.3136500961276;547.1956224350206;549.9815676467365;20171.29400470984;20595.588088238226;20655.380338589865;20822.16711331549;20840.270590529333;21758.238461653844;22274.77725222747;22520.43698907524;22535.661965070536;22547.661785073196;6495.545311828174;6645.202575690924;6656.934890417534;6659.766908158215;6665.033570132328;5932.228810254661;6197.163382943312;6482.611043337415;6492.7402903883785;6506.934930650704;6430.614163150202;6439;6440.581362211465;6445.226572811269;6474.514411419163;6429.517786166056;6437.742490300382;6468.514861385392;6480.675966201718;6481.870362592769;5962.552808539377;5978.790742323998;5994.610350327215;5998.580099393044;6003.339632640406;26626.201213963614;26696.46607067867;27164.320891977663;27927.30181745452;28002.859985699943;2042.5608494173823;2084.8749075055543;2085.572457646194;2085.9165633374646;2088.853780235384;18361.816381836143;18827.341043063563;19007;19023.61952760937;19039.42881713537;2262.1743063781764;2338.251759436981;2372.857628542293;2379.7263314718857;2387.0451819272257;129377.99999999905;133916;137318.3134084333;138859;139128.30435847858;13806.240656763774;14332.283385830668;14639.341229644691;14679.339429725687;14724.33740481681;21437.78562214358;22164.335069947927;22296.55406891853;22317.776822231895;22386.21648242304;9167.862482062774;9241.861372079424;9312.534373281309;9370.016148304467;9460.290478214023;8418.494890306602;8467.661293548312;8475.194856488746;8488.40581159313;8568.657253709907;8529.658813647384;8602.52686102258;8613.48319100856;8712.390132690778;8921.776955576162;2462.3228612131807;2473.5918573435542;2496.90012399502;2539.8984040638165;2578.458523710042;884.5046773806561;904.5206040798388;915.3318077803241;932.8507438809894;933.7712260496222;18389.88636136689;19156.712649310273;19242.903785481263;19452.513687157934;19591.412257632295;928.661038720862;989.1196834817018;994.472929347447;996.5814357969671;999.1008092716613;9581.712548623553;9798.216142708567;9894.653687121061;9987.60049598008;10195.541200645988;525228;530734;537863;543708;546208;121192;122396;123108;125867;125876;1113.788380207774;1122.646366394583;1147.4090843215752;1148.4544841200363;1149.2644707387278;15906.761398579261;16025.198740063184;16154.11152386583;16257.837421625632;16397.508074757778;50800.23799642934;51922.740386297824;52929.47070529399;55791.721041394536;56271;63079;65647;66576.6671166641;67475;67851;14116.435342586181;14427.278636068364;14488.492902748354;14528.85471145275;14555.345009474811;22196.223132190295;22329.218477353214;22439.887800560893;22643.660345094508;22657.320280391614;17872.642547149244;17904.28382864723;18206.817931821042;18240.361587344378;18261.360852370104;15808.446704365291;15942;16068.919655401649;16364.754528682317;16481.423150190167;17880.55298617545;17953.910230448764;18228;18344.541386465444;18411.447656570323;13820.930895345458;14233.857661423253;14254.643633909236;14355.56933292003;14392.856071439151;17674.116294184983;17742.467725968243;17859.196336164645;18057.638847223243;18099.81900181034 11:32:15 INFO - PID 7388 | |3;mootools.html;1222.2361024359775;1289.8258735070763;1291.3220559206416;1298.532528289815;1302.1666133674444;12275.017998560115;14011.439542418304;14717.116972981601;14720.705585888276;14736.926315368422;12298.877011229884;14231.501897433593;14626.926865365685;14650.194239316834;14657.56027319182;2563.4744877300154;2602.1933200707745;2625.9868700656566;2627.0542604662305;2629.868506574673;2412.6863507744056;2489.639002344659;2490.6762120924345;2609.9086531971384;2714.647095877533;2600.2589262060314;2624.3045592917892;2624.698159711629;2625.12058460416;2625.2780485366484;2590.1193594177976;2600.2329312852753;2608.869556522185;2612.1771641932824;2621.1350254416093;2517.622356646499;2534.88593013313;2545.8599777012255;2546.363409147713;2557.041109583906;14102.083364581373;14377.065490743173;14401.20793356365;14407.639809004753;14415.063020903608;7483.32650061497;7695.653695583712;7711.768646940601;7760.883586746203;7762.883556746653;5079.161938280179;5113.642045056848;5144.897102057937;5266.894662106736;5349.117395629716;1881.9529511762178;1903.3909149072304;1914.7510823592843;1920.308688872005;1932.072605149536;24760.504789904102;25275.62086568703;25449.236522904343;25494.490110197694;25495.107671231417;6263;6361.936380636227;6519.445847103049;6539.149910511603;6555.672216389162;15543.222838858012;15600.14199219031;15659.686806263811;15677.529674109795;15742.606434839221;7376.299251571092;7576.356009739124;7583.203763604853;7584.582847943416;7595.848083038309;6856.6228857412325;7016.193137789118;7025.40284075849;7057.717691292393;7065.43476521877;4840.709557426566;4881;4943.826966056171;4947.158982972904;4962.652614317035;1509.532045066033;1525.2297589717343;1525.8016457860408;1535.6237721758018;1547.8452154784657;769.3037800790294;800.263757343234;811.1766556944706;812.9959649464099;814.6049166154411;6715.294894036154;6768.492363072789;6786.660666966632;6810.557313774688;6875.828104297432;625.7997440818895;643.8969764837603;655.3741177175785;658.9604623722591;690;4607;4748.19280722278;4844.781984810692;4924.926126108111;4995.25071239317;19778.802211977985;20455.18179272842;20728.689069663968;20740.274090407063;20878.37364879056;19659.803401965797;19779.50551236202;20009.599808004048;20400.897995509928;20555.8972205138;9762.219022478184;9943.303968722264;10032.498375081217;10059.34614250086;10076.546555405024;7551.773446796605;7636.31273185416;7663.543003210014;7709.383249339927;7789.61051947389;17417.216225270146;17637.559061023578;17802.198901049742;18095.63808723792;18363.35728249505;18100.45698629043;18157.36449224271;18210.544736381697;18274.36039738656;18288.17703203386;9850.408975461496;10123.443210623487;10163.695089147337;10240.129588985019;10249.33379330341;12478.313692746986;12536.623901282976;12552.937235313764;12585.993120550516;12610.306433145897;9646.855297170689;9661.806763864824;9663.516824158905;9702.272329575451;10106.242031847494;9890.258230632588;9999.55002024896;10003.449810260505;10063.245256605931;10232.59069637206;8604.870926936226;8737.257333126501;8748.212660860552;8748.518831464331;8748.737537873874;6387.361263873576;6401.711922963571;6434.260060093149;6438.29178790342;6489.935100648933;6451.967740161457;6635.734570617315;6636.2368327642935;6660.733570657119;6675.165604299463 11:32:15 INFO - PID 7388 | |4;prototype.html;504.3367971117982;514.934086441067;522.822240438251;535.427093010479;537.3149234725724;6338.429541341273;6366.204224471941;6376.991247756965;6377.33038031007;6469.870602587951;6327.49380049596;6329.683515824214;6349.269833969095;6394.6020242409095;6416.165898433197;5185.144451165553;5216.26972223888;5233.162693968966;5261.473852614727;5281.287026251445;4877.292792545079;5169.870753231162;5209.374875014984;5210.557102646279;5268.367795864501;4986.551210391064;4986.800527978877;5015.348004759376;5021.874453138683;5030.547250747432;4981.1532039553185;5031.1950087986115;5055.241713742949;5057.898842023139;5067.189249720027;4487.506374298824;4503.166914120865;4755.239161734141;4884.487128851455;4928.310036594879;6220.751169953196;6308.139098965816;6334.936650633481;6338.366163383671;6352.047192921099;6022.066579680157;6064.575479716422;6067.544934129958;6080.726367313438;6098.512119030467;6697.59814411132;6733.865322693568;6763.391294783493;6764.289749576273;6806.4554835613035;5340.439253878326;5365.812196573141;5373.09255214401;5374.892502149935;5380.381256155514;6722.9663851680425;6723.428508576777;6780.321967803229;6964.651767411659;7039.69134506781;5460.26286451324;5504.339479262514;5504.779808807602;5540.730968728389;5592.5805564582815;5575.944240557543;5586.972065139648;5616.747246373923;5631.774729010794;5646.774129034792;5956.76172953077;5976.432238937294;6026.6986650667295;6067.271927368744;6128.785492507741;6694.698738556776;6753.966230168818;6799.354061364163;6800.727970881109;6828.829279268058;1948.2693989753843;1964.400857738375;1966.6361723081275;1980.6533856575043;1983.611471969627;1361.6187467509114;1443.5524987253984;1444.104655113836;1449.2319070892445;1452.513408008329;5743.942560574341;5751.194832723422;5774;5808.332041815245;5875.764969401262;6611.206655201407;6640.501962352746;6668.499862510331;6756.391924726799;6756.662166891636;5776;5811.506021988093;5836.854078648068;5867.501262392744;5876.353601103875;3592.443171308399;3603.3333833240936;3627.365211088049;3648.5986541480415;3656.6668497830156;6558.311377305409;6578.736850525926;6642.701078451481;6643.7674681385915;6676.332366763285;6872.312768723188;6879.793606191723;6880.827979300458;7015.298470153046;7021.22766495685;6524.347565243533;6549.115869357575;6565.67171641416;6622.946886465115;6624.370684785034;6743.898841517479;6746.763863264762;6818.113645226089;6822.829429264308;6832.760853370109;6548.8035358939305;6651.301613330531;6653.700583473658;6700.899486507608;6756.358145976124;6579.342065793574;6608.770386952258;6610.3720146586;6643.2360278568585;6667.8997965335175;5542.889142217214;5568.693721845338;5574.442555744393;5583;5586.469285417878;6475.611463312216;6624.966875165594;6721.428678562377;6831.453483721191;6844.760433384808;6379.234491861006;6609.636469994004;6625.569337993015;6627.3372662733345;6632.50256230775;6491.642959637265;6522.15212022434;6530.412262896362;6579.440747536321;6588.275289718032;6487.805365839033;6526.282108968105;6540.215174179129;6591.703373348115;6613.576866969039;6569.507286953593;6578.901316480161;6588.769393071219;6649.808092115908;6682.365175308338;6354.745810167541;6400.775972841115;6437.388448097423;6443.130177425987;6511.641859697762 11:32:15 INFO - PID 7388 | |5;yui.html;783.5298820707573;796.3509739562256;813.1786895235812;814.2874984388657;817.7383237364046;15273.236338183087;15871.206439677999;15882.841171588281;15885.523434296974;17593.3842315519;16135.273912673929;16434.83565164348;16442;16444.753328700048;16468.423605173823;713.0623230451939;766.2796970847413;777.5451360953849;780.336713793274;781.1797612506873;730.7332823519404;786.9173736757643;787.2009909941414;787.6455594982252;787.759733281349;816.848882956652;818.3616778912428;818.5129847740615;819.2381085590398;819.9467034642759;810.4529442626203;810.8094597769519;811.1645005644167;811.5982588618642;812.358236992775;592.0734051209843;592.6947621974687;592.7984485275027;593.8010766393263;594.0999385930319;14940.103593784408;15175.848241517553;15319.923400383039;15320.693586128327;15324.310406031755;17456;18231.45305640833;18235.908820455945;18277.177527011183;18323.083845807658;14311.212883291415;14908;14996.850031499655;15036.699266014728;15044.924775376163;3608.765430247052;3644.5444319460066;3648.416253399443;3650.7444478886487;3650.9269814603826;123959.76040239572;125218.37390813079;126105.36947315297;126909;127115.36442317729;14136.85863141376;14191.290435478184;14838.70322593542;14845.183514906785;14858.851411485746;25407.87296063508;26391.944322226896;26520.60219096715;26709.19872403831;26936.59595106075;7849.803754906173;8034.718784842619;8037.31682806968;8041.597920103972;8048.114707382183;3994.8601798936897;4077.2660921033907;4101.815418306183;4109.198706252312;4121.361189015707;4712.717236965793;4826.179549476527;4851.466338702739;4855.951440485621;4866.926996095061;886.2849639915715;905.7599736069947;910.6812615584624;919.5310391700281;920.397139873384;621.4003486635328;633.3223450907485;639.6513899924553;645.2482857470993;657.4707360574688;11144.219904606762;11261.180322632226;11424;11454;11569.132315076404;626.5770604841805;645.5965021861336;648.2706954675989;654.5320096131289;660.9438197753245;5222.164453687392;5348.197770334481;5736.282964629421;5835.591508594358;5843.678597677169;105609.47195263974;108127;108668;114171;114598;91066.54466727756;93901.53049234847;97277.36586143644;97532.51233743927;98716.50641746745;82804;83726;85994.57002715071;86161.1383886153;89524;11096.33421994683;11188.776224475629;11201.831972520582;11635.360055197045;11661.300321980709;40348;41159.38260926028;41960.16079678328;42974.140517190106;43156.352654709575;52153.47846521638;52889;55237.7238113823;74845.25154748383;77014.2298577007;17346.132693365027;17492.212850421507;18079;18400.631987360444;18416.723749143504;18859.6228075435;19011;19033.238670453025;19155.80844191596;19309.51726206856;16153.515394538183;16180.757288640445;16241;16266.837331627006;16286.755698664292;17166.227519761393;17600.29598816033;17640.823591763918;17815.376461823773;17820.108994549963;16802.243899024328;17080.23138958775;17090.2309396075;17114.14429278556;17429;11397.943010284895;11583.420828958688;11585.59450419265;11776.11679124052;12042.036637068839;12838.55065072718;12910.677233068873;13012.089153759145;13063.150895192162;13943.790843137158 11:32:15 INFO - PID 7388 | __end_tp_report 11:32:15 INFO - PID 7388 | __start_cc_report 11:32:15 INFO - PID 7388 | _x_x_mozilla_cycle_collect,364 11:32:15 INFO - PID 7388 | __end_cc_report 11:32:15 INFO - PID 7388 | __startTimestamp1503945135365__endTimestamp 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | ------- Summary: start ------- 11:32:15 INFO - PID 7388 | Number of tests: 6 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#0] dojo.html Cycles:165 Average:6281.63 Median:6549.54 stddev:723.89 (11.1%) stddev-sans-first:688.06 11:32:15 INFO - PID 7388 | Values: 3328.9 3350.5 3356.6 3388.4 3395.1 6267.5 6319.8 6333.9 6370.5 6446.5 6187.4 6310.7 6317.6 6334.0 6345.2 5773.3 5785.5 5789.3 5791.5 5819.9 5826.4 5829.2 5838.8 5858.4 5889.3 5859.2 5875.1 5876.6 5909.9 5964.8 5658.4 5736.7 5763.5 5768.5 5821.2 5570.8 5685.1 5752.7 5757.0 5807.7 6252.2 6317.9 6349.3 6418.6 6451.8 6825.6 6832.0 6893.2 6917.6 6937.2 6748.0 6768.2 6845.8 6874.7 6919.6 6390.1 6413.1 6423.7 6457.2 6461.3 7038.5 7044.4 7059.7 7131.4 7144.0 6524.2 6598.0 6715.4 6736.3 6830.0 6708.5 6788.8 6831.2 6855.2 6875.2 6697.5 6839.4 6868.5 6879.9 6895.9 6821.1 6824.2 6836.4 6910.7 6935.3 5329.3 5374.2 5383.0 5441.3 5462.3 4774.3 4833.4 4846.8 4869.6 4876.5 5822.4 5903.3 5904.2 5946.4 6046.3 6754.7 6811.9 6821.8 6830.4 6914.5 5941.9 5965.3 5968.3 6002.5 6006.3 5897.7 5900.5 5969.3 5989.7 5991.7 6657.7 6657.8 6733.0 6739.4 6758.7 6619.2 6660.3 6700.6 6742.4 6769.5 6631.5 6639.5 6655.1 6662.2 6667.9 6675.7 6701.3 6719.0 6792.0 6802.3 6719.0 6731.7 6817.2 6866.8 6954.9 6556.6 6559.1 6559.3 6561.2 6691.6 6611.5 6612.1 6684.4 6703.2 6709.5 6481.4 6528.4 6581.9 6600.6 6627.2 6519.7 6608.8 6637.5 6649.9 6665.6 6531.5 6537.5 6541.7 6549.5 6556.2 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#1] ext.html Cycles:180 Average:36670.61 Median:3287.52 stddev:56809.39 (1728.0%) stddev-sans-first:56904.72 11:32:15 INFO - PID 7388 | Values: 745.4 823.8 848.2 1047.0 1065.3 27287.6 27710.9 27747.0 36110.6 36874.3 36490.5 36819.3 36838.8 36890.0 36909.8 7015.7 7495.3 7528.3 7533.4 7674.4 7401.6 7509.7 7511.4 7512.9 7518.4 7488.3 7524.8 7536.8 7541.5 7570.8 7481.6 7511.8 7515.9 7572.3 7577.8 7485.4 7509.4 7520.0 7525.9 7549.9 33327.3 33450.2 33455.0 33520.3 33649.8 3264.3 3286.4 3287.1 3287.9 3299.2 29008.7 29032.6 29056.6 29096.0 29098.0 4856.6 5047.2 5089.5 5109.1 5113.1 189048.1 189431.0 189807.0 191683.0 191857.0 41511.4 41773.8 42559.8 42988.6 43030.8 44210.3 44248.8 44383.8 44583.0 44757.6 13740.4 13855.2 13913.3 13962.9 13986.8 9690.1 9814.4 11302.5 11390.4 11416.7 12992.3 13073.7 13076.2 13110.9 13117.0 5313.9 5334.9 5391.6 5407.5 5434.2 889.5 920.2 937.8 941.3 945.4 20793.0 21047.3 21146.5 21681.2 21879.9 1009.3 1013.3 1019.3 1025.3 1030.9 11302.0 11312.0 11580.1 14106.6 15115.3 244488.0 246127.0 246393.0 248560.0 248777.0 48246.3 48440.0 48528.8 48554.0 48591.0 1264.3 1303.3 1303.5 1307.8 1307.9 24772.5 24956.5 24957.9 25247.9 25381.0 33249.5 33402.0 33422.5 33436.3 33457.7 214077.0 214953.0 215111.0 215474.0 215768.0 30357.8 30708.7 31139.4 32547.3 32551.7 38790.0 39519.4 39588.4 39739.6 40159.4 29511.7 29842.4 30773.8 30956.5 30975.2 29818.0 30006.7 30150.0 30237.8 30537.8 33927.7 33981.2 34024.5 34030.7 34214.5 29186.9 29481.6 29795.7 29918.0 30272.8 20796.6 21100.7 21223.9 21334.7 21598.9 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#2] jquery.html Cycles:180 Average:35468.17 Median:22650.49 stddev:89989.42 (397.3%) stddev-sans-first:90203.63 11:32:15 INFO - PID 7388 | Values: 529.5 533.9 538.3 547.2 550.0 20171.3 20595.6 20655.4 20822.2 20840.3 21758.2 22274.8 22520.4 22535.7 22547.7 6495.5 6645.2 6656.9 6659.8 6665.0 5932.2 6197.2 6482.6 6492.7 6506.9 6430.6 6439.0 6440.6 6445.2 6474.5 6429.5 6437.7 6468.5 6480.7 6481.9 5962.6 5978.8 5994.6 5998.6 6003.3 26626.2 26696.5 27164.3 27927.3 28002.9 2042.6 2084.9 2085.6 2085.9 2088.9 18361.8 18827.3 19007.0 19023.6 19039.4 2262.2 2338.3 2372.9 2379.7 2387.0 129378.0 133916.0 137318.3 138859.0 139128.3 13806.2 14332.3 14639.3 14679.3 14724.3 21437.8 22164.3 22296.6 22317.8 22386.2 9167.9 9241.9 9312.5 9370.0 9460.3 8418.5 8467.7 8475.2 8488.4 8568.7 8529.7 8602.5 8613.5 8712.4 8921.8 2462.3 2473.6 2496.9 2539.9 2578.5 884.5 904.5 915.3 932.9 933.8 18389.9 19156.7 19242.9 19452.5 19591.4 928.7 989.1 994.5 996.6 999.1 9581.7 9798.2 9894.7 9987.6 10195.5 525228.0 530734.0 537863.0 543708.0 546208.0 121192.0 122396.0 123108.0 125867.0 125876.0 1113.8 1122.6 1147.4 1148.5 1149.3 15906.8 16025.2 16154.1 16257.8 16397.5 50800.2 51922.7 52929.5 55791.7 56271.0 63079.0 65647.0 66576.7 67475.0 67851.0 14116.4 14427.3 14488.5 14528.9 14555.3 22196.2 22329.2 22439.9 22643.7 22657.3 17872.6 17904.3 18206.8 18240.4 18261.4 15808.4 15942.0 16068.9 16364.8 16481.4 17880.6 17953.9 18228.0 18344.5 18411.4 13820.9 14233.9 14254.6 14355.6 14392.9 17674.1 17742.5 17859.2 18057.6 18099.8 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#3] mootools.html Cycles:180 Average:8652.92 Median:2611.04 stddev:6284.07 (240.7%) stddev-sans-first:6276.89 11:32:15 INFO - PID 7388 | Values: 1222.2 1289.8 1291.3 1298.5 1302.2 12275.0 14011.4 14717.1 14720.7 14736.9 12298.9 14231.5 14626.9 14650.2 14657.6 2563.5 2602.2 2626.0 2627.1 2629.9 2412.7 2489.6 2490.7 2609.9 2714.6 2600.3 2624.3 2624.7 2625.1 2625.3 2590.1 2600.2 2608.9 2612.2 2621.1 2517.6 2534.9 2545.9 2546.4 2557.0 14102.1 14377.1 14401.2 14407.6 14415.1 7483.3 7695.7 7711.8 7760.9 7762.9 5079.2 5113.6 5144.9 5266.9 5349.1 1882.0 1903.4 1914.8 1920.3 1932.1 24760.5 25275.6 25449.2 25494.5 25495.1 6263.0 6361.9 6519.4 6539.1 6555.7 15543.2 15600.1 15659.7 15677.5 15742.6 7376.3 7576.4 7583.2 7584.6 7595.8 6856.6 7016.2 7025.4 7057.7 7065.4 4840.7 4881.0 4943.8 4947.2 4962.7 1509.5 1525.2 1525.8 1535.6 1547.8 769.3 800.3 811.2 813.0 814.6 6715.3 6768.5 6786.7 6810.6 6875.8 625.8 643.9 655.4 659.0 690.0 4607.0 4748.2 4844.8 4924.9 4995.3 19778.8 20455.2 20728.7 20740.3 20878.4 19659.8 19779.5 20009.6 20400.9 20555.9 9762.2 9943.3 10032.5 10059.3 10076.5 7551.8 7636.3 7663.5 7709.4 7789.6 17417.2 17637.6 17802.2 18095.6 18363.4 18100.5 18157.4 18210.5 18274.4 18288.2 9850.4 10123.4 10163.7 10240.1 10249.3 12478.3 12536.6 12552.9 12586.0 12610.3 9646.9 9661.8 9663.5 9702.3 10106.2 9890.3 9999.6 10003.4 10063.2 10232.6 8604.9 8737.3 8748.2 8748.5 8748.7 6387.4 6401.7 6434.3 6438.3 6489.9 6452.0 6635.7 6636.2 6660.7 6675.2 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#4] prototype.html Cycles:180 Average:5672.86 Median:6338.40 stddev:1520.32 (24.0%) stddev-sans-first:1474.27 11:32:15 INFO - PID 7388 | Values: 504.3 514.9 522.8 535.4 537.3 6338.4 6366.2 6377.0 6377.3 6469.9 6327.5 6329.7 6349.3 6394.6 6416.2 5185.1 5216.3 5233.2 5261.5 5281.3 4877.3 5169.9 5209.4 5210.6 5268.4 4986.6 4986.8 5015.3 5021.9 5030.5 4981.2 5031.2 5055.2 5057.9 5067.2 4487.5 4503.2 4755.2 4884.5 4928.3 6220.8 6308.1 6334.9 6338.4 6352.0 6022.1 6064.6 6067.5 6080.7 6098.5 6697.6 6733.9 6763.4 6764.3 6806.5 5340.4 5365.8 5373.1 5374.9 5380.4 6723.0 6723.4 6780.3 6964.7 7039.7 5460.3 5504.3 5504.8 5540.7 5592.6 5575.9 5587.0 5616.7 5631.8 5646.8 5956.8 5976.4 6026.7 6067.3 6128.8 6694.7 6754.0 6799.4 6800.7 6828.8 1948.3 1964.4 1966.6 1980.7 1983.6 1361.6 1443.6 1444.1 1449.2 1452.5 5743.9 5751.2 5774.0 5808.3 5875.8 6611.2 6640.5 6668.5 6756.4 6756.7 5776.0 5811.5 5836.9 5867.5 5876.4 3592.4 3603.3 3627.4 3648.6 3656.7 6558.3 6578.7 6642.7 6643.8 6676.3 6872.3 6879.8 6880.8 7015.3 7021.2 6524.3 6549.1 6565.7 6622.9 6624.4 6743.9 6746.8 6818.1 6822.8 6832.8 6548.8 6651.3 6653.7 6700.9 6756.4 6579.3 6608.8 6610.4 6643.2 6667.9 5542.9 5568.7 5574.4 5583.0 5586.5 6475.6 6625.0 6721.4 6831.5 6844.8 6379.2 6609.6 6625.6 6627.3 6632.5 6491.6 6522.2 6530.4 6579.4 6588.3 6487.8 6526.3 6540.2 6591.7 6613.6 6569.5 6578.9 6588.8 6649.8 6682.4 6354.7 6400.8 6437.4 6443.1 6511.6 11:32:15 INFO - PID 7388 | 11:32:15 INFO - PID 7388 | [#5] yui.html Cycles:180 Average:22551.15 Median:3626.65 stddev:31919.72 (880.1%) stddev-sans-first:31967.42 11:32:15 INFO - PID 7388 | Values: 783.5 796.4 813.2 814.3 817.7 15273.2 15871.2 15882.8 15885.5 17593.4 16135.3 16434.8 16442.0 16444.8 16468.4 713.1 766.3 777.5 780.3 781.2 730.7 786.9 787.2 787.6 787.8 816.8 818.4 818.5 819.2 819.9 810.5 810.8 811.2 811.6 812.4 592.1 592.7 592.8 593.8 594.1 14940.1 15175.8 15319.9 15320.7 15324.3 17456.0 18231.5 18235.9 18277.2 18323.1 14311.2 14908.0 14996.9 15036.7 15044.9 3608.8 3644.5 3648.4 3650.7 3650.9 123959.8 125218.4 126105.4 126909.0 127115.4 14136.9 14191.3 14838.7 14845.2 14858.9 25407.9 26391.9 26520.6 26709.2 26936.6 7849.8 8034.7 8037.3 8041.6 8048.1 3994.9 4077.3 4101.8 4109.2 4121.4 4712.7 4826.2 4851.5 4856.0 4866.9 886.3 905.8 910.7 919.5 920.4 621.4 633.3 639.7 645.2 657.5 11144.2 11261.2 11424.0 11454.0 11569.1 626.6 645.6 648.3 654.5 660.9 5222.2 5348.2 5736.3 5835.6 5843.7 105609.5 108127.0 108668.0 114171.0 114598.0 91066.5 93901.5 97277.4 97532.5 98716.5 82804.0 83726.0 85994.6 86161.1 89524.0 11096.3 11188.8 11201.8 11635.4 11661.3 40348.0 41159.4 41960.2 42974.1 43156.4 52153.5 52889.0 55237.7 74845.3 77014.2 17346.1 17492.2 18079.0 18400.6 18416.7 18859.6 19011.0 19033.2 19155.8 19309.5 16153.5 16180.8 16241.0 16266.8 16286.8 17166.2 17600.3 17640.8 17815.4 17820.1 16802.2 17080.2 17090.2 17114.1 17429.0 11397.9 11583.4 11585.6 11776.1 12042.0 12838.6 12910.7 13012.1 13063.2 13943.8 11:32:15 INFO - PID 7388 | -------- Summary: end -------- 11:32:15 INFO - PID 7388 | 11:32:16 INFO - TEST-INFO | 7388: exit 0 11:32:16 INFO - TEST-OK | dromaeo_css | took 1110942ms 11:32:16 INFO - TEST-START | kraken 11:32:16 INFO - Initialising browser for kraken test... 11:32:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43173/getInfo.html -profile /tmp/tmpuvO3kW/profile 11:32:16 INFO - TEST-INFO | started process 7761 (/builds/slave/test/build/application/firefox/firefox http://localhost:43173/getInfo.html) 11:32:21 INFO - TEST-INFO | 7761: exit 0 11:32:21 INFO - Browser initialized. 11:32:21 INFO - Running cycle 1/1 for kraken test... 11:32:21 INFO - Using env: {'DISPLAY': ':0', 11:32:21 INFO - 'HOME': '/home/cltbld', 11:32:21 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:21 INFO - 'LANG': 'en_US.UTF-8', 11:32:21 INFO - 'LANGUAGE': 'en_US:en', 11:32:21 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:21 INFO - 'LOGNAME': 'cltbld', 11:32:21 INFO - 'MAIL': '/var/mail/cltbld', 11:32:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:21 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:21 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:21 INFO - 'MOZ_NO_REMOTE': '1', 11:32:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:21 INFO - 'NO_EM_RESTART': '1', 11:32:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:21 INFO - 'PWD': '/builds/slave/test', 11:32:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:21 INFO - 'RUST_BACKTRACE': 'full', 11:32:21 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:21 INFO - 'SHELL': '/bin/bash', 11:32:21 INFO - 'SHLVL': '1', 11:32:21 INFO - 'STYLO_FORCE_ENABLED': '1', 11:32:21 INFO - 'TERM': 'linux', 11:32:21 INFO - 'TMOUT': '86400', 11:32:21 INFO - 'USER': 'cltbld', 11:32:21 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617', 11:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:21 INFO - '_': '/tools/buildbot/bin/python'} 11:32:21 INFO - TEST-INFO | started process 7946 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuvO3kW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:22 INFO - PID 7946 | 11:32:22 INFO - PID 7946 | (/builds/slave/test/build/application/firefox/firefox:7997): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:22 INFO - PID 7946 | 11:32:33 INFO - PID 7946 | RSS: Main: 173752320 11:32:33 INFO - PID 7946 | 11:32:35 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43173/tests/kraken/driver.html?testName=audio-beat-detection) 11:32:36 INFO - PID 7946 | RSS: Main: 180228096 11:32:36 INFO - PID 7946 | 11:32:39 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43173/tests/kraken/driver.html?testName=audio-dft) 11:32:39 INFO - PID 7946 | RSS: Main: 183623680 11:32:39 INFO - PID 7946 | 11:32:42 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43173/tests/kraken/driver.html?testName=audio-fft) 11:32:43 INFO - PID 7946 | RSS: Main: 175669248 11:32:43 INFO - PID 7946 | 11:32:45 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43173/tests/kraken/driver.html?testName=audio-oscillator) 11:32:46 INFO - PID 7946 | RSS: Main: 176472064 11:32:46 INFO - PID 7946 | 11:32:48 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43173/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:32:49 INFO - PID 7946 | RSS: Main: 176762880 11:32:49 INFO - PID 7946 | 11:32:52 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43173/tests/kraken/driver.html?testName=imaging-darkroom) 11:32:52 INFO - PID 7946 | RSS: Main: 177971200 11:32:52 INFO - PID 7946 | 11:32:56 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43173/tests/kraken/driver.html?testName=imaging-desaturate) 11:32:56 INFO - PID 7946 | RSS: Main: 178245632 11:32:56 INFO - PID 7946 | 11:32:59 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43173/tests/kraken/driver.html?testName=json-parse-financial) 11:33:00 INFO - PID 7946 | RSS: Main: 178544640 11:33:00 INFO - PID 7946 | 11:33:01 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43173/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:33:02 INFO - PID 7946 | RSS: Main: 178704384 11:33:02 INFO - PID 7946 | 11:33:04 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:33:04 INFO - PID 7946 | RSS: Main: 178892800 11:33:04 INFO - PID 7946 | 11:33:07 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:33:07 INFO - PID 7946 | RSS: Main: 175620096 11:33:07 INFO - PID 7946 | 11:33:10 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:33:11 INFO - PID 7946 | RSS: Main: 175693824 11:33:11 INFO - PID 7946 | 11:33:13 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:33:14 INFO - PID 7946 | RSS: Main: 175910912 11:33:14 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | Cycle 1(1): loaded http://localhost:43173/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43173/tests/kraken/driver.html?testName=ai-astar) 11:33:16 INFO - PID 7946 | RSS: Main: 177442816 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | __start_tp_report 11:33:16 INFO - PID 7946 | _x_x_mozilla_page_load 11:33:16 INFO - PID 7946 | _x_x_mozilla_page_load_details 11:33:16 INFO - PID 7946 | |i|pagename|runs| 11:33:16 INFO - PID 7946 | |0;ai-astar;97;107;100;105;108;108;109;98;108;107 11:33:16 INFO - PID 7946 | |1;audio-beat-detection;151;119;141;166;115;144;147;116;178;120 11:33:16 INFO - PID 7946 | |2;audio-dft;162;161;161;161;160;162;163;170;164;162 11:33:16 INFO - PID 7946 | |3;audio-fft;73;74;75;104;75;73;73;89;98;74 11:33:16 INFO - PID 7946 | |4;audio-oscillator;79;78;131;80;79;79;126;80;79;125 11:33:16 INFO - PID 7946 | |5;imaging-gaussian-blur;114;114;115;114;113;113;114;115;115;115 11:33:16 INFO - PID 7946 | |6;imaging-darkroom;148;148;149;147;148;147;148;147;147;148 11:33:16 INFO - PID 7946 | |7;imaging-desaturate;93;93;94;94;94;93;94;94;93;94 11:33:16 INFO - PID 7946 | |8;json-parse-financial;51;51;51;51;55;50;51;52;50;50 11:33:16 INFO - PID 7946 | |9;json-stringify-tinderbox;39;39;39;39;38;38;38;38;38;38 11:33:16 INFO - PID 7946 | |10;stanford-crypto-aes;78;79;75;74;74;79;74;74;77;75 11:33:16 INFO - PID 7946 | |11;stanford-crypto-ccm;128;133;115;124;128;125;115;118;121;158 11:33:16 INFO - PID 7946 | |12;stanford-crypto-pbkdf2;182;167;169;175;169;167;171;174;167;172 11:33:16 INFO - PID 7946 | |13;stanford-crypto-sha256-iterative;66;67;64;68;63;67;63;67;63;63 11:33:16 INFO - PID 7946 | __end_tp_report 11:33:16 INFO - PID 7946 | __start_cc_report 11:33:16 INFO - PID 7946 | _x_x_mozilla_cycle_collect,945 11:33:16 INFO - PID 7946 | __end_cc_report 11:33:16 INFO - PID 7946 | __startTimestamp1503945196580__endTimestamp 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | ------- Summary: start ------- 11:33:16 INFO - PID 7946 | Number of tests: 14 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#0] ai-astar Cycles:10 Average:104.70 Median:108.00 stddev:4.57 (4.2%) stddev-sans-first:3.91 11:33:16 INFO - PID 7946 | Values: 97.0 107.0 100.0 105.0 108.0 108.0 109.0 98.0 108.0 107.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:145.50 stddev:21.98 (15.1%) stddev-sans-first:22.93 11:33:16 INFO - PID 7946 | Values: 151.0 119.0 141.0 166.0 115.0 144.0 147.0 116.0 178.0 120.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.84 (1.8%) stddev-sans-first:3.00 11:33:16 INFO - PID 7946 | Values: 162.0 161.0 161.0 161.0 160.0 162.0 163.0 170.0 164.0 162.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.50 stddev:11.75 (15.8%) stddev-sans-first:12.12 11:33:16 INFO - PID 7946 | Values: 73.0 74.0 75.0 104.0 75.0 73.0 73.0 89.0 98.0 74.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#4] audio-oscillator Cycles:10 Average:93.60 Median:79.00 stddev:23.33 (29.5%) stddev-sans-first:24.14 11:33:16 INFO - PID 7946 | Values: 79.0 78.0 131.0 80.0 79.0 79.0 126.0 80.0 79.0 125.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 11:33:16 INFO - PID 7946 | Values: 114.0 114.0 115.0 114.0 113.0 113.0 114.0 115.0 115.0 115.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 11:33:16 INFO - PID 7946 | Values: 148.0 148.0 149.0 147.0 148.0 147.0 148.0 147.0 147.0 148.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#7] imaging-desaturate Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:33:16 INFO - PID 7946 | Values: 93.0 93.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 94.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.48 (2.9%) stddev-sans-first:1.56 11:33:16 INFO - PID 7946 | Values: 51.0 51.0 51.0 51.0 55.0 50.0 51.0 52.0 50.0 50.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#9] json-stringify-tinderbox Cycles:10 Average:38.40 Median:38.50 stddev:0.52 (1.3%) stddev-sans-first:0.50 11:33:16 INFO - PID 7946 | Values: 39.0 39.0 39.0 39.0 38.0 38.0 38.0 38.0 38.0 38.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:2.13 (2.8%) stddev-sans-first:2.12 11:33:16 INFO - PID 7946 | Values: 78.0 79.0 75.0 74.0 74.0 79.0 74.0 74.0 77.0 75.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:126.50 stddev:12.54 (9.9%) stddev-sans-first:13.29 11:33:16 INFO - PID 7946 | Values: 128.0 133.0 115.0 124.0 128.0 125.0 115.0 118.0 121.0 158.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:4.74 (2.8%) stddev-sans-first:3.06 11:33:16 INFO - PID 7946 | Values: 182.0 167.0 169.0 175.0 169.0 167.0 171.0 174.0 167.0 172.0 11:33:16 INFO - PID 7946 | 11:33:16 INFO - PID 7946 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.18 11:33:16 INFO - PID 7946 | Values: 66.0 67.0 64.0 68.0 63.0 67.0 63.0 67.0 63.0 63.0 11:33:16 INFO - PID 7946 | -------- Summary: end -------- 11:33:16 INFO - PID 7946 | 11:33:17 INFO - PID 7946 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:33:17 INFO - TEST-INFO | 7946: exit 0 11:33:17 INFO - TEST-OK | kraken | took 61226ms 11:33:17 INFO - SUITE-END | took 1172s 11:33:17 INFO - Completed test suite (00:19:32) 11:33:17 INFO - javascript benchmark 11:33:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8209.671279101714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3328.9167770805725, 3350.5476760637307, 3356.563646725925, 3388.373150967073, 3395.117269509928, 6267.498600111991, 6319.77880774173, 6333.936660633392, 6370.4903607711385, 6446.548741588091, 6187.35032821554, 6310.652914089723, 6317.620942743439, 6334.0, 6345.206849143857, 5773.336066352371, 5785.479306862381, 5789.2763404574425, 5791.507721843648, 5819.883602327951, 5826.388229235933, 5829.154772557977, 5838.795642152526, 5858.41415858415, 5889.293284805808, 5859.238299021121, 5875.1187321901625, 5876.647401155944, 5909.852253693671, 5964.761409543613, 5658.405867383948, 5736.741846616912, 5763.452472015152, 5768.509676677488, 5821.243238379005, 5570.832875013756, 5685.147227915804, 5752.654840709529, 5756.971215143939, 5807.709614519299, 6252.155958945529, 6317.905231421532, 6349.301576826545, 6418.614883107029, 6451.83870403239, 6825.590464572141, 6832.009358642969, 6893.172819261721, 6917.619530925797, 6937.202221744514, 6748.0, 6768.187817461887, 6845.794626161223, 6874.725010999554, 6919.550229235134, 6390.13733146024, 6413.070104834773, 6423.7430502779835, 6457.1605691260775, 6461.289258181596, 7038.472114591426, 7044.401225895754, 7059.682314295869, 7131.358177764027, 7144.0, 6524.184476940382, 6597.977313516412, 6715.3620406061345, 6736.326367363323, 6829.965850170717, 6708.463322934153, 6788.76239331621, 6831.180258369028, 6855.211650660138, 6875.209350924608, 6697.464202863856, 6839.384455399038, 6868.484863635247, 6879.931200687929, 6895.931130674753, 6821.113255276782, 6824.21521525021, 6836.418904393182, 6910.723571057101, 6935.306469353125, 5329.333833270841, 5374.167004114369, 5382.973085134628, 5441.347038355423, 5462.317210348707, 4774.259989701602, 4833.4441539223435, 4846.75766211688, 4869.63477739171, 4876.536729010738, 5822.417758224228, 5903.321118071391, 5904.173415721716, 5946.405359464019, 6046.304674962347, 6754.729810807513, 6811.863762724718, 6821.795346139624, 6830.35111664401, 6914.51598388108, 5941.881162376728, 5965.28416590012, 5968.313643930916, 6002.519798416116, 6006.339302676702, 5897.67562784051, 5900.527957763368, 5969.31352894414, 5989.670568118708, 5991.730372133177, 6657.667116644052, 6657.833554161185, 6732.966335168293, 6739.393454589111, 6758.695858686371, 6619.172603424572, 6660.333966603301, 6700.597964122168, 6742.359475849787, 6769.458443324621, 6631.469482441489, 6639.4688424924925, 6655.134832471747, 6662.233843108104, 6667.933320666925, 6675.732970681119, 6701.262861085374, 6718.966405167943, 6792.049113124068, 6802.285759995327, 6719.0, 6731.697073631796, 6817.216020157547, 6866.759663411756, 6954.930450695429, 6556.606603603799, 6559.0817285579105, 6559.27847936717, 6561.245456772342, 6691.631960242234, 6611.537192396486, 6612.074309596756, 6684.398404143651, 6703.195616526048, 6709.496787740842, 6481.4166724994975, 6528.412442880163, 6581.868362632817, 6600.570962887589, 6627.204735431779, 6519.706613202323, 6608.801735947929, 6637.535372523877, 6649.900251496329, 6665.566738162004, 6531.542792004514, 6537.477001839937, 6541.672916354068, 6549.541532092708, 6556.18047744032], "value": 6229.917965559842, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [745.3925051083366, 823.8064054947087, 848.2365870716357, 1046.9790604187917, 1065.275612583443, 27287.590686139698, 27710.861445692768, 27747.0, 36110.63889361105, 36874.26251474969, 36490.452643210374, 36819.263614727686, 36838.81580592093, 36890.0, 36909.81545092271, 7015.684294206748, 7495.287947644965, 7528.322450979411, 7533.359664428516, 7674.424418168632, 7401.629918504053, 7509.6620652070515, 7511.436642251826, 7512.887306690404, 7518.360939320164, 7488.288612581823, 7524.849503009937, 7536.811579710524, 7541.472096953188, 7570.772876813677, 7481.551106933602, 7511.849763004737, 7515.924840751604, 7572.318491335751, 7577.772666820004, 7485.363744081759, 7509.399248060196, 7520.0, 7525.924740752577, 7549.924500755032, 33327.33345333104, 33450.163745906306, 33455.0, 33520.329593407994, 33649.83175084109, 3264.281857991238, 3286.359159963808, 3287.1453422110185, 3287.901362959115, 3299.158714527804, 29008.709912900813, 29032.564511532342, 29056.564151537743, 29096.0, 29098.0, 4856.61147108234, 5047.167217409123, 5089.51649593288, 5109.105906466353, 5113.130767769489, 189048.1095189044, 189431.0, 189807.0, 191683.0, 191857.0, 41511.37732934008, 41773.79113104415, 42559.787201063795, 42988.570114298454, 43030.78484607557, 44210.33684494735, 44248.77875610666, 44383.77808110939, 44583.0, 44757.55242447599, 13740.381682824296, 13855.23796191199, 13913.30433478322, 13962.930185349009, 13986.790198147037, 9690.12788849007, 9814.411135331902, 11302.491387887565, 11390.37352945596, 11416.657500275005, 12992.285424301754, 13073.738525229632, 13076.215427074216, 13110.934445327903, 13117.0, 5313.908290616204, 5334.946650533522, 5391.649542779707, 5407.486288802557, 5434.157705555645, 889.5463313709926, 920.1524312990847, 937.8499440089689, 941.2752180820867, 945.413843417072, 20793.0, 21047.263345782823, 21146.471338216666, 21681.241156559445, 21879.890600546896, 1009.2632378363835, 1013.2957594471771, 1019.2559431614962, 1025.3284098915221, 1030.8659874216303, 11302.0, 11312.0, 11580.131490138105, 14106.647333816736, 15115.31981060855, 244488.0, 246127.0, 246393.0, 248560.0, 248777.0, 48246.27630585544, 48440.0, 48528.7573562137, 48554.0, 48591.0, 1264.2793607643555, 1303.2897071096274, 1303.48512337628, 1307.7646023715631, 1307.901907356952, 24772.50454990854, 24956.50086998286, 24957.87521062383, 25247.87376063108, 25381.0, 33249.50125748164, 33402.0, 33422.498662519596, 33436.33127337488, 33457.66542334643, 214077.0, 214953.0, 215111.0, 215474.0, 215768.0, 30357.848210758806, 30708.692913070583, 31139.37721245608, 32547.34905301928, 32551.674483254865, 38790.0, 39519.407208892466, 39588.40617390799, 39739.60260397359, 40159.3976090353, 29511.704882950897, 29842.403151937273, 30773.8461307701, 30956.53565196569, 30975.225619359695, 29818.0, 30006.69993300039, 30150.0, 30237.848810755804, 30537.847310763304, 33927.66072339245, 33981.15047123842, 34024.48963265504, 34030.65969340275, 34214.486782698776, 29186.854065729534, 29481.557776633796, 29795.702042979294, 29918.0, 30272.84863575668, 20796.58406831885, 21100.683489747975, 21223.893880531115, 21334.679979800625, 21598.8920055405], "value": 16072.305904344865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [529.4943329120688, 533.8558589180924, 538.3136500961276, 547.1956224350206, 549.9815676467365, 20171.29400470984, 20595.588088238226, 20655.380338589865, 20822.16711331549, 20840.270590529333, 21758.238461653844, 22274.77725222747, 22520.43698907524, 22535.661965070536, 22547.661785073196, 6495.545311828174, 6645.202575690924, 6656.934890417534, 6659.766908158215, 6665.033570132328, 5932.228810254661, 6197.163382943312, 6482.611043337415, 6492.7402903883785, 6506.934930650704, 6430.614163150202, 6439.0, 6440.581362211465, 6445.226572811269, 6474.514411419163, 6429.517786166056, 6437.742490300382, 6468.514861385392, 6480.675966201718, 6481.870362592769, 5962.552808539377, 5978.790742323998, 5994.610350327215, 5998.580099393044, 6003.339632640406, 26626.201213963614, 26696.46607067867, 27164.320891977663, 27927.30181745452, 28002.859985699943, 2042.5608494173823, 2084.8749075055543, 2085.572457646194, 2085.9165633374646, 2088.853780235384, 18361.816381836143, 18827.341043063563, 19007.0, 19023.61952760937, 19039.42881713537, 2262.1743063781764, 2338.251759436981, 2372.857628542293, 2379.7263314718857, 2387.0451819272257, 129377.99999999905, 133916.0, 137318.3134084333, 138859.0, 139128.30435847858, 13806.240656763774, 14332.283385830668, 14639.341229644691, 14679.339429725687, 14724.33740481681, 21437.78562214358, 22164.335069947927, 22296.55406891853, 22317.776822231895, 22386.21648242304, 9167.862482062774, 9241.861372079424, 9312.534373281309, 9370.016148304467, 9460.290478214023, 8418.494890306602, 8467.661293548312, 8475.194856488746, 8488.40581159313, 8568.657253709907, 8529.658813647384, 8602.52686102258, 8613.48319100856, 8712.390132690778, 8921.776955576162, 2462.3228612131807, 2473.5918573435542, 2496.90012399502, 2539.8984040638165, 2578.458523710042, 884.5046773806561, 904.5206040798388, 915.3318077803241, 932.8507438809894, 933.7712260496222, 18389.88636136689, 19156.712649310273, 19242.903785481263, 19452.513687157934, 19591.412257632295, 928.661038720862, 989.1196834817018, 994.472929347447, 996.5814357969671, 999.1008092716613, 9581.712548623553, 9798.216142708567, 9894.653687121061, 9987.60049598008, 10195.541200645988, 525228.0, 530734.0, 537863.0, 543708.0, 546208.0, 121192.0, 122396.0, 123108.0, 125867.0, 125876.0, 1113.788380207774, 1122.646366394583, 1147.4090843215752, 1148.4544841200363, 1149.2644707387278, 15906.761398579261, 16025.198740063184, 16154.11152386583, 16257.837421625632, 16397.508074757778, 50800.23799642934, 51922.740386297824, 52929.47070529399, 55791.721041394536, 56271.0, 63079.0, 65647.0, 66576.6671166641, 67475.0, 67851.0, 14116.435342586181, 14427.278636068364, 14488.492902748354, 14528.85471145275, 14555.345009474811, 22196.223132190295, 22329.218477353214, 22439.887800560893, 22643.660345094508, 22657.320280391614, 17872.642547149244, 17904.28382864723, 18206.817931821042, 18240.361587344378, 18261.360852370104, 15808.446704365291, 15942.0, 16068.919655401649, 16364.754528682317, 16481.423150190167, 17880.55298617545, 17953.910230448764, 18228.0, 18344.541386465444, 18411.447656570323, 13820.930895345458, 14233.857661423253, 14254.643633909236, 14355.56933292003, 14392.856071439151, 17674.116294184983, 17742.467725968243, 17859.196336164645, 18057.638847223243, 18099.81900181034], "value": 11506.44713197873, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1222.2361024359775, 1289.8258735070763, 1291.3220559206416, 1298.532528289815, 1302.1666133674444, 12275.017998560115, 14011.439542418304, 14717.116972981601, 14720.705585888276, 14736.926315368422, 12298.877011229884, 14231.501897433593, 14626.926865365685, 14650.194239316834, 14657.56027319182, 2563.4744877300154, 2602.1933200707745, 2625.9868700656566, 2627.0542604662305, 2629.868506574673, 2412.6863507744056, 2489.639002344659, 2490.6762120924345, 2609.9086531971384, 2714.647095877533, 2600.2589262060314, 2624.3045592917892, 2624.698159711629, 2625.12058460416, 2625.2780485366484, 2590.1193594177976, 2600.2329312852753, 2608.869556522185, 2612.1771641932824, 2621.1350254416093, 2517.622356646499, 2534.88593013313, 2545.8599777012255, 2546.363409147713, 2557.041109583906, 14102.083364581373, 14377.065490743173, 14401.20793356365, 14407.639809004753, 14415.063020903608, 7483.32650061497, 7695.653695583712, 7711.768646940601, 7760.883586746203, 7762.883556746653, 5079.161938280179, 5113.642045056848, 5144.897102057937, 5266.894662106736, 5349.117395629716, 1881.9529511762178, 1903.3909149072304, 1914.7510823592843, 1920.308688872005, 1932.072605149536, 24760.504789904102, 25275.62086568703, 25449.236522904343, 25494.490110197694, 25495.107671231417, 6263.0, 6361.936380636227, 6519.445847103049, 6539.149910511603, 6555.672216389162, 15543.222838858012, 15600.14199219031, 15659.686806263811, 15677.529674109795, 15742.606434839221, 7376.299251571092, 7576.356009739124, 7583.203763604853, 7584.582847943416, 7595.848083038309, 6856.6228857412325, 7016.193137789118, 7025.40284075849, 7057.717691292393, 7065.43476521877, 4840.709557426566, 4881.0, 4943.826966056171, 4947.158982972904, 4962.652614317035, 1509.532045066033, 1525.2297589717343, 1525.8016457860408, 1535.6237721758018, 1547.8452154784657, 769.3037800790294, 800.263757343234, 811.1766556944706, 812.9959649464099, 814.6049166154411, 6715.294894036154, 6768.492363072789, 6786.660666966632, 6810.557313774688, 6875.828104297432, 625.7997440818895, 643.8969764837603, 655.3741177175785, 658.9604623722591, 690.0, 4607.0, 4748.19280722278, 4844.781984810692, 4924.926126108111, 4995.25071239317, 19778.802211977985, 20455.18179272842, 20728.689069663968, 20740.274090407063, 20878.37364879056, 19659.803401965797, 19779.50551236202, 20009.599808004048, 20400.897995509928, 20555.8972205138, 9762.219022478184, 9943.303968722264, 10032.498375081217, 10059.34614250086, 10076.546555405024, 7551.773446796605, 7636.31273185416, 7663.543003210014, 7709.383249339927, 7789.61051947389, 17417.216225270146, 17637.559061023578, 17802.198901049742, 18095.63808723792, 18363.35728249505, 18100.45698629043, 18157.36449224271, 18210.544736381697, 18274.36039738656, 18288.17703203386, 9850.408975461496, 10123.443210623487, 10163.695089147337, 10240.129588985019, 10249.33379330341, 12478.313692746986, 12536.623901282976, 12552.937235313764, 12585.993120550516, 12610.306433145897, 9646.855297170689, 9661.806763864824, 9663.516824158905, 9702.272329575451, 10106.242031847494, 9890.258230632588, 9999.55002024896, 10003.449810260505, 10063.245256605931, 10232.59069637206, 8604.870926936226, 8737.257333126501, 8748.212660860552, 8748.518831464331, 8748.737537873874, 6387.361263873576, 6401.711922963571, 6434.260060093149, 6438.29178790342, 6489.935100648933, 6451.967740161457, 6635.734570617315, 6636.2368327642935, 6660.733570657119, 6675.165604299463], "value": 6159.132194414805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.3367971117982, 514.934086441067, 522.822240438251, 535.427093010479, 537.3149234725724, 6338.429541341273, 6366.204224471941, 6376.991247756965, 6377.33038031007, 6469.870602587951, 6327.49380049596, 6329.683515824214, 6349.269833969095, 6394.6020242409095, 6416.165898433197, 5185.144451165553, 5216.26972223888, 5233.162693968966, 5261.473852614727, 5281.287026251445, 4877.292792545079, 5169.870753231162, 5209.374875014984, 5210.557102646279, 5268.367795864501, 4986.551210391064, 4986.800527978877, 5015.348004759376, 5021.874453138683, 5030.547250747432, 4981.1532039553185, 5031.1950087986115, 5055.241713742949, 5057.898842023139, 5067.189249720027, 4487.506374298824, 4503.166914120865, 4755.239161734141, 4884.487128851455, 4928.310036594879, 6220.751169953196, 6308.139098965816, 6334.936650633481, 6338.366163383671, 6352.047192921099, 6022.066579680157, 6064.575479716422, 6067.544934129958, 6080.726367313438, 6098.512119030467, 6697.59814411132, 6733.865322693568, 6763.391294783493, 6764.289749576273, 6806.4554835613035, 5340.439253878326, 5365.812196573141, 5373.09255214401, 5374.892502149935, 5380.381256155514, 6722.9663851680425, 6723.428508576777, 6780.321967803229, 6964.651767411659, 7039.69134506781, 5460.26286451324, 5504.339479262514, 5504.779808807602, 5540.730968728389, 5592.5805564582815, 5575.944240557543, 5586.972065139648, 5616.747246373923, 5631.774729010794, 5646.774129034792, 5956.76172953077, 5976.432238937294, 6026.6986650667295, 6067.271927368744, 6128.785492507741, 6694.698738556776, 6753.966230168818, 6799.354061364163, 6800.727970881109, 6828.829279268058, 1948.2693989753843, 1964.400857738375, 1966.6361723081275, 1980.6533856575043, 1983.611471969627, 1361.6187467509114, 1443.5524987253984, 1444.104655113836, 1449.2319070892445, 1452.513408008329, 5743.942560574341, 5751.194832723422, 5774.0, 5808.332041815245, 5875.764969401262, 6611.206655201407, 6640.501962352746, 6668.499862510331, 6756.391924726799, 6756.662166891636, 5776.0, 5811.506021988093, 5836.854078648068, 5867.501262392744, 5876.353601103875, 3592.443171308399, 3603.3333833240936, 3627.365211088049, 3648.5986541480415, 3656.6668497830156, 6558.311377305409, 6578.736850525926, 6642.701078451481, 6643.7674681385915, 6676.332366763285, 6872.312768723188, 6879.793606191723, 6880.827979300458, 7015.298470153046, 7021.22766495685, 6524.347565243533, 6549.115869357575, 6565.67171641416, 6622.946886465115, 6624.370684785034, 6743.898841517479, 6746.763863264762, 6818.113645226089, 6822.829429264308, 6832.760853370109, 6548.8035358939305, 6651.301613330531, 6653.700583473658, 6700.899486507608, 6756.358145976124, 6579.342065793574, 6608.770386952258, 6610.3720146586, 6643.2360278568585, 6667.8997965335175, 5542.889142217214, 5568.693721845338, 5574.442555744393, 5583.0, 5586.469285417878, 6475.611463312216, 6624.966875165594, 6721.428678562377, 6831.453483721191, 6844.760433384808, 6379.234491861006, 6609.636469994004, 6625.569337993015, 6627.3372662733345, 6632.50256230775, 6491.642959637265, 6522.15212022434, 6530.412262896362, 6579.440747536321, 6588.275289718032, 6487.805365839033, 6526.282108968105, 6540.215174179129, 6591.703373348115, 6613.576866969039, 6569.507286953593, 6578.901316480161, 6588.769393071219, 6649.808092115908, 6682.365175308338, 6354.745810167541, 6400.775972841115, 6437.388448097423, 6443.130177425987, 6511.641859697762], "value": 5235.9974305361875, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [783.5298820707573, 796.3509739562256, 813.1786895235812, 814.2874984388657, 817.7383237364046, 15273.236338183087, 15871.206439677999, 15882.841171588281, 15885.523434296974, 17593.3842315519, 16135.273912673929, 16434.83565164348, 16442.0, 16444.753328700048, 16468.423605173823, 713.0623230451939, 766.2796970847413, 777.5451360953849, 780.336713793274, 781.1797612506873, 730.7332823519404, 786.9173736757643, 787.2009909941414, 787.6455594982252, 787.759733281349, 816.848882956652, 818.3616778912428, 818.5129847740615, 819.2381085590398, 819.9467034642759, 810.4529442626203, 810.8094597769519, 811.1645005644167, 811.5982588618642, 812.358236992775, 592.0734051209843, 592.6947621974687, 592.7984485275027, 593.8010766393263, 594.0999385930319, 14940.103593784408, 15175.848241517553, 15319.923400383039, 15320.693586128327, 15324.310406031755, 17456.0, 18231.45305640833, 18235.908820455945, 18277.177527011183, 18323.083845807658, 14311.212883291415, 14908.0, 14996.850031499655, 15036.699266014728, 15044.924775376163, 3608.765430247052, 3644.5444319460066, 3648.416253399443, 3650.7444478886487, 3650.9269814603826, 123959.76040239572, 125218.37390813079, 126105.36947315297, 126909.0, 127115.36442317729, 14136.85863141376, 14191.290435478184, 14838.70322593542, 14845.183514906785, 14858.851411485746, 25407.87296063508, 26391.944322226896, 26520.60219096715, 26709.19872403831, 26936.59595106075, 7849.803754906173, 8034.718784842619, 8037.31682806968, 8041.597920103972, 8048.114707382183, 3994.8601798936897, 4077.2660921033907, 4101.815418306183, 4109.198706252312, 4121.361189015707, 4712.717236965793, 4826.179549476527, 4851.466338702739, 4855.951440485621, 4866.926996095061, 886.2849639915715, 905.7599736069947, 910.6812615584624, 919.5310391700281, 920.397139873384, 621.4003486635328, 633.3223450907485, 639.6513899924553, 645.2482857470993, 657.4707360574688, 11144.219904606762, 11261.180322632226, 11424.0, 11454.0, 11569.132315076404, 626.5770604841805, 645.5965021861336, 648.2706954675989, 654.5320096131289, 660.9438197753245, 5222.164453687392, 5348.197770334481, 5736.282964629421, 5835.591508594358, 5843.678597677169, 105609.47195263974, 108127.0, 108668.0, 114171.0, 114598.0, 91066.54466727756, 93901.53049234847, 97277.36586143644, 97532.51233743927, 98716.50641746745, 82804.0, 83726.0, 85994.57002715071, 86161.1383886153, 89524.0, 11096.33421994683, 11188.776224475629, 11201.831972520582, 11635.360055197045, 11661.300321980709, 40348.0, 41159.38260926028, 41960.16079678328, 42974.140517190106, 43156.352654709575, 52153.47846521638, 52889.0, 55237.7238113823, 74845.25154748383, 77014.2298577007, 17346.132693365027, 17492.212850421507, 18079.0, 18400.631987360444, 18416.723749143504, 18859.6228075435, 19011.0, 19033.238670453025, 19155.80844191596, 19309.51726206856, 16153.515394538183, 16180.757288640445, 16241.0, 16266.837331627006, 16286.755698664292, 17166.227519761393, 17600.29598816033, 17640.823591763918, 17815.376461823773, 17820.108994549963, 16802.243899024328, 17080.23138958775, 17090.2309396075, 17114.14429278556, 17429.0, 11397.943010284895, 11583.420828958688, 11585.59450419265, 11776.11679124052, 12042.036637068839, 12838.55065072718, 12910.677233068873, 13012.089153759145, 13063.150895192162, 13943.790843137158], "value": 8239.68599414639, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1465.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 100.0, 105.0, 108.0, 108.0, 109.0, 98.0, 108.0, 107.0], "value": 104.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 119.0, 141.0, 166.0, 115.0, 144.0, 147.0, 116.0, 178.0, 120.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 161.0, 160.0, 162.0, 163.0, 170.0, 164.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 75.0, 104.0, 75.0, 73.0, 73.0, 89.0, 98.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 131.0, 80.0, 79.0, 79.0, 126.0, 80.0, 79.0, 125.0], "value": 93.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 113.0, 114.0, 115.0, 115.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0, 94.0], "value": 93.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 51.0, 51.0, 55.0, 50.0, 51.0, 52.0, 50.0, 50.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [39.0, 39.0, 39.0, 39.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 75.0, 74.0, 74.0, 79.0, 74.0, 74.0, 77.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 133.0, 115.0, 124.0, 128.0, 125.0, 115.0, 118.0, 121.0, 158.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 167.0, 169.0, 175.0, 169.0, 167.0, 171.0, 174.0, 167.0, 172.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 68.0, 63.0, 67.0, 63.0, 67.0, 63.0, 63.0], "value": 65.1, "unit": "score"}]}]} 11:33:17 INFO - Return code: 0 11:33:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:33:17 INFO - # TBPL SUCCESS # 11:33:17 INFO - Running post-action listener: _package_coverage_data 11:33:17 INFO - Running post-action listener: _resource_record_post_action 11:33:17 INFO - [mozharness: 2017-08-28 18:33:17.860246Z] Finished run-tests step (success) 11:33:17 INFO - Running post-run listener: _resource_record_post_run 11:33:17 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 532480; Write bytes: 441851904; Read time: 76; Write time: 286836 11:33:17 INFO - TinderboxPrint: CPU usage
13.1% 11:33:17 INFO - TinderboxPrint: I/O read bytes / time
532,480 / 76 11:33:17 INFO - TinderboxPrint: I/O write bytes / time
441,851,904 / 286,836 11:33:17 INFO - TinderboxPrint: CPU idle
8,251.8 (86.9%) 11:33:17 INFO - TinderboxPrint: CPU user
1,195.9 (12.6%) 11:33:17 INFO - TinderboxPrint: Swap in / out
0 / 0 11:33:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118317056; Read time: 0; Write time: 81736 11:33:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:33:17 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 528384; Write bytes: 323534848; Read time: 72; Write time: 205100 11:33:18 INFO - Running post-run listener: _upload_blobber_files 11:33:18 INFO - Blob upload gear active. 11:33:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:33:18 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 11:33:18 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'] 11:33:18 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 11:33:18 INFO - (blobuploader) - INFO - Open directory for files ... 11:33:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:33:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:33:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:22 INFO - (blobuploader) - INFO - Done attempting. 11:33:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:33:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:33:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:23 INFO - (blobuploader) - INFO - Done attempting. 11:33:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:33:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:24 INFO - (blobuploader) - INFO - Done attempting. 11:33:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:33:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:33:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:33:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:33:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:33:24 INFO - (blobuploader) - INFO - Done attempting. 11:33:24 INFO - (blobuploader) - INFO - Iteration through files over. 11:33:24 INFO - Return code: 0 11:33:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:33:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:33:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa2b655ff93787bf60752050ccca75c29427f8c3be9a93a13ce12dfd9f204ea0338927b145a0a5c5195d94397f40967950f8af6a5462760cbb9ad0c6872e9f9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176e0b5b88129fa2c553179f8bed1c3b3c4274bb833566eaf178a4740961cae432d0e7cd68dcaefc08596267d1e3c54df3f3a31b6496be62f945ece1e17ccf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f290e5c68149d86b65f6ecf8023796f2419c66ba90a7a3ee55bd9e2bd29a2565be5d8a251aca23c5915bed68c845b3c27412a55c158b7b38b7e942a6466fbd8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74ebb586f920e94ece93cdc3e93c130beb7bd143707bc86c0680c0199399b1aadbedcf1b713201e7b5726ca0a93e210026365ed1196beb49ed03ebb88ebf07c"} 11:33:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:33:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:33:24 INFO - Contents: 11:33:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa2b655ff93787bf60752050ccca75c29427f8c3be9a93a13ce12dfd9f204ea0338927b145a0a5c5195d94397f40967950f8af6a5462760cbb9ad0c6872e9f9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176e0b5b88129fa2c553179f8bed1c3b3c4274bb833566eaf178a4740961cae432d0e7cd68dcaefc08596267d1e3c54df3f3a31b6496be62f945ece1e17ccf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f290e5c68149d86b65f6ecf8023796f2419c66ba90a7a3ee55bd9e2bd29a2565be5d8a251aca23c5915bed68c845b3c27412a55c158b7b38b7e942a6466fbd8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74ebb586f920e94ece93cdc3e93c130beb7bd143707bc86c0680c0199399b1aadbedcf1b713201e7b5726ca0a93e210026365ed1196beb49ed03ebb88ebf07c"} 11:33:24 INFO - Running post-run listener: copy_logs_to_upload_dir 11:33:24 INFO - Copying logs to upload dir... 11:33:24 INFO - mkdir: /builds/slave/test/build/upload/logs 11:33:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.646543 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-08-28 11:33:25.030248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-28 11:33:25.036817) ========= 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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa2b655ff93787bf60752050ccca75c29427f8c3be9a93a13ce12dfd9f204ea0338927b145a0a5c5195d94397f40967950f8af6a5462760cbb9ad0c6872e9f9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176e0b5b88129fa2c553179f8bed1c3b3c4274bb833566eaf178a4740961cae432d0e7cd68dcaefc08596267d1e3c54df3f3a31b6496be62f945ece1e17ccf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f290e5c68149d86b65f6ecf8023796f2419c66ba90a7a3ee55bd9e2bd29a2565be5d8a251aca23c5915bed68c845b3c27412a55c158b7b38b7e942a6466fbd8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74ebb586f920e94ece93cdc3e93c130beb7bd143707bc86c0680c0199399b1aadbedcf1b713201e7b5726ca0a93e210026365ed1196beb49ed03ebb88ebf07c"} build_url:https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/RmbeUV6sREG6fr33Z_wCNQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa2b655ff93787bf60752050ccca75c29427f8c3be9a93a13ce12dfd9f204ea0338927b145a0a5c5195d94397f40967950f8af6a5462760cbb9ad0c6872e9f9", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45176e0b5b88129fa2c553179f8bed1c3b3c4274bb833566eaf178a4740961cae432d0e7cd68dcaefc08596267d1e3c54df3f3a31b6496be62f945ece1e17ccf", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f290e5c68149d86b65f6ecf8023796f2419c66ba90a7a3ee55bd9e2bd29a2565be5d8a251aca23c5915bed68c845b3c27412a55c158b7b38b7e942a6466fbd8", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e74ebb586f920e94ece93cdc3e93c130beb7bd143707bc86c0680c0199399b1aadbedcf1b713201e7b5726ca0a93e210026365ed1196beb49ed03ebb88ebf07c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-28 11:33:25.070829) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:33:25.071277) ========= 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=51fc86400edbde9650d2781a000001d0-1503943954.193519-706646617 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-28 11:33:25.155526) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-28 11:33:25.155945) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-28 11:33:25.156373) ========= ========= Total master_lag: 0.51 =========