builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1503338303.87 results: success (0) revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.866243) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.866801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.867078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.896375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:23.896684) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-21 10:58:24-- 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% 74.3K=0.2s 2017-08-21 10:58:24 (74.3 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.265954 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.182961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.183287) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018689 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.236723) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.237085) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a9d372645a32b8d23d44244f351639af9d73b96a --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 a9d372645a32b8d23d44244f351639af9d73b96a --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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-21 10:58:24,858 truncating revision to first 12 chars 2017-08-21 10:58:24,858 Setting DEBUG logging. 2017-08-21 10:58:24,858 attempt 1/10 2017-08-21 10:58:24,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a9d372645a32?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-21 10:58:25,146 unpacking tar archive at: mozilla-central-a9d372645a32/testing/mozharness/ program finished with exit code 0 elapsedTime=0.592908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.844875) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.845181) ========= script_repo_revision: a9d372645a32b8d23d44244f351639af9d73b96a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.845820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.846092) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-21 10:58:24.857049) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 10:58:24.857441) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:58:25 INFO - MultiFileLogger online at 20170821 10:58:25 in /builds/slave/test 10:58:25 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 10:58:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:58:25 INFO - {'append_to_log': False, 10:58:25 INFO - 'base_work_dir': '/builds/slave/test', 10:58:25 INFO - 'blob_upload_branch': 'Firefox', 10:58:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:58:25 INFO - 'branch': 'Firefox', 10:58:25 INFO - 'buildbot_json_path': 'buildprops.json', 10:58:25 INFO - 'code_coverage': False, 10:58:25 INFO - 'config_files': ('talos/linux_config.py',), 10:58:25 INFO - 'default_actions': ('clobber', 10:58:25 INFO - 'read-buildbot-config', 10:58:25 INFO - 'download-and-extract', 10:58:25 INFO - 'populate-webroot', 10:58:25 INFO - 'create-virtualenv', 10:58:25 INFO - 'install', 10:58:25 INFO - 'setup-mitmproxy', 10:58:25 INFO - 'run-tests'), 10:58:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:58:25 INFO - 'disable_ccov_upload': False, 10:58:25 INFO - 'download_minidump_stackwalk': True, 10:58:25 INFO - 'download_symbols': 'ondemand', 10:58:25 INFO - 'enable_stylo': False, 10:58:25 INFO - 'enable_webrender': False, 10:58:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:58:25 INFO - 'tooltool.py': '/tools/tooltool.py', 10:58:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:58:25 INFO - '/tools/misc-python/virtualenv.py')}, 10:58:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:58:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:58:25 INFO - 'gecko_profile': False, 10:58:25 INFO - 'gecko_profile_interval': 0, 10:58:25 INFO - 'installer_path': 'installer.exe', 10:58:25 INFO - 'log_level': 'info', 10:58:25 INFO - 'log_name': 'talos', 10:58:25 INFO - 'log_to_console': True, 10:58:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:58:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:58:25 INFO - 'opt_config_files': (), 10:58:25 INFO - 'pip_index': False, 10:58:25 INFO - 'suite': 'dromaeojs-e10s', 10:58:25 INFO - 'system_bits': '32', 10:58:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:58:25 INFO - 'title': 'talos-linux64-ix-005', 10:58:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:58:25 INFO - 'use_talos_json': True, 10:58:25 INFO - 'verify': 'False', 10:58:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:58:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:58:25 INFO - 'work_dir': 'build'} 10:58:25 INFO - [mozharness: 2017-08-21 17:58:25.627914Z] Running clobber step. 10:58:25 INFO - Running pre-action listener: _resource_record_pre_action 10:58:25 INFO - Running main action method: clobber 10:58:25 INFO - rmtree: /builds/slave/test/build 10:58:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:58:27 INFO - Running post-action listener: _resource_record_post_action 10:58:27 INFO - [mozharness: 2017-08-21 17:58:27.163288Z] Finished clobber step (success) 10:58:27 INFO - [mozharness: 2017-08-21 17:58:27.163386Z] Running read-buildbot-config step. 10:58:27 INFO - Running pre-action listener: _resource_record_pre_action 10:58:27 INFO - Running main action method: read_buildbot_config 10:58:27 INFO - Using buildbot properties: 10:58:27 INFO - { 10:58:27 INFO - "project": "", 10:58:27 INFO - "product": "firefox", 10:58:27 INFO - "who": "ffxbld@noreply.mozilla.org", 10:58:27 INFO - "installer_path": "public/build/target.tar.bz2", 10:58:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:58:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:58:27 INFO - "stage_platform": "linux64-stylosequential", 10:58:27 INFO - "basedir": "/builds/slave/test", 10:58:27 INFO - "buildnumber": 203, 10:58:27 INFO - "platform": "ubuntu64_hw_styloseq", 10:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:58:27 INFO - "slavebuilddir": "test", 10:58:27 INFO - "taskId": "LAYBfBZ1TpeBKpAuJrM34g", 10:58:27 INFO - "branch": "mozilla-central", 10:58:27 INFO - "script_repo_revision": "production", 10:58:27 INFO - "revision": "a9d372645a32b8d23d44244f351639af9d73b96a", 10:58:27 INFO - "slavename": "talos-linux64-ix-005", 10:58:27 INFO - "repo_path": "mozilla-central" 10:58:27 INFO - } 10:58:27 INFO - Finding installer, test and symbols from parent task. 10:58:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAYBfBZ1TpeBKpAuJrM34g'}, attempt #1 10:58:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LAYBfBZ1TpeBKpAuJrM34g'}, attempt #1 10:58:28 INFO - Task dependencies: MLlCFHQhSUSWzn2nnk1GfQ 10:58:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ'}, attempt #1 10:58:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:58:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json 10:58:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip 10:58:28 INFO - Running post-action listener: _resource_record_post_action 10:58:28 INFO - [mozharness: 2017-08-21 17:58:28.529751Z] Finished read-buildbot-config step (success) 10:58:28 INFO - [mozharness: 2017-08-21 17:58:28.529968Z] Running download-and-extract step. 10:58:28 INFO - Running pre-action listener: _resource_record_pre_action 10:58:28 INFO - Running main action method: download_and_extract 10:58:28 INFO - mkdir: /builds/slave/test/build/tests 10:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:28 INFO - trying https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json 10:58:28 INFO - Downloading https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:58:29 INFO - Downloaded 989 bytes. 10:58:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:58:29 INFO - Using the following test package requirements: 10:58:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:58:29 INFO - u'common': [u'target.common.tests.zip'], 10:58:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:58:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:58:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:58:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:58:29 INFO - u'mozbase': [u'target.common.tests.zip'], 10:58:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:58:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:58:29 INFO - u'web-platform': [u'target.common.tests.zip', 10:58:29 INFO - u'target.web-platform.tests.tar.gz'], 10:58:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:58:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:58:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip 10:58:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:29 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip into memory 10:58:31 INFO - Content-Length response header: 54005943 10:58:31 INFO - Bytes received: 54005943 10:58:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:58:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip 10:58:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:58:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.common.tests.zip into memory 10:58:44 INFO - Content-Length response header: 54005943 10:58:44 INFO - Bytes received: 54005943 10:58:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip 10:58:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:58:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.talos.tests.zip into memory 10:58:57 INFO - Content-Length response header: 14496256 10:58:57 INFO - Bytes received: 14496256 10:58:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:58:57 INFO - trying https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:59:01 INFO - Downloaded 62023543 bytes. 10:59:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:59:01 INFO - mkdir: /builds/slave/test/properties 10:59:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:01 INFO - Contents: 10:59:01 INFO - build_url:https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 10:59:01 INFO - Running post-action listener: _resource_record_post_action 10:59:01 INFO - Running post-action listener: find_tests_for_verification 10:59:01 INFO - Running post-action listener: set_extra_try_arguments 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.922285Z] Finished download-and-extract step (success) 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.922513Z] Running populate-webroot step. 10:59:01 INFO - Running pre-action listener: _resource_record_pre_action 10:59:01 INFO - Running main action method: populate_webroot 10:59:01 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:01 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:59:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:01 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:59:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:01 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['damp', 'tps']}, 10:59:01 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['damp', 'tps']}, 10:59:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:59:01 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:59:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:59:01 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:59:01 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:01 INFO - 'ts_paint', 10:59:01 INFO - 'tpaint', 10:59:01 INFO - 'sessionrestore', 10:59:01 INFO - 'sessionrestore_many_windows', 10:59:01 INFO - 'sessionrestore_no_auto_restore', 10:59:01 INFO - 'tabpaint']}, 10:59:01 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['a11yr', 10:59:01 INFO - 'ts_paint', 10:59:01 INFO - 'tpaint', 10:59:01 INFO - 'sessionrestore', 10:59:01 INFO - 'sessionrestore_many_windows', 10:59:01 INFO - 'sessionrestore_no_auto_restore', 10:59:01 INFO - 'tabpaint']}, 10:59:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:59:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:59:01 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['bloom_basic_singleton']}, 10:59:01 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['bloom_basic']}, 10:59:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:01 INFO - 'tsvgr_opacity', 10:59:01 INFO - 'tart', 10:59:01 INFO - 'tscrollx', 10:59:01 INFO - 'tsvg_static']}, 10:59:01 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tsvgx', 10:59:01 INFO - 'tsvgr_opacity', 10:59:01 INFO - 'tart', 10:59:01 INFO - 'tscrollx', 10:59:01 INFO - 'tsvg_static']}, 10:59:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:59:01 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo'], 10:59:01 INFO - 'tests': ['tp5o']}, 10:59:01 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--stylo-threads=1', 10:59:01 INFO - '--mitmproxy', 10:59:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:01 INFO - '--firstNonBlankPaint'], 10:59:01 INFO - 'tests': ['tp6_google', 10:59:01 INFO - 'tp6_youtube', 10:59:01 INFO - 'tp6_amazon', 10:59:01 INFO - 'tp6_facebook']}, 10:59:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--xperf_path', 10:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:01 INFO - 'tests': ['tp5n']}, 10:59:01 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 10:59:01 INFO - 'talos_options': ['--stylo', 10:59:01 INFO - '--xperf_path', 10:59:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:01 INFO - 'tests': ['tp5n']}}} 10:59:01 INFO - Running post-action listener: _resource_record_post_action 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.938555Z] Finished populate-webroot step (success) 10:59:01 INFO - [mozharness: 2017-08-21 17:59:01.938646Z] Running create-virtualenv step. 10:59:01 INFO - Running pre-action listener: _resource_record_pre_action 10:59:01 INFO - Running main action method: create_virtualenv 10:59:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:59:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:59:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:02 INFO - Using real prefix '/usr' 10:59:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:02 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:04 INFO - Installing pip.................done. 10:59:04 INFO - Return code: 0 10:59:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:04 INFO - Reading from file tmpfile_stdout 10:59:04 INFO - Output received: 10:59:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:59:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:04 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 10:59:04 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 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:59:04 INFO - Cleaning up... 10:59:04 INFO - Return code: 0 10:59:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:04 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:04 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 10:59:04 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 10:59:04 INFO - Using env: {'DISPLAY': ':0', 10:59:04 INFO - 'HOME': '/home/cltbld', 10:59:04 INFO - 'LANG': 'en_US.UTF-8', 10:59:04 INFO - 'LANGUAGE': 'en_US:en', 10:59:04 INFO - 'LOGNAME': 'cltbld', 10:59:04 INFO - 'MAIL': '/var/mail/cltbld', 10:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:04 INFO - 'MOZ_NO_REMOTE': '1', 10:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:04 INFO - 'NO_EM_RESTART': '1', 10:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:04 INFO - 'PWD': '/builds/slave/test', 10:59:04 INFO - 'SHELL': '/bin/bash', 10:59:04 INFO - 'SHLVL': '1', 10:59:04 INFO - 'TERM': 'linux', 10:59:04 INFO - 'TMOUT': '86400', 10:59:04 INFO - 'USER': 'cltbld', 10:59:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:04 INFO - '_': '/tools/buildbot/bin/python'} 10:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:05 INFO - Downloading/unpacking psutil>=3.1.1 10:59:05 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 10:59:05 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 10:59:05 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 10:59:05 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 10:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:06 INFO - Installing collected packages: psutil 10:59:06 INFO - Running setup.py install for psutil 10:59:06 INFO - building 'psutil._psutil_linux' extension 10:59:06 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 10:59:06 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 10:59:06 INFO - building 'psutil._psutil_posix' extension 10:59:06 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 10:59:06 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 10:59:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:06 INFO - Successfully installed psutil 10:59:06 INFO - Cleaning up... 10:59:06 INFO - Return code: 0 10:59:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:06 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:06 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 10:59:06 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 10:59:06 INFO - Using env: {'DISPLAY': ':0', 10:59:06 INFO - 'HOME': '/home/cltbld', 10:59:06 INFO - 'LANG': 'en_US.UTF-8', 10:59:06 INFO - 'LANGUAGE': 'en_US:en', 10:59:06 INFO - 'LOGNAME': 'cltbld', 10:59:06 INFO - 'MAIL': '/var/mail/cltbld', 10:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:06 INFO - 'MOZ_NO_REMOTE': '1', 10:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:06 INFO - 'NO_EM_RESTART': '1', 10:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:06 INFO - 'PWD': '/builds/slave/test', 10:59:06 INFO - 'SHELL': '/bin/bash', 10:59:06 INFO - 'SHLVL': '1', 10:59:06 INFO - 'TERM': 'linux', 10:59:06 INFO - 'TMOUT': '86400', 10:59:06 INFO - 'USER': 'cltbld', 10:59:06 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:06 INFO - '_': '/tools/buildbot/bin/python'} 10:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:07 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 10:59:07 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 10:59:07 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 10:59:07 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 10:59:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:08 INFO - Installing collected packages: mozsystemmonitor 10:59:08 INFO - Running setup.py install for mozsystemmonitor 10:59:08 INFO - Successfully installed mozsystemmonitor 10:59:08 INFO - Cleaning up... 10:59:08 INFO - Return code: 0 10:59:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59: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', '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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:59: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 jsonschema==2.5.1 10:59:08 INFO - Using env: {'DISPLAY': ':0', 10:59:08 INFO - 'HOME': '/home/cltbld', 10:59:08 INFO - 'LANG': 'en_US.UTF-8', 10:59:08 INFO - 'LANGUAGE': 'en_US:en', 10:59:08 INFO - 'LOGNAME': 'cltbld', 10:59:08 INFO - 'MAIL': '/var/mail/cltbld', 10:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:08 INFO - 'MOZ_NO_REMOTE': '1', 10:59:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:08 INFO - 'NO_EM_RESTART': '1', 10:59:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:08 INFO - 'PWD': '/builds/slave/test', 10:59:08 INFO - 'SHELL': '/bin/bash', 10:59:08 INFO - 'SHLVL': '1', 10:59:08 INFO - 'TERM': 'linux', 10:59:08 INFO - 'TMOUT': '86400', 10:59:08 INFO - 'USER': 'cltbld', 10:59:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:08 INFO - '_': '/tools/buildbot/bin/python'} 10:59:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:08 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:08 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 10:59:08 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 10:59:08 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 10:59:08 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 10:59:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:09 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 10:59:09 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 10:59:09 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 10:59:09 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 10:59:09 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:09 INFO - warning: no files found matching '*.txt' 10:59:09 INFO - no previously-included directories found matching 'build' 10:59:09 INFO - no previously-included directories found matching 'dist' 10:59:09 INFO - no previously-included directories found matching '.git*' 10:59:09 INFO - Installing collected packages: jsonschema, functools32 10:59:09 INFO - Running setup.py install for functools32 10:59:10 INFO - warning: no files found matching '*.txt' 10:59:10 INFO - no previously-included directories found matching 'build' 10:59:10 INFO - no previously-included directories found matching 'dist' 10:59:10 INFO - no previously-included directories found matching '.git*' 10:59:10 INFO - Successfully installed jsonschema functools32 10:59:10 INFO - Cleaning up... 10:59:10 INFO - Return code: 0 10:59:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59: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', '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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:59: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 functools32==3.2.3-2 10:59:10 INFO - Using env: {'DISPLAY': ':0', 10:59:10 INFO - 'HOME': '/home/cltbld', 10:59:10 INFO - 'LANG': 'en_US.UTF-8', 10:59:10 INFO - 'LANGUAGE': 'en_US:en', 10:59:10 INFO - 'LOGNAME': 'cltbld', 10:59:10 INFO - 'MAIL': '/var/mail/cltbld', 10:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:10 INFO - 'MOZ_NO_REMOTE': '1', 10:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:10 INFO - 'NO_EM_RESTART': '1', 10:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:10 INFO - 'PWD': '/builds/slave/test', 10:59:10 INFO - 'SHELL': '/bin/bash', 10:59:10 INFO - 'SHLVL': '1', 10:59:10 INFO - 'TERM': 'linux', 10:59:10 INFO - 'TMOUT': '86400', 10:59:10 INFO - 'USER': 'cltbld', 10:59:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:10 INFO - '_': '/tools/buildbot/bin/python'} 10:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:10 INFO - Cleaning up... 10:59:10 INFO - Return code: 0 10:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59: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', '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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:59: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 blobuploader==1.2.4 10:59:10 INFO - Using env: {'DISPLAY': ':0', 10:59:10 INFO - 'HOME': '/home/cltbld', 10:59:10 INFO - 'LANG': 'en_US.UTF-8', 10:59:10 INFO - 'LANGUAGE': 'en_US:en', 10:59:10 INFO - 'LOGNAME': 'cltbld', 10:59:10 INFO - 'MAIL': '/var/mail/cltbld', 10:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:10 INFO - 'MOZ_NO_REMOTE': '1', 10:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:10 INFO - 'NO_EM_RESTART': '1', 10:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:10 INFO - 'PWD': '/builds/slave/test', 10:59:10 INFO - 'SHELL': '/bin/bash', 10:59:10 INFO - 'SHLVL': '1', 10:59:10 INFO - 'TERM': 'linux', 10:59:10 INFO - 'TMOUT': '86400', 10:59:10 INFO - 'USER': 'cltbld', 10:59:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:10 INFO - '_': '/tools/buildbot/bin/python'} 10:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:10 INFO - Downloading/unpacking blobuploader==1.2.4 10:59: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 10:59: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 10:59: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 10:59: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 10:59:11 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 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 10:59:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59: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 10:59: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 10:59: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 10:59: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 10:59:12 INFO - Downloading docopt-0.6.1.tar.gz 10:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:12 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:12 INFO - Running setup.py install for blobuploader 10:59:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:12 INFO - Running setup.py install for requests 10:59:12 INFO - Running setup.py install for docopt 10:59:12 INFO - Successfully installed blobuploader requests docopt 10:59:12 INFO - Cleaning up... 10:59:12 INFO - Return code: 0 10:59:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:12 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:12 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 10:59:12 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 10:59:12 INFO - Using env: {'DISPLAY': ':0', 10:59:12 INFO - 'HOME': '/home/cltbld', 10:59:12 INFO - 'LANG': 'en_US.UTF-8', 10:59:12 INFO - 'LANGUAGE': 'en_US:en', 10:59:12 INFO - 'LOGNAME': 'cltbld', 10:59:12 INFO - 'MAIL': '/var/mail/cltbld', 10:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:12 INFO - 'MOZ_NO_REMOTE': '1', 10:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:12 INFO - 'NO_EM_RESTART': '1', 10:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:12 INFO - 'PWD': '/builds/slave/test', 10:59:12 INFO - 'SHELL': '/bin/bash', 10:59:12 INFO - 'SHLVL': '1', 10:59:12 INFO - 'TERM': 'linux', 10:59:12 INFO - 'TMOUT': '86400', 10:59:12 INFO - 'USER': 'cltbld', 10:59:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:12 INFO - '_': '/tools/buildbot/bin/python'} 10:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:13 INFO - Running setup.py (path:/tmp/pip-4Al853-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:13 INFO - Running setup.py (path:/tmp/pip-xkc4wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:13 INFO - Running setup.py (path:/tmp/pip-Ampv3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:13 INFO - Running setup.py (path:/tmp/pip-Sw2tcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:13 INFO - Running setup.py (path:/tmp/pip-VkEzAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:13 INFO - Running setup.py (path:/tmp/pip-co9US_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:13 INFO - Running setup.py (path:/tmp/pip-nTcGfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:13 INFO - Running setup.py (path:/tmp/pip-0Bmbxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:13 INFO - Running setup.py (path:/tmp/pip-EDGfs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:13 INFO - Running setup.py (path:/tmp/pip-d_p0Jp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:13 INFO - Running setup.py (path:/tmp/pip-IHBQXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:13 INFO - Running setup.py (path:/tmp/pip-MZGagT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:13 INFO - Running setup.py (path:/tmp/pip-8qxnNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:13 INFO - Running setup.py (path:/tmp/pip-Q2vKgC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:14 INFO - Running setup.py (path:/tmp/pip-uYKWat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:14 INFO - Running setup.py (path:/tmp/pip-x7q_ID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:14 INFO - Running setup.py (path:/tmp/pip-53kclU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:14 INFO - Running setup.py install for manifestparser 10:59:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:14 INFO - Running setup.py install for mozcrash 10:59:14 INFO - Running setup.py install for mozdebug 10:59:14 INFO - Running setup.py install for mozdevice 10:59:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:14 INFO - Running setup.py install for mozfile 10:59:14 INFO - Running setup.py install for mozhttpd 10:59:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:14 INFO - Running setup.py install for mozinfo 10:59:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:14 INFO - Running setup.py install for mozInstall 10:59:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozleak 10:59:15 INFO - Running setup.py install for mozlog 10:59:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for moznetwork 10:59:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozprocess 10:59:15 INFO - Running setup.py install for mozprofile 10:59:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozrunner 10:59:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Running setup.py install for mozscreenshot 10:59:15 INFO - Running setup.py install for moztest 10:59:15 INFO - Running setup.py install for mozversion 10:59:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:15 INFO - Cleaning up... 10:59:16 INFO - Return code: 0 10:59:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:16 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:16 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 10:59:16 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 10:59:16 INFO - Using env: {'DISPLAY': ':0', 10:59:16 INFO - 'HOME': '/home/cltbld', 10:59:16 INFO - 'LANG': 'en_US.UTF-8', 10:59:16 INFO - 'LANGUAGE': 'en_US:en', 10:59:16 INFO - 'LOGNAME': 'cltbld', 10:59:16 INFO - 'MAIL': '/var/mail/cltbld', 10:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:16 INFO - 'MOZ_NO_REMOTE': '1', 10:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:16 INFO - 'NO_EM_RESTART': '1', 10:59:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:16 INFO - 'PWD': '/builds/slave/test', 10:59:16 INFO - 'SHELL': '/bin/bash', 10:59:16 INFO - 'SHLVL': '1', 10:59:16 INFO - 'TERM': 'linux', 10:59:16 INFO - 'TMOUT': '86400', 10:59:16 INFO - 'USER': 'cltbld', 10:59:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:16 INFO - '_': '/tools/buildbot/bin/python'} 10:59:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:16 INFO - Running setup.py (path:/tmp/pip-JK1NA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:16 INFO - Running setup.py (path:/tmp/pip-oiFO2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:16 INFO - Running setup.py (path:/tmp/pip-4sgynB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:16 INFO - Running setup.py (path:/tmp/pip-4A2a0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:16 INFO - Running setup.py (path:/tmp/pip-ochYz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:16 INFO - Running setup.py (path:/tmp/pip-xqV3SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:16 INFO - Running setup.py (path:/tmp/pip-gdipq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:16 INFO - Running setup.py (path:/tmp/pip-8wRBl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:16 INFO - Running setup.py (path:/tmp/pip-yLrz2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:16 INFO - Running setup.py (path:/tmp/pip-eZunAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:16 INFO - Running setup.py (path:/tmp/pip-vc7tR6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:16 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)) 10:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:17 INFO - Running setup.py (path:/tmp/pip-ICVeCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:17 INFO - Running setup.py (path:/tmp/pip-MxAXwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:17 INFO - Running setup.py (path:/tmp/pip-upvRDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:17 INFO - Running setup.py (path:/tmp/pip-cegIFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:17 INFO - Running setup.py (path:/tmp/pip-osr7Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:17 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)) 10:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:17 INFO - Running setup.py (path:/tmp/pip-VKyDPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 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)) 10:59:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59: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 10:59: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 10:59: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 10:59: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 10:59:18 INFO - Downloading blessings-1.6.tar.gz 10:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:18 INFO - Installing collected packages: blessings 10:59:18 INFO - Running setup.py install for blessings 10:59:18 INFO - Successfully installed blessings 10:59:18 INFO - Cleaning up... 10:59:18 INFO - Return code: 0 10:59:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:18 INFO - Reading from file tmpfile_stdout 10:59:18 INFO - Current package versions: 10:59:18 INFO - argparse == 1.2.1 10:59:18 INFO - blessings == 1.6 10:59:18 INFO - blobuploader == 1.2.4 10:59:18 INFO - docopt == 0.6.1 10:59:18 INFO - functools32 == 3.2.3-2 10:59:18 INFO - jsonschema == 2.5.1 10:59:18 INFO - manifestparser == 1.1 10:59:18 INFO - mozInstall == 1.13 10:59:18 INFO - mozcrash == 1.0 10:59:18 INFO - mozdebug == 0.1 10:59:18 INFO - mozdevice == 0.51 10:59:18 INFO - mozfile == 1.2 10:59:18 INFO - mozhttpd == 0.7 10:59:18 INFO - mozinfo == 0.10 10:59:18 INFO - mozleak == 0.1 10:59:18 INFO - mozlog == 3.5 10:59:18 INFO - moznetwork == 0.27 10:59:18 INFO - mozprocess == 0.25 10:59:18 INFO - mozprofile == 0.28 10:59:18 INFO - mozrunner == 6.13 10:59:18 INFO - mozscreenshot == 0.1 10:59:18 INFO - mozsystemmonitor == 0.3 10:59:18 INFO - moztest == 0.8 10:59:18 INFO - mozversion == 1.4 10:59:18 INFO - psutil == 3.1.1 10:59:18 INFO - requests == 1.2.3 10:59:18 INFO - wsgiref == 0.1.2 10:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:18 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')]} 10:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:18 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')]} 10:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:18 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:18 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 10:59:18 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 10:59:19 INFO - Using env: {'DISPLAY': ':0', 10:59:19 INFO - 'HOME': '/home/cltbld', 10:59:19 INFO - 'LANG': 'en_US.UTF-8', 10:59:19 INFO - 'LANGUAGE': 'en_US:en', 10:59:19 INFO - 'LOGNAME': 'cltbld', 10:59:19 INFO - 'MAIL': '/var/mail/cltbld', 10:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:19 INFO - 'MOZ_NO_REMOTE': '1', 10:59:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:19 INFO - 'NO_EM_RESTART': '1', 10:59:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:19 INFO - 'PWD': '/builds/slave/test', 10:59:19 INFO - 'SHELL': '/bin/bash', 10:59:19 INFO - 'SHLVL': '1', 10:59:19 INFO - 'TERM': 'linux', 10:59:19 INFO - 'TMOUT': '86400', 10:59:19 INFO - 'USER': 'cltbld', 10:59:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:19 INFO - '_': '/tools/buildbot/bin/python'} 10:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 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)) 10:59:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:59:20 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)) 10:59:20 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)) 10:59:20 INFO - Installing collected packages: simplejson 10:59:20 INFO - Running setup.py install for simplejson 10:59:20 INFO - building 'simplejson._speedups' extension 10:59:20 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 10:59:21 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 10:59:21 INFO - Successfully installed simplejson 10:59:21 INFO - Cleaning up... 10:59:21 INFO - Return code: 0 10:59:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59: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')]} 10:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59: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')]} 10:59:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:21 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 0x17ae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1979a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b1cf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', '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 10:59:21 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 10:59:21 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 10:59:21 INFO - Using env: {'DISPLAY': ':0', 10:59:21 INFO - 'HOME': '/home/cltbld', 10:59:21 INFO - 'LANG': 'en_US.UTF-8', 10:59:21 INFO - 'LANGUAGE': 'en_US:en', 10:59:21 INFO - 'LOGNAME': 'cltbld', 10:59:21 INFO - 'MAIL': '/var/mail/cltbld', 10:59:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:21 INFO - 'MOZ_NO_REMOTE': '1', 10:59:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:21 INFO - 'NO_EM_RESTART': '1', 10:59:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:21 INFO - 'PWD': '/builds/slave/test', 10:59:21 INFO - 'SHELL': '/bin/bash', 10:59:21 INFO - 'SHLVL': '1', 10:59:21 INFO - 'TERM': 'linux', 10:59:21 INFO - 'TMOUT': '86400', 10:59:21 INFO - 'USER': 'cltbld', 10:59:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:21 INFO - '_': '/tools/buildbot/bin/python'} 10:59:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:21 INFO - Cleaning up... 10:59:21 INFO - Return code: 0 10:59:21 INFO - Running post-action listener: _resource_record_post_action 10:59:21 INFO - Running post-action listener: _start_resource_monitoring 10:59:21 INFO - Starting resource monitoring. 10:59:21 INFO - [mozharness: 2017-08-21 17:59:21.690747Z] Finished create-virtualenv step (success) 10:59:21 INFO - [mozharness: 2017-08-21 17:59:21.691266Z] Running install step. 10:59:21 INFO - Running pre-action listener: _resource_record_pre_action 10:59:21 INFO - Running main action method: install 10:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:21 INFO - Reading from file tmpfile_stdout 10:59:21 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:22 INFO - Reading from file tmpfile_stdout 10:59:22 INFO - Output received: 10:59:22 INFO - Usage: mozinstall [options] installer 10:59:22 INFO - Options: 10:59:22 INFO - -h, --help show this help message and exit 10:59:22 INFO - -d DEST, --destination=DEST 10:59:22 INFO - Directory to install application into. [default: 10:59:22 INFO - "/builds/slave/test"] 10:59:22 INFO - --app=APP Application being installed. [default: firefox] 10:59:22 INFO - mkdir: /builds/slave/test/build/application 10:59:22 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'] 10:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:59:40 INFO - Reading from file tmpfile_stdout 10:59:40 INFO - Output received: 10:59:40 INFO - /builds/slave/test/build/application/firefox/firefox 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.018596Z] Finished install step (success) 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.018848Z] Running setup-mitmproxy step. 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running main action method: setup_mitmproxy 10:59:40 INFO - Skipping: mitmproxy is not required 10:59:40 INFO - Running post-action listener: _resource_record_post_action 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.019982Z] Finished setup-mitmproxy step (success) 10:59:40 INFO - [mozharness: 2017-08-21 17:59:40.020200Z] Running run-tests step. 10:59:40 INFO - Running pre-action listener: _resource_record_pre_action 10:59:40 INFO - Running pre-action listener: _set_gcov_prefix 10:59:40 INFO - Running main action method: run_tests 10:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:59:40 INFO - Python 2.7.3 10:59:40 INFO - Return code: 0 10:59:40 INFO - grabbing minidump binary from tooltool 10:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:40 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b1a130>, '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 0x1b1b030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b1b4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:59:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:59:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:59:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:59:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:59:40 INFO - Return code: 0 10:59:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:59:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:59:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:59:40 INFO - ENV: RUST_BACKTRACE is now full 10:59:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:59:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:59:40 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:59:40 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 10:59:40 INFO - Using env: {'DISPLAY': ':0', 10:59:40 INFO - 'HOME': '/home/cltbld', 10:59:40 INFO - 'LANG': 'en_US.UTF-8', 10:59:40 INFO - 'LANGUAGE': 'en_US:en', 10:59:40 INFO - 'LOGNAME': 'cltbld', 10:59:40 INFO - 'MAIL': '/var/mail/cltbld', 10:59:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:59:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:40 INFO - 'MOZ_NO_REMOTE': '1', 10:59:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:40 INFO - 'NO_EM_RESTART': '1', 10:59:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:40 INFO - 'PWD': '/builds/slave/test', 10:59:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:59:40 INFO - 'RUST_BACKTRACE': 'full', 10:59:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:59:40 INFO - 'SHELL': '/bin/bash', 10:59:40 INFO - 'SHLVL': '1', 10:59:40 INFO - 'STYLO_FORCE_ENABLED': '1', 10:59:40 INFO - 'TERM': 'linux', 10:59:40 INFO - 'TMOUT': '86400', 10:59:40 INFO - 'USER': 'cltbld', 10:59:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400', 10:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:40 INFO - '_': '/tools/buildbot/bin/python'} 10:59:40 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/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 10:59:40 INFO - mozversion application_buildid: 20170821171611 10:59:40 INFO - mozversion application_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 10:59:40 INFO - mozversion application_display_name: Nightly 10:59:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:59:40 INFO - mozversion application_name: Firefox 10:59:40 INFO - mozversion application_remotingname: firefox 10:59:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:59:40 INFO - mozversion application_vendor: Mozilla 10:59:40 INFO - mozversion application_version: 57.0a1 10:59:40 INFO - mozversion platform_buildid: 20170821171611 10:59:40 INFO - mozversion platform_changeset: a9d372645a32b8d23d44244f351639af9d73b96a 10:59:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:59:40 INFO - mozversion platform_version: 57.0a1 10:59:40 INFO - using testdate: 1503338380 10:59:40 INFO - actual date: 1503338380 10:59:40 INFO - starting webserver on 'localhost:57071' 10:59:40 INFO - SUITE-START | Running 2 tests 10:59:40 INFO - TEST-START | dromaeo_css 10:59:40 INFO - Initialising browser for dromaeo_css test... 10:59:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57071/getInfo.html -profile /tmp/tmpb2lBu8/profile 10:59:40 INFO - TEST-INFO | started process 8339 (/builds/slave/test/build/application/firefox/firefox http://localhost:57071/getInfo.html) 10:59:46 INFO - TEST-INFO | 8339: exit 0 10:59:46 INFO - Browser initialized. 10:59:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:59:46 INFO - TEST-INFO | started process 8526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb2lBu8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:59:47 INFO - PID 8526 | 10:59:47 INFO - PID 8526 | (/builds/slave/test/build/application/firefox/firefox:8575): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:47 INFO - PID 8526 | 10:59:47 INFO - PID 8526 | 10:59:47 INFO - PID 8526 | (/builds/slave/test/build/application/firefox/firefox:8638): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:59:47 INFO - PID 8526 | 10:59:47 INFO - PID 8526 | __metrics Screen width/height:1600/1200 10:59:47 INFO - PID 8526 | colorDepth:24 10:59:47 INFO - PID 8526 | Browser inner width/height: 1024/768 10:59:47 INFO - PID 8526 | __metrics 10:59:57 INFO - PID 8526 | RSS: Main: 174796800 10:59:57 INFO - PID 8526 | 11:02:56 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57071/tests/dromaeo/cssquery-ext.html) 11:02:57 INFO - PID 8526 | RSS: Main: 178872320 11:02:57 INFO - PID 8526 | 11:05:59 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-ext.html (next: http://localhost:57071/tests/dromaeo/cssquery-jquery.html) 11:05:59 INFO - PID 8526 | RSS: Main: 175640576 11:05:59 INFO - PID 8526 | 11:09:01 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57071/tests/dromaeo/cssquery-mootools.html) 11:09:02 INFO - PID 8526 | RSS: Main: 177836032 11:09:02 INFO - PID 8526 | 11:12:04 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57071/tests/dromaeo/cssquery-prototype.html) 11:12:04 INFO - PID 8526 | RSS: Main: 175964160 11:12:04 INFO - PID 8526 | 11:15:08 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57071/tests/dromaeo/cssquery-yui.html) 11:15:09 INFO - PID 8526 | RSS: Main: 178851840 11:15:09 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | Cycle 1(1): loaded http://localhost:57071/tests/dromaeo/cssquery-yui.html (next: http://localhost:57071/tests/dromaeo/cssquery-dojo.html) 11:18:11 INFO - PID 8526 | RSS: Main: 177807360 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | __start_tp_report 11:18:11 INFO - PID 8526 | _x_x_mozilla_page_load 11:18:11 INFO - PID 8526 | _x_x_mozilla_page_load_details 11:18:11 INFO - PID 8526 | |i|pagename|runs| 11:18:11 INFO - PID 8526 | |0;dojo.html;3165;3180.650128485867;3196.3767065422253;3215.3890760755453;3222.5810644616195;6127.662978536178;6242;6243.531735119867;6261.123442718017;6283.308836028044;6085.148079268906;6167.629942203471;6195.31851496335;6332.1135041094285;6349.460295874845;5733.684647344395;5734.397888221739;5752.108423194411;5792.739326730297;5807.303123625171;932.8469772170067;5649.887002259952;5686.545076393879;5771.682557459338;5779.682117483537;5691.51622112121;5731.111677689964;5771.855703607402;5816.825495235171;5820.068788993741;5721.284839395075;5728.369879313273;5806.82579522615;5814.709264536757;5819.418058194189;5660.433956604348;5673.063944449161;5708.115242137475;5755.22304488897;5764.913526297109;6073.635581865058;6137.693115344259;6239.500839932794;6258.937410625881;6260.436560709558;6572.4084832365315;6620.23867255267;6687.164104486939;6741.662916854138;6753.628550429725;6751.223609284946;6781.966090169518;6835.692393842289;6839.487038472134;6840.897386539206;6219.129321894939;6223.937760622426;6304.968475157641;6305.747770089145;6323.05154226865;6763.256041835394;6854.828629284208;6916.827079323057;6963.651817409109;6980.7905762827195;6544.770933017417;6557.868842623217;6569.57297775643;6577.736890524421;6598.86802263952;6681.799546013627;6686.933130668631;6766.357196066366;6772.153480814898;6778.830529236809;6605.504587155982;6648.16897887764;6652.135222421054;6685.966570167216;6743.730250790011;6528.869422611521;6624.039514270404;6626.503012274099;6627.569208001464;6628.171478565179;5362.758675859595;5373.677579345252;5376.274202982626;5389.164679474688;5438.700871452108;4652.371929789503;4675.509071547506;4680.040591678698;4730.053989202104;4739.810407583727;5797.36229014808;5809.477147056785;5862.618929769551;5905.940940590625;5916.615419997686;6384;6462.935370646233;6721.059051732761;6735.393814556714;6849.589024658537;5838.095095260242;5845.415458454206;5848.4151584841175;5858.238429004287;5868.882622347529;5885.823425297248;5912.146974495219;5979.79070732531;5985.46130848217;5993.9700301498215;6503.349665033554;6521.380468855451;6595.8351041223395;6597.703103360361;6612.173478315211;6545.574537655038;6620.271770105381;6653.068570400051;6697.196336439659;6789.287124852017;6499.0901273820755;6518.152640156749;6550.312217217314;6597.60414375139;6599.8020059398295;6584.242812076673;6599.307072757291;6605.966970165118;6700.497462690415;6709.7651582194385;6608.471322294109;6744.291849355747;6746.4265537429865;6843.213030501357;6851.314868513109;6479.5788273762055;6507.219133703797;6517.315681853527;6524.119243902012;6525.543211975306;6508.576942498722;6563.638999855054;6586.110875032001;6605.702743376656;6606.933930660632;6419.807405777834;6459.90181669108;6529.118568993315;6538;6554.31179726141;6567.113439685581;6587.736490540325;6680.532362734756;6690.565113267622;6694.665266736546;6239.1577137085915;6333.809985700436;6360.077788720702;6371.49028077762;6378.489720822416 11:18:11 INFO - PID 8526 | |1;ext.html;812.2243257688908;826.4297634632103;844.5861527851353;878.5738916625431;880.8810810540575;41337.79331103344;42145.36781948273;42148.578514214845;42381.788091059505;42392.36411453831;38297.61702382976;38595.99999999993;38641.806790966075;38656.613433865656;38667;6986.266442023591;7105.43156547475;7107.751228706997;7113.075300210991;7114.537555058904;7019.684114214872;7058.2588828173075;7099.396551293146;7104.78685639429;7107.0760801095785;7764.145943946161;8003.439759216857;8004.239597238253;8004.759857204293;8010.439269251155;7875.606219689022;7910.050793904711;7932.999999999971;7934.246246606592;7935.64289606969;7267.527610705287;7872.252136047066;7879.566623835687;7883.526988380716;7887.171846956102;39501.60498395008;39793;39882;39890;39900.401493977326;3458.1354661334667;3513.6662017108333;3515.9979405869462;3519.7008254298416;3520.137566296248;31651.575679094494;31760.841195794103;31793.52309715356;31837.681623183704;31846.522302165486;4915.827946021872;4924.162892308316;4944.901101977976;4958.504149585049;4969.776360063805;178738;180515;181702;182414;196552;50257.989680413106;50416;50881;50913.49086509162;50950.23574646383;52611.736941315816;52708.20937685938;52772;53015.734921325915;53197.46802532003;16691.49925502237;16826.747598786027;16832.495025149266;16834.410795622338;16948.91525542389;13907.79138312926;13918.164910105426;13918.930405348112;13919.164850108824;13934.651633709238;14693.92653036728;14730.55808325752;14774.261286935825;14819.184944827923;14969.925150374396;5861.648301101947;5885.675722962299;5886.264216972879;5911.881762364815;6026.578139530191;958.8705524754208;967.5065716484644;982.1651596143221;995.4723996281982;996.7358649957768;22682.43293917665;28841.42317153645;29713.108606741833;29746;30430.391392172034;1090.9454527273763;1092.448313601626;1098.319042193845;1105.5190991918541;1113.3542545323692;12437.564685236155;12554.058445616616;12723.618291451272;12821.807672884914;12852.678683032998;231655;233425;234259;235008;235414;48720;49057.75471122622;49132.754336228805;49405.25892111621;49437.75281123571;1413.8727514523537;1446.0889639527031;1461.291273732239;1465.5383554180398;1479.3934486860335;22926.656100158176;22947.770522294562;23049;23340.53318933578;23424.765752342257;38216.04459888525;38347;38382;38383.42424863573;38475.807620961714;203144;203280;203288;203346;204089;34615.13462163466;37786.62213377831;39949.60050399575;39991.40012899867;40071.19857602773;48320;48781.756091219315;48931.75534122306;49108.508914910395;49128.50871491382;35776.28447430985;35793.28413431769;36465.63534364622;36824.26351473009;36925.815370922974;35531;35531.289374211854;35785.46321805123;35800;36120;39144;39257.2148557033;39447.2110557793;39534.604653953094;39655.60344396519;34713.65286347104;35670.108247292985;35839.64160358467;35961.1009724759;36230;25074.874625626755;25084.62373064442;25203.243902682214;25881.611775823;25963.74036259613 11:18:11 INFO - PID 8526 | |2;jquery.html;575.9251297331347;581.4069648958063;585.6164212440851;589.831897909096;595.6336852835506;21863.344099677037;22983.42541436463;23662.64506032411;23689.289321320368;23767;26523.469530609374;26823.86588067062;26997.46005079902;27021.86489067557;27127.593086103676;6556.803295901119;6690.7323707051655;6694.564853284545;6695.397414232718;6702.530822842403;5890.852728681774;6423.389777971085;6431.1317972073875;6593;6681.164854393201;6372.776952806653;6380.3300653431415;6383.297837237923;6399.008153736178;6399.392057754506;6372.1397611322345;6382.266039405481;6385.553011289212;6398.744050237985;6422.293547709748;5964.1650168976375;5990.97004514979;5991.460768530853;5993.580449368546;5994.07091900756;29203.70796292031;30026.549601755993;30582;31139;31478;1951.4731022623955;1984.3848406993877;1985.2852972929734;1988.1649707123042;1997.1911375892787;19230.519237019045;19411.22355105794;20213.898930505402;20349;20420.38738837837;2382.2614989353356;2383.2254517281954;2434.1358817619844;2436.902523899042;2447.49826285611;140901;146307;146665;146867;146901.26549367292;15119.924400377928;15254.23728813555;15284.923575382274;15304.933833932499;15311.15788631636;24290.271291861274;24410.38974025628;24432.633510497355;24433.511329773304;24476.14333498319;10403.58385664565;10549.9472502637;10719.83920241197;10786.838197427045;10843.403612801214;9999.850002249972;10005.199584033406;10037.146842518321;10094.899051009543;10118.595256189818;9230.723078307661;9369.203617692436;9436.197923176607;9581.137697607248;9720.75698107553;2641.564141916601;2651.270900502377;2744.890204391802;2757.7931655125944;2844.7866410019333;951.5432592355708;975.1808480876098;981.2640519610293;988.1452543549777;988.8763904511936;19753.901230493757;19810.306639267845;19948.60102797936;20134.69797953032;20400.387988360373;1008.566316483919;1018.4856647393019;1028.5525796278644;1032.3702541449709;1038.4651904269308;10767.19246056549;10988;11055.778884422267;11310.60412885545;11419.208972022085;483685;485340;492715;500297;503066;117474;117947;119683;120039;120258.39870800765;1064.3401091323428;1095.7863216672831;1115.0354942974268;1197.550918405598;1230.6062060140848;20783.79216207879;20803.271885483937;20890.268840590506;20907.37277881666;20964.371068867957;58538.7073064632;59004;60304.39695602988;60611.09083363665;61723;73012;73274.26725732887;73340.63329683317;73860.63069684617;74112.62943685247;14583.270836458347;15197.012194207342;15221.391144354102;15228.543143705707;15339;23742.287731368087;24039;24138.155164569154;24239.151629692875;24422;18556.164972575996;18847.811521884607;19235.615287693887;19304.710429343853;19318.903405482884;15638.765418518504;15652.765208522109;15691.686166276382;15821.129837859029;16389.918050409673;18891.622167556296;19377;19541.413757587296;19548;19594.216231350587;14878.330475128429;14999.850001500281;15034;15079.623009424851;15117.773233401287;18500.444986650422;18926.3375781847;18978.620427591093;19059.332923347618;19083.809161908204 11:18:11 INFO - PID 8526 | |3;mootools.html;1313.835770528684;1378.772892126008;1385.0304786649342;1386.3830595385054;1387.5143699705097;12570.43433045513;14204.43182272709;14774.63063423415;14785.852141478583;14823.110613363206;12600.117991740559;12765.106442549002;13270.601881943532;14280.571582852532;14338.784918226209;2550.247676935304;2599.9870000650067;2609.2694045667245;2610.0342873136965;2610.37351035751;2632.736726327371;2677.063027940225;2722.3602453423428;2724.5368287391093;2726.3047922779665;2763.3782398960275;2803.1590522843167;2808.6910439851704;2811.0442449567145;2813.4935711571907;2696.91909242723;2710.1598504463677;2713.3894873653467;2714.0772137473155;2719.9320016999536;2586.8059895507913;2615.1500762252153;2629.6449979252748;2645.0742240215964;2681.3832818451865;14371.496997605138;14436.123303970417;14469.638259043502;14478.348474318682;14496.275186240646;7543.2079631638435;7812.414068944852;7840.490368126054;7844.294013538752;7845.568493732842;5040.873978150576;5159.845204643867;5186.740662966837;5229.137192363255;5273.841784746463;1751.2557163205713;1787.830156135165;1797.7752780902388;1814.4556633010177;1815.509812350658;24077.87961060201;24751.752482475124;24753.62869556958;24795.504089918282;24813.379665508506;6876;6963.79108626742;7034.964825175842;7157.105361829771;7165.6417179140835;15910.840891590937;16811.915940420466;16819.579510512336;19191.808081919004;19202.903985479985;7679.462437629312;7861.606919654108;7909.604519773989;7917.920820791834;7924.762257132295;7105.857882842314;7187.209406965229;7256.854862902713;7260.782176534713;7326.3406293433845;5128;5298.417174110845;5304.257403963448;5312.203169524525;5345.679259244458;1531.257340190007;1548.2800497768592;1560.8907376483764;1563.7185306644913;1572.3789103304132;799.5962039170298;806.2944923192207;819.4386845011186;822.2394285286086;844.6030365728097;7058.752943646948;7065.540739851996;7073;7084.220735719066;7090.858182836314;720.9855802883912;721.8231533274381;723.9167495737952;727.5307426709743;729.8211938075206;4691.249400095969;4769.618430525619;4996.275540046673;5023.698578085254;5044.9495505045215;18279.360222392417;18920.33778817762;19304.227830886888;20023.59952800936;20060.59878802416;19538.70691939622;19574.804251957583;19586.216551337788;19734.30929917446;19820;10579.153667706565;10635.89364106349;10804.837927431096;10879.184061195283;10915.454227288763;8246.752597422086;8258.628361723857;8301.418900676894;8444.240018398374;8730.432521886058;16924.66150677004;17235.3967611133;17318.653626927644;18072.457826265232;18113.275468981094;17861;18149.18328675239;18220;18257.817421826145;18347.724784128517;11861.110416718608;11909;12055.638330850088;12115.697107572381;12146.149769516049;13554.254516001714;13561.796573051215;13631.522896698569;13760;13765.793513097511;10772.407517586607;10829.837552436877;10841.07850832688;11024.448777560929;11101.833472497758;10750.73123171927;10876.673699789018;10961.50673219691;10996.835047474455;11137.443127843737;9202.493862837608;9489.478078705737;9495.19290860257;9502.382345147544;9504.144626983605;6784.491163162881;6868.965655171693;6892.448604111559;6900.2409734930125;6906.067680863019;6951.582905025714;6956.165260168812;7004.929950700428;7028.578285302899;7062.964685176541 11:18:11 INFO - PID 8526 | |4;prototype.html;490.24210645963166;502.9245613158026;525.582162181066;526.8208809004939;532.1246549426194;6368.649724265169;6370.916944119499;6399.520035997301;6471.352864713526;6489.351064893508;6012.75948962041;6246.125542424064;6255.530835187368;6282.748690052393;6301.558890877641;4977.55202031817;5076.847694569169;5155.871103222412;5162.535371816536;5169.612279079065;4910.1586904910655;5028.84913452597;5034.219695947116;5086.847394578169;5091.618128640367;4976.004799040188;4989.326440930482;5036.093503169428;5037.622178336621;5042.621803364744;4959.528844759742;4998.77505512251;5029.748512574393;5074.441811400725;5082.364704411949;4520.886977825548;4531.388262584542;4551.453825540956;4580.473245576768;4595;6188.164597779332;6228.252609686821;6267.6866156691985;6269.686515674198;6308.810735677937;5772.769089236425;5796.797112101099;5821.282721597139;5860.619059761102;5864;6588.308227636077;6591.209054913393;6662.233843108056;6666.899996500057;6704.731810727565;4943.480934501861;4959.388198835393;4975.885248769295;5001.9749901250625;5011.874703132415;6973.79078627642;7036.964815175891;7091.234418576708;7159.105111861018;7192.676329565182;5013.674111182834;5013.949860501421;5019.472955339636;5068.949310506921;5080.847574572768;5141.485851414828;5164.457731938092;5186.222066689951;5194.065068287745;5208.661437006658;5751.396103409165;5792.391798861143;5813.314138899672;5874.148248503943;5904.645721256738;6681.465482761368;6696.2968888267005;6734.663266836638;6802.591844489347;6814.352636499525;1709.734991076385;1722.5779683977505;1739.4694618141589;1765.6380442009358;1773.742807292961;1238.5479300055415;1239.2812168941991;1242.546470538265;1249.6875781054737;1254.9184303020456;5861.70691465425;5887.735051922588;5934.1692163097205;5938.406159384027;5977.701114944235;6691.59850408977;6725.2426505133635;6746.291639377893;6770.526063175629;6795.694193761293;5856.765729370863;5878.441548052928;5885.882282354329;5911.438413350725;5935.732892019783;3650.178709790329;3650.288193802236;3671.5227020487164;3680.35593771089;3703.9814800925824;6686.699098540577;6694.430973367318;6702.765403210864;6724.529282950244;6755.18937727466;7030.578165310098;7100.396466300423;7109.786706398816;7154;7175.17485489165;6498.870022599522;6591.406773390418;6653.6379585247505;6688.264290927994;6732;6893.7931862044215;6899.448044156556;6916.239213686591;6950.860982780215;6979.406750426067;6818.420434263143;6829.726810927507;6867.553609015597;6885.862282754417;6925.965370173117;6644.501662375244;6676.399124078856;6713.932860671526;6729.259781423942;6777.966110169417;5544.117059129311;5550.139728342114;5588.2455868458865;5601.327840658984;5612.147991162988;6852.588844669336;6960.756373527105;6972.546784458994;6975.441964642918;7021;6717.496187786033;6749.966250168718;6767.864642707217;6821.454283657196;6821.488388370793;6673.399394054364;6689.866202676017;6702.162229721285;6713.798586042427;6754.628495432798;6352.998805376292;6421.775237866652;6504.512161587805;6665.466762658879;6678.933210667831;6706.429953453816;6716.865662686817;6750.898736519054;6776.898346524707;6807.89788153188;6467.383154211447;6505.31694172124;6530.444912182517;6601.174853143357;6605.867882642417 11:18:11 INFO - PID 8526 | |5;yui.html;923.164536094834;928.6053427293401;939.0421769794809;940.4263399326414;960.8366577681793;17243.999999999985;17846.464606061807;17896.910515447405;17991.37030203943;18026.81973180268;20661.690074648894;21163.57672846546;21222;21502.139914403404;21530.677039844413;1062.4900047976957;1079.8434227037076;1082.1451053667593;1083.6478144602995;1084.0947808579845;1014.7057353367514;1056.7305337139019;1064.4518073192312;1064.792365488726;1069.1820757120809;1121.0527104596645;1127.4869934179928;1127.6278827986744;1128.05807151029;1128.328644456551;1114.0697517572837;1123.2642619084513;1124.9718757031098;1125.0268517732102;1128.1595211567394;809.3969992355733;810.1331575214523;812.0985705866483;815.4414226254975;816.4652152839899;18027.549311267194;18156.818431815645;19116.139773710216;19320.516987075294;19366.80633193664;21137;21410.678839817414;21645.134194632195;21698.674519882214;21736.347909562737;14870.628234294121;15337.846621533754;15384.615384615363;15402.614934626612;15594.37622495099;3440;3455.7926524408617;3466.5493485846932;3475.7566970312087;3488.494168345601;121961;123873;126125.36937315346;126634.36682816526;127923;14792.408303667948;15189.468368607268;15288.38846446152;15620.140892250807;15652.843471565138;29860.10419687413;30243.243918902204;30659.2335191622;30736.69263307383;30824.53763193554;7463.925360746432;7990.720324788721;8262.917370826215;8560.785980350416;8762;4091.713580049368;4185.748855068706;4193.203291374629;4197.874063778091;4207.537170911197;4858.78135483904;4957.702537847741;5004.749762511859;5017.54842064216;5044.117279476077;1041.671873359889;1044.806710758512;1061.9097376723066;1065.4885654885697;1067.685032915292;674.5581644023173;681.7477533312607;693.1128155960379;702.3573430311208;708.7235977968596;10918.781624367628;10983.286086404358;11292.661220163409;11418.02946749519;12361.07291953089;613.7115555688819;620.6462316479654;623.1587357067922;624.0981781325941;629.5026928726346;5060.873478163002;5223.320968274176;5290.947090529123;5346.091164502044;5461.808836690776;105194.47402762937;109112.45443772888;109113.45443272733;112023;113023;97823.51088244513;100410.4979475098;100640.99359006462;101702.4914875421;103193;85746.57126714327;89042.10957890339;89895.10104898998;90314.54842725744;92287;9630.662926797528;9729.318947673595;9898.158656514277;9984.201263899016;10245.282830201815;39409.211815764094;39432;39486.40770388504;40383.39424908687;40786.59213407947;51609.225861611354;51641;52008.47991520036;52340.73829630828;71702.64148679223;18289.359872404402;18429.26282948667;18435.446936591925;18708.625827483647;18715.90642046781;15552.455664051704;15946.681066378376;17352.82647173512;17891.19489622944;18773.436796896116;16625.50123496297;16647.001179929244;16708.665826683642;16716.33134674648;16787.412440564523;15827.208639568205;16159.111248881425;16429.753553696464;16441.588960276087;16494.75257871157;16175.43385981532;16438.260278287744;16879;16883.493495195165;16977.066261355743;12229.14395992272;12247.632571022883;12322.199057061262;12462.750744985231;12524.499020039097;13402.06185567001;13476;13503.392347344197;13520.932395338354;13533.796993044914 11:18:11 INFO - PID 8526 | __end_tp_report 11:18:11 INFO - PID 8526 | __start_cc_report 11:18:11 INFO - PID 8526 | _x_x_mozilla_cycle_collect,410 11:18:11 INFO - PID 8526 | __end_cc_report 11:18:11 INFO - PID 8526 | __startTimestamp1503339491456__endTimestamp 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | ------- Summary: start ------- 11:18:11 INFO - PID 8526 | Number of tests: 6 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#0] dojo.html Cycles:165 Average:6151.22 Median:6462.94 stddev:826.65 (12.8%) stddev-sans-first:795.30 11:18:11 INFO - PID 8526 | Values: 3165.0 3180.7 3196.4 3215.4 3222.6 6127.7 6242.0 6243.5 6261.1 6283.3 6085.1 6167.6 6195.3 6332.1 6349.5 5733.7 5734.4 5752.1 5792.7 5807.3 932.8 5649.9 5686.5 5771.7 5779.7 5691.5 5731.1 5771.9 5816.8 5820.1 5721.3 5728.4 5806.8 5814.7 5819.4 5660.4 5673.1 5708.1 5755.2 5764.9 6073.6 6137.7 6239.5 6258.9 6260.4 6572.4 6620.2 6687.2 6741.7 6753.6 6751.2 6782.0 6835.7 6839.5 6840.9 6219.1 6223.9 6305.0 6305.7 6323.1 6763.3 6854.8 6916.8 6963.7 6980.8 6544.8 6557.9 6569.6 6577.7 6598.9 6681.8 6686.9 6766.4 6772.2 6778.8 6605.5 6648.2 6652.1 6686.0 6743.7 6528.9 6624.0 6626.5 6627.6 6628.2 5362.8 5373.7 5376.3 5389.2 5438.7 4652.4 4675.5 4680.0 4730.1 4739.8 5797.4 5809.5 5862.6 5905.9 5916.6 6384.0 6462.9 6721.1 6735.4 6849.6 5838.1 5845.4 5848.4 5858.2 5868.9 5885.8 5912.1 5979.8 5985.5 5994.0 6503.3 6521.4 6595.8 6597.7 6612.2 6545.6 6620.3 6653.1 6697.2 6789.3 6499.1 6518.2 6550.3 6597.6 6599.8 6584.2 6599.3 6606.0 6700.5 6709.8 6608.5 6744.3 6746.4 6843.2 6851.3 6479.6 6507.2 6517.3 6524.1 6525.5 6508.6 6563.6 6586.1 6605.7 6606.9 6419.8 6459.9 6529.1 6538.0 6554.3 6567.1 6587.7 6680.5 6690.6 6694.7 6239.2 6333.8 6360.1 6371.5 6378.5 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#1] ext.html Cycles:180 Average:38633.60 Median:38382.71 stddev:53870.08 (140.3%) stddev-sans-first:53946.34 11:18:11 INFO - PID 8526 | Values: 812.2 826.4 844.6 878.6 880.9 41337.8 42145.4 42148.6 42381.8 42392.4 38297.6 38596.0 38641.8 38656.6 38667.0 6986.3 7105.4 7107.8 7113.1 7114.5 7019.7 7058.3 7099.4 7104.8 7107.1 7764.1 8003.4 8004.2 8004.8 8010.4 7875.6 7910.1 7933.0 7934.2 7935.6 7267.5 7872.3 7879.6 7883.5 7887.2 39501.6 39793.0 39882.0 39890.0 39900.4 3458.1 3513.7 3516.0 3519.7 3520.1 31651.6 31760.8 31793.5 31837.7 31846.5 4915.8 4924.2 4944.9 4958.5 4969.8 178738.0 180515.0 181702.0 182414.0 196552.0 50258.0 50416.0 50881.0 50913.5 50950.2 52611.7 52708.2 52772.0 53015.7 53197.5 16691.5 16826.7 16832.5 16834.4 16948.9 13907.8 13918.2 13918.9 13919.2 13934.7 14693.9 14730.6 14774.3 14819.2 14969.9 5861.6 5885.7 5886.3 5911.9 6026.6 958.9 967.5 982.2 995.5 996.7 22682.4 28841.4 29713.1 29746.0 30430.4 1090.9 1092.4 1098.3 1105.5 1113.4 12437.6 12554.1 12723.6 12821.8 12852.7 231655.0 233425.0 234259.0 235008.0 235414.0 48720.0 49057.8 49132.8 49405.3 49437.8 1413.9 1446.1 1461.3 1465.5 1479.4 22926.7 22947.8 23049.0 23340.5 23424.8 38216.0 38347.0 38382.0 38383.4 38475.8 203144.0 203280.0 203288.0 203346.0 204089.0 34615.1 37786.6 39949.6 39991.4 40071.2 48320.0 48781.8 48931.8 49108.5 49128.5 35776.3 35793.3 36465.6 36824.3 36925.8 35531.0 35531.3 35785.5 35800.0 36120.0 39144.0 39257.2 39447.2 39534.6 39655.6 34713.7 35670.1 35839.6 35961.1 36230.0 25074.9 25084.6 25203.2 25881.6 25963.7 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#2] jquery.html Cycles:180 Average:35657.09 Median:23323.04 stddev:83402.39 (357.6%) stddev-sans-first:83594.76 11:18:11 INFO - PID 8526 | Values: 575.9 581.4 585.6 589.8 595.6 21863.3 22983.4 23662.6 23689.3 23767.0 26523.5 26823.9 26997.5 27021.9 27127.6 6556.8 6690.7 6694.6 6695.4 6702.5 5890.9 6423.4 6431.1 6593.0 6681.2 6372.8 6380.3 6383.3 6399.0 6399.4 6372.1 6382.3 6385.6 6398.7 6422.3 5964.2 5991.0 5991.5 5993.6 5994.1 29203.7 30026.5 30582.0 31139.0 31478.0 1951.5 1984.4 1985.3 1988.2 1997.2 19230.5 19411.2 20213.9 20349.0 20420.4 2382.3 2383.2 2434.1 2436.9 2447.5 140901.0 146307.0 146665.0 146867.0 146901.3 15119.9 15254.2 15284.9 15304.9 15311.2 24290.3 24410.4 24432.6 24433.5 24476.1 10403.6 10549.9 10719.8 10786.8 10843.4 9999.9 10005.2 10037.1 10094.9 10118.6 9230.7 9369.2 9436.2 9581.1 9720.8 2641.6 2651.3 2744.9 2757.8 2844.8 951.5 975.2 981.3 988.1 988.9 19753.9 19810.3 19948.6 20134.7 20400.4 1008.6 1018.5 1028.6 1032.4 1038.5 10767.2 10988.0 11055.8 11310.6 11419.2 483685.0 485340.0 492715.0 500297.0 503066.0 117474.0 117947.0 119683.0 120039.0 120258.4 1064.3 1095.8 1115.0 1197.6 1230.6 20783.8 20803.3 20890.3 20907.4 20964.4 58538.7 59004.0 60304.4 60611.1 61723.0 73012.0 73274.3 73340.6 73860.6 74112.6 14583.3 15197.0 15221.4 15228.5 15339.0 23742.3 24039.0 24138.2 24239.2 24422.0 18556.2 18847.8 19235.6 19304.7 19318.9 15638.8 15652.8 15691.7 15821.1 16389.9 18891.6 19377.0 19541.4 19548.0 19594.2 14878.3 14999.9 15034.0 15079.6 15117.8 18500.4 18926.3 18978.6 19059.3 19083.8 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#3] mootools.html Cycles:180 Average:8918.41 Median:2612.76 stddev:6220.43 (238.1%) stddev-sans-first:6211.63 11:18:11 INFO - PID 8526 | Values: 1313.8 1378.8 1385.0 1386.4 1387.5 12570.4 14204.4 14774.6 14785.9 14823.1 12600.1 12765.1 13270.6 14280.6 14338.8 2550.2 2600.0 2609.3 2610.0 2610.4 2632.7 2677.1 2722.4 2724.5 2726.3 2763.4 2803.2 2808.7 2811.0 2813.5 2696.9 2710.2 2713.4 2714.1 2719.9 2586.8 2615.2 2629.6 2645.1 2681.4 14371.5 14436.1 14469.6 14478.3 14496.3 7543.2 7812.4 7840.5 7844.3 7845.6 5040.9 5159.8 5186.7 5229.1 5273.8 1751.3 1787.8 1797.8 1814.5 1815.5 24077.9 24751.8 24753.6 24795.5 24813.4 6876.0 6963.8 7035.0 7157.1 7165.6 15910.8 16811.9 16819.6 19191.8 19202.9 7679.5 7861.6 7909.6 7917.9 7924.8 7105.9 7187.2 7256.9 7260.8 7326.3 5128.0 5298.4 5304.3 5312.2 5345.7 1531.3 1548.3 1560.9 1563.7 1572.4 799.6 806.3 819.4 822.2 844.6 7058.8 7065.5 7073.0 7084.2 7090.9 721.0 721.8 723.9 727.5 729.8 4691.2 4769.6 4996.3 5023.7 5044.9 18279.4 18920.3 19304.2 20023.6 20060.6 19538.7 19574.8 19586.2 19734.3 19820.0 10579.2 10635.9 10804.8 10879.2 10915.5 8246.8 8258.6 8301.4 8444.2 8730.4 16924.7 17235.4 17318.7 18072.5 18113.3 17861.0 18149.2 18220.0 18257.8 18347.7 11861.1 11909.0 12055.6 12115.7 12146.1 13554.3 13561.8 13631.5 13760.0 13765.8 10772.4 10829.8 10841.1 11024.4 11101.8 10750.7 10876.7 10961.5 10996.8 11137.4 9202.5 9489.5 9495.2 9502.4 9504.1 6784.5 6869.0 6892.4 6900.2 6906.1 6951.6 6956.2 7004.9 7028.6 7063.0 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#4] prototype.html Cycles:180 Average:5652.51 Median:6268.69 stddev:1594.60 (25.4%) stddev-sans-first:1551.28 11:18:11 INFO - PID 8526 | Values: 490.2 502.9 525.6 526.8 532.1 6368.6 6370.9 6399.5 6471.4 6489.4 6012.8 6246.1 6255.5 6282.7 6301.6 4977.6 5076.8 5155.9 5162.5 5169.6 4910.2 5028.8 5034.2 5086.8 5091.6 4976.0 4989.3 5036.1 5037.6 5042.6 4959.5 4998.8 5029.7 5074.4 5082.4 4520.9 4531.4 4551.5 4580.5 4595.0 6188.2 6228.3 6267.7 6269.7 6308.8 5772.8 5796.8 5821.3 5860.6 5864.0 6588.3 6591.2 6662.2 6666.9 6704.7 4943.5 4959.4 4975.9 5002.0 5011.9 6973.8 7037.0 7091.2 7159.1 7192.7 5013.7 5013.9 5019.5 5068.9 5080.8 5141.5 5164.5 5186.2 5194.1 5208.7 5751.4 5792.4 5813.3 5874.1 5904.6 6681.5 6696.3 6734.7 6802.6 6814.4 1709.7 1722.6 1739.5 1765.6 1773.7 1238.5 1239.3 1242.5 1249.7 1254.9 5861.7 5887.7 5934.2 5938.4 5977.7 6691.6 6725.2 6746.3 6770.5 6795.7 5856.8 5878.4 5885.9 5911.4 5935.7 3650.2 3650.3 3671.5 3680.4 3704.0 6686.7 6694.4 6702.8 6724.5 6755.2 7030.6 7100.4 7109.8 7154.0 7175.2 6498.9 6591.4 6653.6 6688.3 6732.0 6893.8 6899.4 6916.2 6950.9 6979.4 6818.4 6829.7 6867.6 6885.9 6926.0 6644.5 6676.4 6713.9 6729.3 6778.0 5544.1 5550.1 5588.2 5601.3 5612.1 6852.6 6960.8 6972.5 6975.4 7021.0 6717.5 6750.0 6767.9 6821.5 6821.5 6673.4 6689.9 6702.2 6713.8 6754.6 6353.0 6421.8 6504.5 6665.5 6678.9 6706.4 6716.9 6750.9 6776.9 6807.9 6467.4 6505.3 6530.4 6601.2 6605.9 11:18:11 INFO - PID 8526 | 11:18:11 INFO - PID 8526 | [#5] yui.html Cycles:180 Average:23011.08 Median:18223.09 stddev:32053.17 (175.9%) stddev-sans-first:32100.18 11:18:11 INFO - PID 8526 | Values: 923.2 928.6 939.0 940.4 960.8 17244.0 17846.5 17896.9 17991.4 18026.8 20661.7 21163.6 21222.0 21502.1 21530.7 1062.5 1079.8 1082.1 1083.6 1084.1 1014.7 1056.7 1064.5 1064.8 1069.2 1121.1 1127.5 1127.6 1128.1 1128.3 1114.1 1123.3 1125.0 1125.0 1128.2 809.4 810.1 812.1 815.4 816.5 18027.5 18156.8 19116.1 19320.5 19366.8 21137.0 21410.7 21645.1 21698.7 21736.3 14870.6 15337.8 15384.6 15402.6 15594.4 3440.0 3455.8 3466.5 3475.8 3488.5 121961.0 123873.0 126125.4 126634.4 127923.0 14792.4 15189.5 15288.4 15620.1 15652.8 29860.1 30243.2 30659.2 30736.7 30824.5 7463.9 7990.7 8262.9 8560.8 8762.0 4091.7 4185.7 4193.2 4197.9 4207.5 4858.8 4957.7 5004.7 5017.5 5044.1 1041.7 1044.8 1061.9 1065.5 1067.7 674.6 681.7 693.1 702.4 708.7 10918.8 10983.3 11292.7 11418.0 12361.1 613.7 620.6 623.2 624.1 629.5 5060.9 5223.3 5290.9 5346.1 5461.8 105194.5 109112.5 109113.5 112023.0 113023.0 97823.5 100410.5 100641.0 101702.5 103193.0 85746.6 89042.1 89895.1 90314.5 92287.0 9630.7 9729.3 9898.2 9984.2 10245.3 39409.2 39432.0 39486.4 40383.4 40786.6 51609.2 51641.0 52008.5 52340.7 71702.6 18289.4 18429.3 18435.4 18708.6 18715.9 15552.5 15946.7 17352.8 17891.2 18773.4 16625.5 16647.0 16708.7 16716.3 16787.4 15827.2 16159.1 16429.8 16441.6 16494.8 16175.4 16438.3 16879.0 16883.5 16977.1 12229.1 12247.6 12322.2 12462.8 12524.5 13402.1 13476.0 13503.4 13520.9 13533.8 11:18:11 INFO - PID 8526 | -------- Summary: end -------- 11:18:11 INFO - PID 8526 | 11:18:12 INFO - TEST-INFO | 8526: exit 0 11:18:12 INFO - TEST-OK | dromaeo_css | took 1111744ms 11:18:12 INFO - TEST-START | kraken 11:18:12 INFO - Initialising browser for kraken test... 11:18:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57071/getInfo.html -profile /tmp/tmp_7N96Y/profile 11:18:12 INFO - TEST-INFO | started process 8952 (/builds/slave/test/build/application/firefox/firefox http://localhost:57071/getInfo.html) 11:18:17 INFO - TEST-INFO | 8952: exit 0 11:18:17 INFO - Browser initialized. 11:18:17 INFO - Running cycle 1/1 for kraken test... 11:18:17 INFO - TEST-INFO | started process 9138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_7N96Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:18 INFO - PID 9138 | 11:18:18 INFO - PID 9138 | (/builds/slave/test/build/application/firefox/firefox:9187): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:18 INFO - PID 9138 | 11:18:19 INFO - PID 9138 | 11:18:19 INFO - PID 9138 | (/builds/slave/test/build/application/firefox/firefox:9246): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:19 INFO - PID 9138 | 11:18:19 INFO - PID 9138 | __metrics Screen width/height:1600/1200 11:18:19 INFO - PID 9138 | colorDepth:24 11:18:19 INFO - PID 9138 | Browser inner width/height: 1024/768 11:18:19 INFO - PID 9138 | __metrics 11:18:28 INFO - PID 9138 | RSS: Main: 174493696 11:18:28 INFO - PID 9138 | 11:18:31 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-beat-detection) 11:18:32 INFO - PID 9138 | RSS: Main: 178061312 11:18:32 INFO - PID 9138 | 11:18:35 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-dft) 11:18:35 INFO - PID 9138 | RSS: Main: 180744192 11:18:35 INFO - PID 9138 | 11:18:38 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-fft) 11:18:39 INFO - PID 9138 | RSS: Main: 174592000 11:18:39 INFO - PID 9138 | 11:18:41 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57071/tests/kraken/driver.html?testName=audio-oscillator) 11:18:42 INFO - PID 9138 | RSS: Main: 175063040 11:18:42 INFO - PID 9138 | 11:18:44 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:18:44 INFO - PID 9138 | RSS: Main: 175079424 11:18:44 INFO - PID 9138 | 11:18:48 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-darkroom) 11:18:48 INFO - PID 9138 | RSS: Main: 176394240 11:18:48 INFO - PID 9138 | 11:18:52 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57071/tests/kraken/driver.html?testName=imaging-desaturate) 11:18:52 INFO - PID 9138 | RSS: Main: 176173056 11:18:52 INFO - PID 9138 | 11:18:55 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57071/tests/kraken/driver.html?testName=json-parse-financial) 11:18:56 INFO - PID 9138 | RSS: Main: 176517120 11:18:56 INFO - PID 9138 | 11:18:58 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57071/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:18:58 INFO - PID 9138 | RSS: Main: 176504832 11:18:58 INFO - PID 9138 | 11:19:00 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:01 INFO - PID 9138 | RSS: Main: 176439296 11:19:01 INFO - PID 9138 | 11:19:03 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:03 INFO - PID 9138 | RSS: Main: 176263168 11:19:03 INFO - PID 9138 | 11:19:06 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:07 INFO - PID 9138 | RSS: Main: 177037312 11:19:07 INFO - PID 9138 | 11:19:10 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:11 INFO - PID 9138 | RSS: Main: 177033216 11:19:11 INFO - PID 9138 | 11:19:12 INFO - PID 9138 | Cycle 1(1): loaded http://localhost:57071/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57071/tests/kraken/driver.html?testName=ai-astar) 11:19:13 INFO - PID 9138 | RSS: Main: 178434048 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | __start_tp_report 11:19:13 INFO - PID 9138 | _x_x_mozilla_page_load 11:19:13 INFO - PID 9138 | _x_x_mozilla_page_load_details 11:19:13 INFO - PID 9138 | |i|pagename|runs| 11:19:13 INFO - PID 9138 | |0;ai-astar;98;114;102;109;108;110;112;102;108;109 11:19:13 INFO - PID 9138 | |1;audio-beat-detection;143;119;149;175;120;157;153;118;173;123 11:19:13 INFO - PID 9138 | |2;audio-dft;162;161;164;169;166;163;171;167;165;164 11:19:13 INFO - PID 9138 | |3;audio-fft;76;75;76;157;76;75;75;96;111;76 11:19:13 INFO - PID 9138 | |4;audio-oscillator;78;79;133;78;79;88;130;79;79;131 11:19:13 INFO - PID 9138 | |5;imaging-gaussian-blur;113;116;114;114;117;118;117;117;117;116 11:19:13 INFO - PID 9138 | |6;imaging-darkroom;149;150;150;150;150;150;149;149;153;152 11:19:13 INFO - PID 9138 | |7;imaging-desaturate;94;94;93;94;93;94;94;94;94;99 11:19:13 INFO - PID 9138 | |8;json-parse-financial;57;71;55;55;55;56;54;56;55;53 11:19:13 INFO - PID 9138 | |9;json-stringify-tinderbox;54;53;54;54;58;54;54;56;53;54 11:19:13 INFO - PID 9138 | |10;stanford-crypto-aes;79;82;74;75;77;76;77;76;85;75 11:19:13 INFO - PID 9138 | |11;stanford-crypto-ccm;135;135;125;126;115;118;119;120;125;158 11:19:13 INFO - PID 9138 | |12;stanford-crypto-pbkdf2;179;180;174;172;170;175;170;173;182;194 11:19:13 INFO - PID 9138 | |13;stanford-crypto-sha256-iterative;70;78;68;72;76;76;67;66;66;77 11:19:13 INFO - PID 9138 | __end_tp_report 11:19:13 INFO - PID 9138 | __start_cc_report 11:19:13 INFO - PID 9138 | _x_x_mozilla_cycle_collect,927 11:19:13 INFO - PID 9138 | __end_cc_report 11:19:13 INFO - PID 9138 | __startTimestamp1503339553181__endTimestamp 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | ------- Summary: start ------- 11:19:13 INFO - PID 9138 | Number of tests: 14 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#0] ai-astar Cycles:10 Average:107.20 Median:109.50 stddev:4.98 (4.6%) stddev-sans-first:4.02 11:19:13 INFO - PID 9138 | Values: 98.0 114.0 102.0 109.0 108.0 110.0 112.0 102.0 108.0 109.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:151.00 stddev:22.08 (14.6%) stddev-sans-first:23.41 11:19:13 INFO - PID 9138 | Values: 143.0 119.0 149.0 175.0 120.0 157.0 153.0 118.0 173.0 123.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.50 stddev:3.12 (1.9%) stddev-sans-first:3.09 11:19:13 INFO - PID 9138 | Values: 162.0 161.0 164.0 169.0 166.0 163.0 171.0 167.0 165.0 164.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#3] audio-fft Cycles:10 Average:89.30 Median:76.00 stddev:26.71 (35.1%) stddev-sans-first:27.89 11:19:13 INFO - PID 9138 | Values: 76.0 75.0 76.0 157.0 76.0 75.0 75.0 96.0 111.0 76.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:24.98 (31.6%) stddev-sans-first:25.69 11:19:13 INFO - PID 9138 | Values: 78.0 79.0 133.0 78.0 79.0 88.0 130.0 79.0 79.0 131.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:117.00 stddev:1.66 (1.4%) stddev-sans-first:1.39 11:19:13 INFO - PID 9138 | Values: 113.0 116.0 114.0 114.0 117.0 118.0 117.0 117.0 117.0 116.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#6] imaging-darkroom Cycles:10 Average:150.20 Median:150.00 stddev:1.32 (0.9%) stddev-sans-first:1.32 11:19:13 INFO - PID 9138 | Values: 149.0 150.0 150.0 150.0 150.0 150.0 149.0 149.0 153.0 152.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.70 (1.8%) stddev-sans-first:1.80 11:19:13 INFO - PID 9138 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 94.0 99.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:55.50 stddev:5.14 (9.3%) stddev-sans-first:5.45 11:19:13 INFO - PID 9138 | Values: 57.0 71.0 55.0 55.0 55.0 56.0 54.0 56.0 55.0 53.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:1.51 (2.8%) stddev-sans-first:1.59 11:19:13 INFO - PID 9138 | Values: 54.0 53.0 54.0 54.0 58.0 54.0 54.0 56.0 53.0 54.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.47 (4.5%) stddev-sans-first:3.64 11:19:13 INFO - PID 9138 | Values: 79.0 82.0 74.0 75.0 77.0 76.0 77.0 76.0 85.0 75.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.50 stddev:12.62 (10.1%) stddev-sans-first:13.09 11:19:13 INFO - PID 9138 | Values: 135.0 135.0 125.0 126.0 115.0 118.0 119.0 120.0 125.0 158.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.00 stddev:7.29 (4.1%) stddev-sans-first:7.70 11:19:13 INFO - PID 9138 | Values: 179.0 180.0 174.0 172.0 170.0 175.0 170.0 173.0 182.0 194.0 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:74.00 stddev:4.81 (6.5%) stddev-sans-first:5.07 11:19:13 INFO - PID 9138 | Values: 70.0 78.0 68.0 72.0 76.0 76.0 67.0 66.0 66.0 77.0 11:19:13 INFO - PID 9138 | -------- Summary: end -------- 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150079,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 11:19:13 INFO - PID 9138 | 11:19:13 INFO - PID 9138 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:19:14 INFO - TEST-INFO | 9138: exit 0 11:19:14 INFO - TEST-OK | kraken | took 61992ms 11:19:14 INFO - SUITE-END | took 1173s 11:19:14 INFO - Completed test suite (00:19:33) 11:19:14 INFO - javascript benchmark 11:19:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8534.76325604659, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.0, 3180.650128485867, 3196.3767065422253, 3215.3890760755453, 3222.5810644616195, 6127.662978536178, 6242.0, 6243.531735119867, 6261.123442718017, 6283.308836028044, 6085.148079268906, 6167.629942203471, 6195.31851496335, 6332.1135041094285, 6349.460295874845, 5733.684647344395, 5734.397888221739, 5752.108423194411, 5792.739326730297, 5807.303123625171, 932.8469772170067, 5649.887002259952, 5686.545076393879, 5771.682557459338, 5779.682117483537, 5691.51622112121, 5731.111677689964, 5771.855703607402, 5816.825495235171, 5820.068788993741, 5721.284839395075, 5728.369879313273, 5806.82579522615, 5814.709264536757, 5819.418058194189, 5660.433956604348, 5673.063944449161, 5708.115242137475, 5755.22304488897, 5764.913526297109, 6073.635581865058, 6137.693115344259, 6239.500839932794, 6258.937410625881, 6260.436560709558, 6572.4084832365315, 6620.23867255267, 6687.164104486939, 6741.662916854138, 6753.628550429725, 6751.223609284946, 6781.966090169518, 6835.692393842289, 6839.487038472134, 6840.897386539206, 6219.129321894939, 6223.937760622426, 6304.968475157641, 6305.747770089145, 6323.05154226865, 6763.256041835394, 6854.828629284208, 6916.827079323057, 6963.651817409109, 6980.7905762827195, 6544.770933017417, 6557.868842623217, 6569.57297775643, 6577.736890524421, 6598.86802263952, 6681.799546013627, 6686.933130668631, 6766.357196066366, 6772.153480814898, 6778.830529236809, 6605.504587155982, 6648.16897887764, 6652.135222421054, 6685.966570167216, 6743.730250790011, 6528.869422611521, 6624.039514270404, 6626.503012274099, 6627.569208001464, 6628.171478565179, 5362.758675859595, 5373.677579345252, 5376.274202982626, 5389.164679474688, 5438.700871452108, 4652.371929789503, 4675.509071547506, 4680.040591678698, 4730.053989202104, 4739.810407583727, 5797.36229014808, 5809.477147056785, 5862.618929769551, 5905.940940590625, 5916.615419997686, 6384.0, 6462.935370646233, 6721.059051732761, 6735.393814556714, 6849.589024658537, 5838.095095260242, 5845.415458454206, 5848.4151584841175, 5858.238429004287, 5868.882622347529, 5885.823425297248, 5912.146974495219, 5979.79070732531, 5985.46130848217, 5993.9700301498215, 6503.349665033554, 6521.380468855451, 6595.8351041223395, 6597.703103360361, 6612.173478315211, 6545.574537655038, 6620.271770105381, 6653.068570400051, 6697.196336439659, 6789.287124852017, 6499.0901273820755, 6518.152640156749, 6550.312217217314, 6597.60414375139, 6599.8020059398295, 6584.242812076673, 6599.307072757291, 6605.966970165118, 6700.497462690415, 6709.7651582194385, 6608.471322294109, 6744.291849355747, 6746.4265537429865, 6843.213030501357, 6851.314868513109, 6479.5788273762055, 6507.219133703797, 6517.315681853527, 6524.119243902012, 6525.543211975306, 6508.576942498722, 6563.638999855054, 6586.110875032001, 6605.702743376656, 6606.933930660632, 6419.807405777834, 6459.90181669108, 6529.118568993315, 6538.0, 6554.31179726141, 6567.113439685581, 6587.736490540325, 6680.532362734756, 6690.565113267622, 6694.665266736546, 6239.1577137085915, 6333.809985700436, 6360.077788720702, 6371.49028077762, 6378.489720822416], "value": 6093.155985342899, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.2243257688908, 826.4297634632103, 844.5861527851353, 878.5738916625431, 880.8810810540575, 41337.79331103344, 42145.36781948273, 42148.578514214845, 42381.788091059505, 42392.36411453831, 38297.61702382976, 38595.99999999993, 38641.806790966075, 38656.613433865656, 38667.0, 6986.266442023591, 7105.43156547475, 7107.751228706997, 7113.075300210991, 7114.537555058904, 7019.684114214872, 7058.2588828173075, 7099.396551293146, 7104.78685639429, 7107.0760801095785, 7764.145943946161, 8003.439759216857, 8004.239597238253, 8004.759857204293, 8010.439269251155, 7875.606219689022, 7910.050793904711, 7932.999999999971, 7934.246246606592, 7935.64289606969, 7267.527610705287, 7872.252136047066, 7879.566623835687, 7883.526988380716, 7887.171846956102, 39501.60498395008, 39793.0, 39882.0, 39890.0, 39900.401493977326, 3458.1354661334667, 3513.6662017108333, 3515.9979405869462, 3519.7008254298416, 3520.137566296248, 31651.575679094494, 31760.841195794103, 31793.52309715356, 31837.681623183704, 31846.522302165486, 4915.827946021872, 4924.162892308316, 4944.901101977976, 4958.504149585049, 4969.776360063805, 178738.0, 180515.0, 181702.0, 182414.0, 196552.0, 50257.989680413106, 50416.0, 50881.0, 50913.49086509162, 50950.23574646383, 52611.736941315816, 52708.20937685938, 52772.0, 53015.734921325915, 53197.46802532003, 16691.49925502237, 16826.747598786027, 16832.495025149266, 16834.410795622338, 16948.91525542389, 13907.79138312926, 13918.164910105426, 13918.930405348112, 13919.164850108824, 13934.651633709238, 14693.92653036728, 14730.55808325752, 14774.261286935825, 14819.184944827923, 14969.925150374396, 5861.648301101947, 5885.675722962299, 5886.264216972879, 5911.881762364815, 6026.578139530191, 958.8705524754208, 967.5065716484644, 982.1651596143221, 995.4723996281982, 996.7358649957768, 22682.43293917665, 28841.42317153645, 29713.108606741833, 29746.0, 30430.391392172034, 1090.9454527273763, 1092.448313601626, 1098.319042193845, 1105.5190991918541, 1113.3542545323692, 12437.564685236155, 12554.058445616616, 12723.618291451272, 12821.807672884914, 12852.678683032998, 231655.0, 233425.0, 234259.0, 235008.0, 235414.0, 48720.0, 49057.75471122622, 49132.754336228805, 49405.25892111621, 49437.75281123571, 1413.8727514523537, 1446.0889639527031, 1461.291273732239, 1465.5383554180398, 1479.3934486860335, 22926.656100158176, 22947.770522294562, 23049.0, 23340.53318933578, 23424.765752342257, 38216.04459888525, 38347.0, 38382.0, 38383.42424863573, 38475.807620961714, 203144.0, 203280.0, 203288.0, 203346.0, 204089.0, 34615.13462163466, 37786.62213377831, 39949.60050399575, 39991.40012899867, 40071.19857602773, 48320.0, 48781.756091219315, 48931.75534122306, 49108.508914910395, 49128.50871491382, 35776.28447430985, 35793.28413431769, 36465.63534364622, 36824.26351473009, 36925.815370922974, 35531.0, 35531.289374211854, 35785.46321805123, 35800.0, 36120.0, 39144.0, 39257.2148557033, 39447.2110557793, 39534.604653953094, 39655.60344396519, 34713.65286347104, 35670.108247292985, 35839.64160358467, 35961.1009724759, 36230.0, 25074.874625626755, 25084.62373064442, 25203.243902682214, 25881.611775823, 25963.74036259613], "value": 17651.151364440113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.9251297331347, 581.4069648958063, 585.6164212440851, 589.831897909096, 595.6336852835506, 21863.344099677037, 22983.42541436463, 23662.64506032411, 23689.289321320368, 23767.0, 26523.469530609374, 26823.86588067062, 26997.46005079902, 27021.86489067557, 27127.593086103676, 6556.803295901119, 6690.7323707051655, 6694.564853284545, 6695.397414232718, 6702.530822842403, 5890.852728681774, 6423.389777971085, 6431.1317972073875, 6593.0, 6681.164854393201, 6372.776952806653, 6380.3300653431415, 6383.297837237923, 6399.008153736178, 6399.392057754506, 6372.1397611322345, 6382.266039405481, 6385.553011289212, 6398.744050237985, 6422.293547709748, 5964.1650168976375, 5990.97004514979, 5991.460768530853, 5993.580449368546, 5994.07091900756, 29203.70796292031, 30026.549601755993, 30582.0, 31139.0, 31478.0, 1951.4731022623955, 1984.3848406993877, 1985.2852972929734, 1988.1649707123042, 1997.1911375892787, 19230.519237019045, 19411.22355105794, 20213.898930505402, 20349.0, 20420.38738837837, 2382.2614989353356, 2383.2254517281954, 2434.1358817619844, 2436.902523899042, 2447.49826285611, 140901.0, 146307.0, 146665.0, 146867.0, 146901.26549367292, 15119.924400377928, 15254.23728813555, 15284.923575382274, 15304.933833932499, 15311.15788631636, 24290.271291861274, 24410.38974025628, 24432.633510497355, 24433.511329773304, 24476.14333498319, 10403.58385664565, 10549.9472502637, 10719.83920241197, 10786.838197427045, 10843.403612801214, 9999.850002249972, 10005.199584033406, 10037.146842518321, 10094.899051009543, 10118.595256189818, 9230.723078307661, 9369.203617692436, 9436.197923176607, 9581.137697607248, 9720.75698107553, 2641.564141916601, 2651.270900502377, 2744.890204391802, 2757.7931655125944, 2844.7866410019333, 951.5432592355708, 975.1808480876098, 981.2640519610293, 988.1452543549777, 988.8763904511936, 19753.901230493757, 19810.306639267845, 19948.60102797936, 20134.69797953032, 20400.387988360373, 1008.566316483919, 1018.4856647393019, 1028.5525796278644, 1032.3702541449709, 1038.4651904269308, 10767.19246056549, 10988.0, 11055.778884422267, 11310.60412885545, 11419.208972022085, 483685.0, 485340.0, 492715.0, 500297.0, 503066.0, 117474.0, 117947.0, 119683.0, 120039.0, 120258.39870800765, 1064.3401091323428, 1095.7863216672831, 1115.0354942974268, 1197.550918405598, 1230.6062060140848, 20783.79216207879, 20803.271885483937, 20890.268840590506, 20907.37277881666, 20964.371068867957, 58538.7073064632, 59004.0, 60304.39695602988, 60611.09083363665, 61723.0, 73012.0, 73274.26725732887, 73340.63329683317, 73860.63069684617, 74112.62943685247, 14583.270836458347, 15197.012194207342, 15221.391144354102, 15228.543143705707, 15339.0, 23742.287731368087, 24039.0, 24138.155164569154, 24239.151629692875, 24422.0, 18556.164972575996, 18847.811521884607, 19235.615287693887, 19304.710429343853, 19318.903405482884, 15638.765418518504, 15652.765208522109, 15691.686166276382, 15821.129837859029, 16389.918050409673, 18891.622167556296, 19377.0, 19541.413757587296, 19548.0, 19594.216231350587, 14878.330475128429, 14999.850001500281, 15034.0, 15079.623009424851, 15117.773233401287, 18500.444986650422, 18926.3375781847, 18978.620427591093, 19059.332923347618, 19083.809161908204], "value": 12226.860736840812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.835770528684, 1378.772892126008, 1385.0304786649342, 1386.3830595385054, 1387.5143699705097, 12570.43433045513, 14204.43182272709, 14774.63063423415, 14785.852141478583, 14823.110613363206, 12600.117991740559, 12765.106442549002, 13270.601881943532, 14280.571582852532, 14338.784918226209, 2550.247676935304, 2599.9870000650067, 2609.2694045667245, 2610.0342873136965, 2610.37351035751, 2632.736726327371, 2677.063027940225, 2722.3602453423428, 2724.5368287391093, 2726.3047922779665, 2763.3782398960275, 2803.1590522843167, 2808.6910439851704, 2811.0442449567145, 2813.4935711571907, 2696.91909242723, 2710.1598504463677, 2713.3894873653467, 2714.0772137473155, 2719.9320016999536, 2586.8059895507913, 2615.1500762252153, 2629.6449979252748, 2645.0742240215964, 2681.3832818451865, 14371.496997605138, 14436.123303970417, 14469.638259043502, 14478.348474318682, 14496.275186240646, 7543.2079631638435, 7812.414068944852, 7840.490368126054, 7844.294013538752, 7845.568493732842, 5040.873978150576, 5159.845204643867, 5186.740662966837, 5229.137192363255, 5273.841784746463, 1751.2557163205713, 1787.830156135165, 1797.7752780902388, 1814.4556633010177, 1815.509812350658, 24077.87961060201, 24751.752482475124, 24753.62869556958, 24795.504089918282, 24813.379665508506, 6876.0, 6963.79108626742, 7034.964825175842, 7157.105361829771, 7165.6417179140835, 15910.840891590937, 16811.915940420466, 16819.579510512336, 19191.808081919004, 19202.903985479985, 7679.462437629312, 7861.606919654108, 7909.604519773989, 7917.920820791834, 7924.762257132295, 7105.857882842314, 7187.209406965229, 7256.854862902713, 7260.782176534713, 7326.3406293433845, 5128.0, 5298.417174110845, 5304.257403963448, 5312.203169524525, 5345.679259244458, 1531.257340190007, 1548.2800497768592, 1560.8907376483764, 1563.7185306644913, 1572.3789103304132, 799.5962039170298, 806.2944923192207, 819.4386845011186, 822.2394285286086, 844.6030365728097, 7058.752943646948, 7065.540739851996, 7073.0, 7084.220735719066, 7090.858182836314, 720.9855802883912, 721.8231533274381, 723.9167495737952, 727.5307426709743, 729.8211938075206, 4691.249400095969, 4769.618430525619, 4996.275540046673, 5023.698578085254, 5044.9495505045215, 18279.360222392417, 18920.33778817762, 19304.227830886888, 20023.59952800936, 20060.59878802416, 19538.70691939622, 19574.804251957583, 19586.216551337788, 19734.30929917446, 19820.0, 10579.153667706565, 10635.89364106349, 10804.837927431096, 10879.184061195283, 10915.454227288763, 8246.752597422086, 8258.628361723857, 8301.418900676894, 8444.240018398374, 8730.432521886058, 16924.66150677004, 17235.3967611133, 17318.653626927644, 18072.457826265232, 18113.275468981094, 17861.0, 18149.18328675239, 18220.0, 18257.817421826145, 18347.724784128517, 11861.110416718608, 11909.0, 12055.638330850088, 12115.697107572381, 12146.149769516049, 13554.254516001714, 13561.796573051215, 13631.522896698569, 13760.0, 13765.793513097511, 10772.407517586607, 10829.837552436877, 10841.07850832688, 11024.448777560929, 11101.833472497758, 10750.73123171927, 10876.673699789018, 10961.50673219691, 10996.835047474455, 11137.443127843737, 9202.493862837608, 9489.478078705737, 9495.19290860257, 9502.382345147544, 9504.144626983605, 6784.491163162881, 6868.965655171693, 6892.448604111559, 6900.2409734930125, 6906.067680863019, 6951.582905025714, 6956.165260168812, 7004.929950700428, 7028.578285302899, 7062.964685176541], "value": 6406.694707534913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.24210645963166, 502.9245613158026, 525.582162181066, 526.8208809004939, 532.1246549426194, 6368.649724265169, 6370.916944119499, 6399.520035997301, 6471.352864713526, 6489.351064893508, 6012.75948962041, 6246.125542424064, 6255.530835187368, 6282.748690052393, 6301.558890877641, 4977.55202031817, 5076.847694569169, 5155.871103222412, 5162.535371816536, 5169.612279079065, 4910.1586904910655, 5028.84913452597, 5034.219695947116, 5086.847394578169, 5091.618128640367, 4976.004799040188, 4989.326440930482, 5036.093503169428, 5037.622178336621, 5042.621803364744, 4959.528844759742, 4998.77505512251, 5029.748512574393, 5074.441811400725, 5082.364704411949, 4520.886977825548, 4531.388262584542, 4551.453825540956, 4580.473245576768, 4595.0, 6188.164597779332, 6228.252609686821, 6267.6866156691985, 6269.686515674198, 6308.810735677937, 5772.769089236425, 5796.797112101099, 5821.282721597139, 5860.619059761102, 5864.0, 6588.308227636077, 6591.209054913393, 6662.233843108056, 6666.899996500057, 6704.731810727565, 4943.480934501861, 4959.388198835393, 4975.885248769295, 5001.9749901250625, 5011.874703132415, 6973.79078627642, 7036.964815175891, 7091.234418576708, 7159.105111861018, 7192.676329565182, 5013.674111182834, 5013.949860501421, 5019.472955339636, 5068.949310506921, 5080.847574572768, 5141.485851414828, 5164.457731938092, 5186.222066689951, 5194.065068287745, 5208.661437006658, 5751.396103409165, 5792.391798861143, 5813.314138899672, 5874.148248503943, 5904.645721256738, 6681.465482761368, 6696.2968888267005, 6734.663266836638, 6802.591844489347, 6814.352636499525, 1709.734991076385, 1722.5779683977505, 1739.4694618141589, 1765.6380442009358, 1773.742807292961, 1238.5479300055415, 1239.2812168941991, 1242.546470538265, 1249.6875781054737, 1254.9184303020456, 5861.70691465425, 5887.735051922588, 5934.1692163097205, 5938.406159384027, 5977.701114944235, 6691.59850408977, 6725.2426505133635, 6746.291639377893, 6770.526063175629, 6795.694193761293, 5856.765729370863, 5878.441548052928, 5885.882282354329, 5911.438413350725, 5935.732892019783, 3650.178709790329, 3650.288193802236, 3671.5227020487164, 3680.35593771089, 3703.9814800925824, 6686.699098540577, 6694.430973367318, 6702.765403210864, 6724.529282950244, 6755.18937727466, 7030.578165310098, 7100.396466300423, 7109.786706398816, 7154.0, 7175.17485489165, 6498.870022599522, 6591.406773390418, 6653.6379585247505, 6688.264290927994, 6732.0, 6893.7931862044215, 6899.448044156556, 6916.239213686591, 6950.860982780215, 6979.406750426067, 6818.420434263143, 6829.726810927507, 6867.553609015597, 6885.862282754417, 6925.965370173117, 6644.501662375244, 6676.399124078856, 6713.932860671526, 6729.259781423942, 6777.966110169417, 5544.117059129311, 5550.139728342114, 5588.2455868458865, 5601.327840658984, 5612.147991162988, 6852.588844669336, 6960.756373527105, 6972.546784458994, 6975.441964642918, 7021.0, 6717.496187786033, 6749.966250168718, 6767.864642707217, 6821.454283657196, 6821.488388370793, 6673.399394054364, 6689.866202676017, 6702.162229721285, 6713.798586042427, 6754.628495432798, 6352.998805376292, 6421.775237866652, 6504.512161587805, 6665.466762658879, 6678.933210667831, 6706.429953453816, 6716.865662686817, 6750.898736519054, 6776.898346524707, 6807.89788153188, 6467.383154211447, 6505.31694172124, 6530.444912182517, 6601.174853143357, 6605.867882642417], "value": 5178.304439889404, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.164536094834, 928.6053427293401, 939.0421769794809, 940.4263399326414, 960.8366577681793, 17243.999999999985, 17846.464606061807, 17896.910515447405, 17991.37030203943, 18026.81973180268, 20661.690074648894, 21163.57672846546, 21222.0, 21502.139914403404, 21530.677039844413, 1062.4900047976957, 1079.8434227037076, 1082.1451053667593, 1083.6478144602995, 1084.0947808579845, 1014.7057353367514, 1056.7305337139019, 1064.4518073192312, 1064.792365488726, 1069.1820757120809, 1121.0527104596645, 1127.4869934179928, 1127.6278827986744, 1128.05807151029, 1128.328644456551, 1114.0697517572837, 1123.2642619084513, 1124.9718757031098, 1125.0268517732102, 1128.1595211567394, 809.3969992355733, 810.1331575214523, 812.0985705866483, 815.4414226254975, 816.4652152839899, 18027.549311267194, 18156.818431815645, 19116.139773710216, 19320.516987075294, 19366.80633193664, 21137.0, 21410.678839817414, 21645.134194632195, 21698.674519882214, 21736.347909562737, 14870.628234294121, 15337.846621533754, 15384.615384615363, 15402.614934626612, 15594.37622495099, 3440.0, 3455.7926524408617, 3466.5493485846932, 3475.7566970312087, 3488.494168345601, 121961.0, 123873.0, 126125.36937315346, 126634.36682816526, 127923.0, 14792.408303667948, 15189.468368607268, 15288.38846446152, 15620.140892250807, 15652.843471565138, 29860.10419687413, 30243.243918902204, 30659.2335191622, 30736.69263307383, 30824.53763193554, 7463.925360746432, 7990.720324788721, 8262.917370826215, 8560.785980350416, 8762.0, 4091.713580049368, 4185.748855068706, 4193.203291374629, 4197.874063778091, 4207.537170911197, 4858.78135483904, 4957.702537847741, 5004.749762511859, 5017.54842064216, 5044.117279476077, 1041.671873359889, 1044.806710758512, 1061.9097376723066, 1065.4885654885697, 1067.685032915292, 674.5581644023173, 681.7477533312607, 693.1128155960379, 702.3573430311208, 708.7235977968596, 10918.781624367628, 10983.286086404358, 11292.661220163409, 11418.02946749519, 12361.07291953089, 613.7115555688819, 620.6462316479654, 623.1587357067922, 624.0981781325941, 629.5026928726346, 5060.873478163002, 5223.320968274176, 5290.947090529123, 5346.091164502044, 5461.808836690776, 105194.47402762937, 109112.45443772888, 109113.45443272733, 112023.0, 113023.0, 97823.51088244513, 100410.4979475098, 100640.99359006462, 101702.4914875421, 103193.0, 85746.57126714327, 89042.10957890339, 89895.10104898998, 90314.54842725744, 92287.0, 9630.662926797528, 9729.318947673595, 9898.158656514277, 9984.201263899016, 10245.282830201815, 39409.211815764094, 39432.0, 39486.40770388504, 40383.39424908687, 40786.59213407947, 51609.225861611354, 51641.0, 52008.47991520036, 52340.73829630828, 71702.64148679223, 18289.359872404402, 18429.26282948667, 18435.446936591925, 18708.625827483647, 18715.90642046781, 15552.455664051704, 15946.681066378376, 17352.82647173512, 17891.19489622944, 18773.436796896116, 16625.50123496297, 16647.001179929244, 16708.665826683642, 16716.33134674648, 16787.412440564523, 15827.208639568205, 16159.111248881425, 16429.753553696464, 16441.588960276087, 16494.75257871157, 16175.43385981532, 16438.260278287744, 16879.0, 16883.493495195165, 16977.066261355743, 12229.14395992272, 12247.632571022883, 12322.199057061262, 12462.750744985231, 12524.499020039097, 13402.06185567001, 13476.0, 13503.392347344197, 13520.932395338354, 13533.796993044914], "value": 8858.704212480927, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 114.0, 102.0, 109.0, 108.0, 110.0, 112.0, 102.0, 108.0, 109.0], "value": 107.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 119.0, 149.0, 175.0, 120.0, 157.0, 153.0, 118.0, 173.0, 123.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 169.0, 166.0, 163.0, 171.0, 167.0, 165.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 157.0, 76.0, 75.0, 75.0, 96.0, 111.0, 76.0], "value": 89.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 133.0, 78.0, 79.0, 88.0, 130.0, 79.0, 79.0, 131.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 114.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 150.0, 150.0, 150.0, 149.0, 149.0, 153.0, 152.0], "value": 150.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 99.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 71.0, 55.0, 55.0, 55.0, 56.0, 54.0, 56.0, 55.0, 53.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 58.0, 54.0, 54.0, 56.0, 53.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 74.0, 75.0, 77.0, 76.0, 77.0, 76.0, 85.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 125.0, 126.0, 115.0, 118.0, 119.0, 120.0, 125.0, 158.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 174.0, 172.0, 170.0, 175.0, 170.0, 173.0, 182.0, 194.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 68.0, 72.0, 76.0, 76.0, 67.0, 66.0, 66.0, 77.0], "value": 71.6, "unit": "score"}]}]} 11:19:14 INFO - Return code: 0 11:19:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:14 INFO - # TBPL SUCCESS # 11:19:14 INFO - Running post-action listener: _package_coverage_data 11:19:14 INFO - Running post-action listener: _resource_record_post_action 11:19:14 INFO - [mozharness: 2017-08-21 18:19:14.446399Z] Finished run-tests step (success) 11:19:14 INFO - Running post-run listener: _resource_record_post_run 11:19:14 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 438185984; Read time: 8; Write time: 260248 11:19:14 INFO - TinderboxPrint: CPU usage
13.2% 11:19:14 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 11:19:14 INFO - TinderboxPrint: I/O write bytes / time
438,185,984 / 260,248 11:19:14 INFO - TinderboxPrint: CPU idle
8,252.5 (86.8%) 11:19:14 INFO - TinderboxPrint: CPU user
1,202.1 (12.6%) 11:19:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 109273088; Read time: 0; Write time: 61424 11:19:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:19:14 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 328912896; Read time: 0; Write time: 198824 11:19:15 INFO - Running post-run listener: _upload_blobber_files 11:19:15 INFO - Blob upload gear active. 11:19:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:15 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:19:15 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:19:15 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:19:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:19:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:19:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:16 INFO - (blobuploader) - INFO - Done attempting. 11:19:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:17 INFO - (blobuploader) - INFO - Done attempting. 11:19:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:19:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:20 INFO - (blobuploader) - INFO - Done attempting. 11:19:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:19:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:19:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:21 INFO - (blobuploader) - INFO - Done attempting. 11:19:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:19:21 INFO - Return code: 0 11:19:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:19:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:19:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe6199ad9b0816fe6ad0c1290ac9a10d57889bf853a4525f683b5431c7c7312d08988a7af95a2b1c91d09c6fe3558326f651c6577842532bc4ec09b94c4612a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d29f6b1a658472b90eac52d200d52043493d5efe096d81760879d3ed7bac002f29e28e5ef4af052e5b8190f4b736f85d3567f8038c9a9dab813fd17dfb31dc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/004b9aed52a386e7ef5cf614b3735693d8d70002288cee314483d70d577e2a3c881af533416db10fa5157407a1095378132ae4f35861ba1027f095fce1b25bb2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8332fbfb2f21e585b711607883dfe31dc0df2cf5234366e6a806ea8069c2320eb9fc02e1f90783896f828992854dd48bbfac99192643890bdec2bc4ca7480f"} 11:19:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:19:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:19:21 INFO - Contents: 11:19:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe6199ad9b0816fe6ad0c1290ac9a10d57889bf853a4525f683b5431c7c7312d08988a7af95a2b1c91d09c6fe3558326f651c6577842532bc4ec09b94c4612a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d29f6b1a658472b90eac52d200d52043493d5efe096d81760879d3ed7bac002f29e28e5ef4af052e5b8190f4b736f85d3567f8038c9a9dab813fd17dfb31dc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/004b9aed52a386e7ef5cf614b3735693d8d70002288cee314483d70d577e2a3c881af533416db10fa5157407a1095378132ae4f35861ba1027f095fce1b25bb2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8332fbfb2f21e585b711607883dfe31dc0df2cf5234366e6a806ea8069c2320eb9fc02e1f90783896f828992854dd48bbfac99192643890bdec2bc4ca7480f"} 11:19:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:19:21 INFO - Copying logs to upload dir... 11:19:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:19:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.365971 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-21 11:19:21.237495) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:21.240971) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe6199ad9b0816fe6ad0c1290ac9a10d57889bf853a4525f683b5431c7c7312d08988a7af95a2b1c91d09c6fe3558326f651c6577842532bc4ec09b94c4612a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d29f6b1a658472b90eac52d200d52043493d5efe096d81760879d3ed7bac002f29e28e5ef4af052e5b8190f4b736f85d3567f8038c9a9dab813fd17dfb31dc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/004b9aed52a386e7ef5cf614b3735693d8d70002288cee314483d70d577e2a3c881af533416db10fa5157407a1095378132ae4f35861ba1027f095fce1b25bb2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8332fbfb2f21e585b711607883dfe31dc0df2cf5234366e6a806ea8069c2320eb9fc02e1f90783896f828992854dd48bbfac99192643890bdec2bc4ca7480f"} build_url:https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/MLlCFHQhSUSWzn2nnk1GfQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe6199ad9b0816fe6ad0c1290ac9a10d57889bf853a4525f683b5431c7c7312d08988a7af95a2b1c91d09c6fe3558326f651c6577842532bc4ec09b94c4612a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d29f6b1a658472b90eac52d200d52043493d5efe096d81760879d3ed7bac002f29e28e5ef4af052e5b8190f4b736f85d3567f8038c9a9dab813fd17dfb31dc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/004b9aed52a386e7ef5cf614b3735693d8d70002288cee314483d70d577e2a3c881af533416db10fa5157407a1095378132ae4f35861ba1027f095fce1b25bb2", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c8332fbfb2f21e585b711607883dfe31dc0df2cf5234366e6a806ea8069c2320eb9fc02e1f90783896f828992854dd48bbfac99192643890bdec2bc4ca7480f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:21.268253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:21.268618) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1503335494.469548-2074627400 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-21 11:19:21.350775) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:19:21.351079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-21 11:19:21.351407) ========= ========= Total master_lag: 0.18 =========