builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1500295519.75 results: success (0) revision: b8783d6fffdbebed01455743185cea68784d5367 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.755006) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.755793) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.756160) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.772901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.773307) ========= 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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 05:45:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2017-07-17 05:45:20 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185029 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.972342) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:19.972862) ========= 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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019191 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:20.023481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:45:20.023850) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b8783d6fffdbebed01455743185cea68784d5367 --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 b8783d6fffdbebed01455743185cea68784d5367 --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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 05:45:20,345 truncating revision to first 12 chars 2017-07-17 05:45:20,345 Setting DEBUG logging. 2017-07-17 05:45:20,345 attempt 1/10 2017-07-17 05:45:20,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b8783d6fffdb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 05:45:21,798 unpacking tar archive at: mozilla-central-b8783d6fffdb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.773404 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:45:21.810413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:21.810772) ========= script_repo_revision: b8783d6fffdbebed01455743185cea68784d5367 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:21.811225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:21.811506) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:45:21.820829) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-17 05:45:21.821282) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:45:22 INFO - MultiFileLogger online at 20170717 05:45:22 in /builds/slave/test 05:45:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:45:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:22 INFO - {'append_to_log': False, 05:45:22 INFO - 'base_work_dir': '/builds/slave/test', 05:45:22 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:45:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:22 INFO - 'branch': 'Firefox-Non-PGO', 05:45:22 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:22 INFO - 'code_coverage': False, 05:45:22 INFO - 'config_files': ('talos/linux_config.py',), 05:45:22 INFO - 'default_actions': ('clobber', 05:45:22 INFO - 'read-buildbot-config', 05:45:22 INFO - 'download-and-extract', 05:45:22 INFO - 'populate-webroot', 05:45:22 INFO - 'create-virtualenv', 05:45:22 INFO - 'install', 05:45:22 INFO - 'setup-mitmproxy', 05:45:22 INFO - 'run-tests'), 05:45:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:22 INFO - 'disable_ccov_upload': False, 05:45:22 INFO - 'download_minidump_stackwalk': True, 05:45:22 INFO - 'download_symbols': 'ondemand', 05:45:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:22 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:22 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:22 INFO - 'gecko_profile': False, 05:45:22 INFO - 'gecko_profile_interval': 0, 05:45:22 INFO - 'installer_path': 'installer.exe', 05:45:22 INFO - 'log_level': 'info', 05:45:22 INFO - 'log_name': 'talos', 05:45:22 INFO - 'log_to_console': True, 05:45:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:45:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:45:22 INFO - 'opt_config_files': (), 05:45:22 INFO - 'pip_index': False, 05:45:22 INFO - 'suite': 'dromaeojs-e10s', 05:45:22 INFO - 'system_bits': '32', 05:45:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:22 INFO - 'title': 'talos-linux64-ix-065', 05:45:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:22 INFO - 'use_talos_json': True, 05:45:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:22 INFO - 'work_dir': 'build'} 05:45:22 INFO - [mozharness: 2017-07-17 12:45:22.253872Z] Running clobber step. 05:45:22 INFO - Running pre-action listener: _resource_record_pre_action 05:45:22 INFO - Running main action method: clobber 05:45:22 INFO - rmtree: /builds/slave/test/build 05:45:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:23 INFO - Running post-action listener: _resource_record_post_action 05:45:23 INFO - [mozharness: 2017-07-17 12:45:23.782442Z] Finished clobber step (success) 05:45:23 INFO - [mozharness: 2017-07-17 12:45:23.782544Z] Running read-buildbot-config step. 05:45:23 INFO - Running pre-action listener: _resource_record_pre_action 05:45:23 INFO - Running main action method: read_buildbot_config 05:45:23 INFO - Using buildbot properties: 05:45:23 INFO - { 05:45:23 INFO - "project": "", 05:45:23 INFO - "product": "firefox", 05:45:23 INFO - "who": "archaeopteryx@coole-files.de", 05:45:23 INFO - "installer_path": "public/build/target.tar.bz2", 05:45:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:45:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:45:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:45:23 INFO - "stage_platform": "linux64", 05:45:23 INFO - "basedir": "/builds/slave/test", 05:45:23 INFO - "buildnumber": 1013, 05:45:23 INFO - "platform": "ubuntu64_hw", 05:45:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:45:23 INFO - "slavebuilddir": "test", 05:45:23 INFO - "taskId": "HN8Phj1NRhiVI-HrrdXfOA", 05:45:23 INFO - "branch": "mozilla-central", 05:45:23 INFO - "script_repo_revision": "production", 05:45:23 INFO - "revision": "b8783d6fffdbebed01455743185cea68784d5367", 05:45:23 INFO - "slavename": "talos-linux64-ix-065", 05:45:23 INFO - "repo_path": "mozilla-central" 05:45:23 INFO - } 05:45:23 INFO - Finding installer, test and symbols from parent task. 05:45:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HN8Phj1NRhiVI-HrrdXfOA'}, attempt #1 05:45:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HN8Phj1NRhiVI-HrrdXfOA'}, attempt #1 05:45:24 INFO - Task dependencies: EmfxPxPpS3uapCru3yn1cQ 05:45:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ'}, attempt #1 05:45:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 05:45:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/test_packages.json 05:45:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.crashreporter-symbols.zip 05:45:25 INFO - Running post-action listener: _resource_record_post_action 05:45:25 INFO - [mozharness: 2017-07-17 12:45:25.119871Z] Finished read-buildbot-config step (success) 05:45:25 INFO - [mozharness: 2017-07-17 12:45:25.120184Z] Running download-and-extract step. 05:45:25 INFO - Running pre-action listener: _resource_record_pre_action 05:45:25 INFO - Running main action method: download_and_extract 05:45:25 INFO - mkdir: /builds/slave/test/build/tests 05:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:45:25 INFO - trying https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.test_packages.json 05:45:25 INFO - Downloading https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:45:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:45:25 INFO - Downloaded 989 bytes. 05:45:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:45:25 INFO - Using the following test package requirements: 05:45:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:45:25 INFO - u'common': [u'target.common.tests.zip'], 05:45:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:45:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:45:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:45:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:45:25 INFO - u'mozbase': [u'target.common.tests.zip'], 05:45:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:45:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:45:25 INFO - u'web-platform': [u'target.common.tests.zip', 05:45:25 INFO - u'target.web-platform.tests.tar.gz'], 05:45:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:45:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:45:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip 05:45:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:45:25 INFO - Fetch https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip into memory 05:45:34 INFO - Content-Length response header: 72769126 05:45:34 INFO - Bytes received: 72769126 05:45:45 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:45:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip 05:45:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:45:45 INFO - Fetch https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.common.tests.zip into memory 05:45:46 INFO - Content-Length response header: 72769126 05:45:46 INFO - Bytes received: 72769126 05:45:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.talos.tests.zip 05:45:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:45:59 INFO - Fetch https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.talos.tests.zip into memory 05:45:59 INFO - Content-Length response header: 14495033 05:45:59 INFO - Bytes received: 14495033 05:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:00 INFO - trying https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 05:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:46:01 INFO - Downloaded 61871189 bytes. 05:46:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 05:46:01 INFO - mkdir: /builds/slave/test/properties 05:46:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:46:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:46:01 INFO - Contents: 05:46:01 INFO - build_url:https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 05:46:01 INFO - Running post-action listener: _resource_record_post_action 05:46:01 INFO - Running post-action listener: set_extra_try_arguments 05:46:01 INFO - [mozharness: 2017-07-17 12:46:01.140679Z] Finished download-and-extract step (success) 05:46:01 INFO - [mozharness: 2017-07-17 12:46:01.140776Z] Running populate-webroot step. 05:46:01 INFO - Running pre-action listener: _resource_record_pre_action 05:46:01 INFO - Running main action method: populate_webroot 05:46:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:46:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:46:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:46:01 INFO - '--tppagecycles', 05:46:01 INFO - '7'], 05:46:01 INFO - 'tests': ['tsvgm']}}, 05:46:01 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:46:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:46:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:46:01 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:01 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:46:01 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['damp', 'tps']}, 05:46:01 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'tests': ['damp', 'tps']}, 05:46:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['dromaeo_dom']}, 05:46:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:46:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:46:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:46:01 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:46:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'other-e10s': {'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_many_windows', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_many_windows', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_many_windows', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['a11yr', 05:46:01 INFO - 'ts_paint', 05:46:01 INFO - 'tpaint', 05:46:01 INFO - 'sessionrestore', 05:46:01 INFO - 'sessionrestore_no_auto_restore', 05:46:01 INFO - 'tabpaint']}, 05:46:01 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:46:01 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:46:01 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:46:01 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:46:01 INFO - 'talos_options': ['--mitmproxy', 05:46:01 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:46:01 INFO - '--firstNonBlankPaint'], 05:46:01 INFO - 'tests': ['quantum_pageload_google', 05:46:01 INFO - 'quantum_pageload_youtube', 05:46:01 INFO - 'quantum_pageload_amazon', 05:46:01 INFO - 'quantum_pageload_facebook']}, 05:46:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['tsvgx', 05:46:01 INFO - 'tsvgr_opacity', 05:46:01 INFO - 'tart', 05:46:01 INFO - 'tscrollx', 05:46:01 INFO - 'cart', 05:46:01 INFO - 'tsvg_static']}, 05:46:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:46:01 INFO - 'tsvgr_opacity', 05:46:01 INFO - 'tart', 05:46:01 INFO - 'tscrollx', 05:46:01 INFO - 'cart', 05:46:01 INFO - 'tsvg_static']}, 05:46:01 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'talos_options': ['--disable-e10s'], 05:46:01 INFO - 'tests': ['tp5o']}, 05:46:01 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:46:01 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'talos_options': ['--disable-e10s', 05:46:01 INFO - '--xperf_path', 05:46:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:01 INFO - 'tests': ['tp5n']}, 05:46:01 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:46:01 INFO - 'talos_options': ['--xperf_path', 05:46:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:46:01 INFO - 'tests': ['tp5n']}}, 05:46:01 INFO - 'talos.zip': {'path': '', 05:46:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:46:01 INFO - Running post-action listener: _resource_record_post_action 05:46:01 INFO - [mozharness: 2017-07-17 12:46:01.156138Z] Finished populate-webroot step (success) 05:46:01 INFO - [mozharness: 2017-07-17 12:46:01.156230Z] Running create-virtualenv step. 05:46:01 INFO - Running pre-action listener: _resource_record_pre_action 05:46:01 INFO - Running main action method: create_virtualenv 05:46:01 INFO - Creating virtualenv /builds/slave/test/build/venv 05:46: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 05:46:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:46:01 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:46:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:46:01 INFO - Using real prefix '/usr' 05:46:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:03 INFO - Installing pip.................done. 05:46:03 INFO - Return code: 0 05:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:03 INFO - Reading from file tmpfile_stdout 05:46:03 INFO - Output received: 05:46:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:46:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:03 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:46:03 INFO - Using env: {'DISPLAY': ':0', 05:46:03 INFO - 'HOME': '/home/cltbld', 05:46:03 INFO - 'LANG': 'en_US.UTF-8', 05:46:03 INFO - 'LANGUAGE': 'en_US:en', 05:46:03 INFO - 'LOGNAME': 'cltbld', 05:46:03 INFO - 'MAIL': '/var/mail/cltbld', 05:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:03 INFO - 'MOZ_NO_REMOTE': '1', 05:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:03 INFO - 'NO_EM_RESTART': '1', 05:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:03 INFO - 'PWD': '/builds/slave/test', 05:46:03 INFO - 'SHELL': '/bin/bash', 05:46:03 INFO - 'SHLVL': '1', 05:46:03 INFO - 'TERM': 'linux', 05:46:03 INFO - 'TMOUT': '86400', 05:46:03 INFO - 'USER': 'cltbld', 05:46:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:03 INFO - '_': '/tools/buildbot/bin/python'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46: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 05:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46: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')]} 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46: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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46: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 05:46: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 05:46:04 INFO - Using env: {'DISPLAY': ':0', 05:46:04 INFO - 'HOME': '/home/cltbld', 05:46:04 INFO - 'LANG': 'en_US.UTF-8', 05:46:04 INFO - 'LANGUAGE': 'en_US:en', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MAIL': '/var/mail/cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SHLVL': '1', 05:46:04 INFO - 'TERM': 'linux', 05:46:04 INFO - 'TMOUT': '86400', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - '_': '/tools/buildbot/bin/python'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 INFO - Downloading/unpacking psutil>=3.1.1 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:05 INFO - Installing collected packages: psutil 05:46:05 INFO - Running setup.py install for psutil 05:46:05 INFO - building 'psutil._psutil_linux' extension 05:46:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:46:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:46:05 INFO - building 'psutil._psutil_posix' extension 05:46:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:46:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:46:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:06 INFO - Successfully installed psutil 05:46:06 INFO - Cleaning up... 05:46:06 INFO - Return code: 0 05:46:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46: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')]} 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46: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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46: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 05:46: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 05:46:06 INFO - Using env: {'DISPLAY': ':0', 05:46:06 INFO - 'HOME': '/home/cltbld', 05:46:06 INFO - 'LANG': 'en_US.UTF-8', 05:46:06 INFO - 'LANGUAGE': 'en_US:en', 05:46:06 INFO - 'LOGNAME': 'cltbld', 05:46:06 INFO - 'MAIL': '/var/mail/cltbld', 05:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:06 INFO - 'MOZ_NO_REMOTE': '1', 05:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:06 INFO - 'NO_EM_RESTART': '1', 05:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:06 INFO - 'PWD': '/builds/slave/test', 05:46:06 INFO - 'SHELL': '/bin/bash', 05:46:06 INFO - 'SHLVL': '1', 05:46:06 INFO - 'TERM': 'linux', 05:46:06 INFO - 'TMOUT': '86400', 05:46:06 INFO - 'USER': 'cltbld', 05:46:06 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:06 INFO - '_': '/tools/buildbot/bin/python'} 05:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:07 INFO - Installing collected packages: mozsystemmonitor 05:46:07 INFO - Running setup.py install for mozsystemmonitor 05:46:07 INFO - Successfully installed mozsystemmonitor 05:46:07 INFO - Cleaning up... 05:46:07 INFO - Return code: 0 05:46:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:07 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:46:07 INFO - Using env: {'DISPLAY': ':0', 05:46:07 INFO - 'HOME': '/home/cltbld', 05:46:07 INFO - 'LANG': 'en_US.UTF-8', 05:46:07 INFO - 'LANGUAGE': 'en_US:en', 05:46:07 INFO - 'LOGNAME': 'cltbld', 05:46:07 INFO - 'MAIL': '/var/mail/cltbld', 05:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:07 INFO - 'MOZ_NO_REMOTE': '1', 05:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:07 INFO - 'NO_EM_RESTART': '1', 05:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:07 INFO - 'PWD': '/builds/slave/test', 05:46:07 INFO - 'SHELL': '/bin/bash', 05:46:07 INFO - 'SHLVL': '1', 05:46:07 INFO - 'TERM': 'linux', 05:46:07 INFO - 'TMOUT': '86400', 05:46:07 INFO - 'USER': 'cltbld', 05:46:07 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:07 INFO - '_': '/tools/buildbot/bin/python'} 05:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:46: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 05:46: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 05:46: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 05:46: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 05:46:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46: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 05:46: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 05:46: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 05:46: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 05:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:09 INFO - warning: no files found matching '*.txt' 05:46:09 INFO - no previously-included directories found matching 'build' 05:46:09 INFO - no previously-included directories found matching 'dist' 05:46:09 INFO - no previously-included directories found matching '.git*' 05:46:09 INFO - Installing collected packages: jsonschema, functools32 05:46:09 INFO - Running setup.py install for functools32 05:46:09 INFO - warning: no files found matching '*.txt' 05:46:09 INFO - no previously-included directories found matching 'build' 05:46:09 INFO - no previously-included directories found matching 'dist' 05:46:09 INFO - no previously-included directories found matching '.git*' 05:46:09 INFO - Successfully installed jsonschema functools32 05:46:09 INFO - Cleaning up... 05:46:09 INFO - Return code: 0 05:46:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:09 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:46:09 INFO - Using env: {'DISPLAY': ':0', 05:46:09 INFO - 'HOME': '/home/cltbld', 05:46:09 INFO - 'LANG': 'en_US.UTF-8', 05:46:09 INFO - 'LANGUAGE': 'en_US:en', 05:46:09 INFO - 'LOGNAME': 'cltbld', 05:46:09 INFO - 'MAIL': '/var/mail/cltbld', 05:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:09 INFO - 'MOZ_NO_REMOTE': '1', 05:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:09 INFO - 'NO_EM_RESTART': '1', 05:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:09 INFO - 'PWD': '/builds/slave/test', 05:46:09 INFO - 'SHELL': '/bin/bash', 05:46:09 INFO - 'SHLVL': '1', 05:46:09 INFO - 'TERM': 'linux', 05:46:09 INFO - 'TMOUT': '86400', 05:46:09 INFO - 'USER': 'cltbld', 05:46:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:09 INFO - '_': '/tools/buildbot/bin/python'} 05:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:09 INFO - Cleaning up... 05:46:09 INFO - Return code: 0 05:46:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:09 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:46:09 INFO - Using env: {'DISPLAY': ':0', 05:46:09 INFO - 'HOME': '/home/cltbld', 05:46:09 INFO - 'LANG': 'en_US.UTF-8', 05:46:09 INFO - 'LANGUAGE': 'en_US:en', 05:46:09 INFO - 'LOGNAME': 'cltbld', 05:46:09 INFO - 'MAIL': '/var/mail/cltbld', 05:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:09 INFO - 'MOZ_NO_REMOTE': '1', 05:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:09 INFO - 'NO_EM_RESTART': '1', 05:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:09 INFO - 'PWD': '/builds/slave/test', 05:46:09 INFO - 'SHELL': '/bin/bash', 05:46:09 INFO - 'SHLVL': '1', 05:46:09 INFO - 'TERM': 'linux', 05:46:09 INFO - 'TMOUT': '86400', 05:46:09 INFO - 'USER': 'cltbld', 05:46:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:09 INFO - '_': '/tools/buildbot/bin/python'} 05:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:46: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 05:46: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 05:46: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 05:46: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 05:46:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46: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 05:46: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 05:46: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 05:46: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 05:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46: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 05:46: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 05:46: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 05:46: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 05:46:11 INFO - Downloading docopt-0.6.1.tar.gz 05:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:11 INFO - Running setup.py install for blobuploader 05:46:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:11 INFO - Running setup.py install for requests 05:46:11 INFO - Running setup.py install for docopt 05:46:11 INFO - Successfully installed blobuploader requests docopt 05:46:11 INFO - Cleaning up... 05:46:11 INFO - Return code: 0 05:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:11 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:11 INFO - Using env: {'DISPLAY': ':0', 05:46:11 INFO - 'HOME': '/home/cltbld', 05:46:11 INFO - 'LANG': 'en_US.UTF-8', 05:46:11 INFO - 'LANGUAGE': 'en_US:en', 05:46:11 INFO - 'LOGNAME': 'cltbld', 05:46:11 INFO - 'MAIL': '/var/mail/cltbld', 05:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:11 INFO - 'MOZ_NO_REMOTE': '1', 05:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:11 INFO - 'NO_EM_RESTART': '1', 05:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:11 INFO - 'PWD': '/builds/slave/test', 05:46:11 INFO - 'SHELL': '/bin/bash', 05:46:11 INFO - 'SHLVL': '1', 05:46:11 INFO - 'TERM': 'linux', 05:46:11 INFO - 'TMOUT': '86400', 05:46:11 INFO - 'USER': 'cltbld', 05:46:11 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:11 INFO - '_': '/tools/buildbot/bin/python'} 05:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:12 INFO - Running setup.py (path:/tmp/pip-ZJryxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:12 INFO - Running setup.py (path:/tmp/pip-5zC3qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:12 INFO - Running setup.py (path:/tmp/pip-SgAv0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:12 INFO - Running setup.py (path:/tmp/pip-0cFpBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:12 INFO - Running setup.py (path:/tmp/pip-mPDPyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:12 INFO - Running setup.py (path:/tmp/pip-ZWRFe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:12 INFO - Running setup.py (path:/tmp/pip-yehwIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Running setup.py (path:/tmp/pip-_5a8Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Running setup.py (path:/tmp/pip-qAaK9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Running setup.py (path:/tmp/pip-EXRz9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:12 INFO - Running setup.py (path:/tmp/pip-_RTPrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:13 INFO - Running setup.py (path:/tmp/pip-idvmr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:13 INFO - Running setup.py (path:/tmp/pip-kqHI_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:13 INFO - Running setup.py (path:/tmp/pip-rTpzpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:13 INFO - Running setup.py (path:/tmp/pip-fKbA8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:13 INFO - Running setup.py (path:/tmp/pip-dmIj2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:13 INFO - Running setup.py (path:/tmp/pip-HVQ1cm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:13 INFO - Running setup.py install for manifestparser 05:46:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozcrash 05:46:13 INFO - Running setup.py install for mozdebug 05:46:13 INFO - Running setup.py install for mozdevice 05:46:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:13 INFO - Running setup.py install for mozfile 05:46:13 INFO - Running setup.py install for mozhttpd 05:46:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozinfo 05:46:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozInstall 05:46:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozleak 05:46:14 INFO - Running setup.py install for mozlog 05:46:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for moznetwork 05:46:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozprocess 05:46:14 INFO - Running setup.py install for mozprofile 05:46:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozrunner 05:46:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:14 INFO - Running setup.py install for mozscreenshot 05:46:14 INFO - Running setup.py install for moztest 05:46:15 INFO - Running setup.py install for mozversion 05:46:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:15 INFO - Cleaning up... 05:46:15 INFO - Return code: 0 05:46:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:15 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:46:15 INFO - Using env: {'DISPLAY': ':0', 05:46:15 INFO - 'HOME': '/home/cltbld', 05:46:15 INFO - 'LANG': 'en_US.UTF-8', 05:46:15 INFO - 'LANGUAGE': 'en_US:en', 05:46:15 INFO - 'LOGNAME': 'cltbld', 05:46:15 INFO - 'MAIL': '/var/mail/cltbld', 05:46:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:15 INFO - 'MOZ_NO_REMOTE': '1', 05:46:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:15 INFO - 'NO_EM_RESTART': '1', 05:46:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:15 INFO - 'PWD': '/builds/slave/test', 05:46:15 INFO - 'SHELL': '/bin/bash', 05:46:15 INFO - 'SHLVL': '1', 05:46:15 INFO - 'TERM': 'linux', 05:46:15 INFO - 'TMOUT': '86400', 05:46:15 INFO - 'USER': 'cltbld', 05:46:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:15 INFO - '_': '/tools/buildbot/bin/python'} 05:46:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:15 INFO - Running setup.py (path:/tmp/pip-huRq9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:15 INFO - Running setup.py (path:/tmp/pip-ix6UBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:15 INFO - Running setup.py (path:/tmp/pip-EpL108-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:15 INFO - Running setup.py (path:/tmp/pip-ikJGUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:15 INFO - Running setup.py (path:/tmp/pip-wqdPCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:15 INFO - Running setup.py (path:/tmp/pip-GVkx5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:15 INFO - Running setup.py (path:/tmp/pip-An2r6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:46:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:15 INFO - Running setup.py (path:/tmp/pip-XdhpaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46: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)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:16 INFO - Running setup.py (path:/tmp/pip-f8JnfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46: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)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:16 INFO - Running setup.py (path:/tmp/pip-ixVmgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46: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)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:16 INFO - Running setup.py (path:/tmp/pip-FqjhAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46: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)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:16 INFO - Running setup.py (path:/tmp/pip-qxQRmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:16 INFO - Running setup.py (path:/tmp/pip-_x5PH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:16 INFO - Running setup.py (path:/tmp/pip-HKPUJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:16 INFO - Running setup.py (path:/tmp/pip-HDMRBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:16 INFO - Running setup.py (path:/tmp/pip-vpzbFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:46:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:16 INFO - Running setup.py (path:/tmp/pip-kJ1ohG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:46:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:17 INFO - Downloading blessings-1.6.tar.gz 05:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:17 INFO - Installing collected packages: blessings 05:46:17 INFO - Running setup.py install for blessings 05:46:17 INFO - Successfully installed blessings 05:46:17 INFO - Cleaning up... 05:46:17 INFO - Return code: 0 05:46:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:18 INFO - Reading from file tmpfile_stdout 05:46:18 INFO - Current package versions: 05:46:18 INFO - argparse == 1.2.1 05:46:18 INFO - blessings == 1.6 05:46:18 INFO - blobuploader == 1.2.4 05:46:18 INFO - docopt == 0.6.1 05:46:18 INFO - functools32 == 3.2.3-2 05:46:18 INFO - jsonschema == 2.5.1 05:46:18 INFO - manifestparser == 1.1 05:46:18 INFO - mozInstall == 1.13 05:46:18 INFO - mozcrash == 1.0 05:46:18 INFO - mozdebug == 0.1 05:46:18 INFO - mozdevice == 0.51 05:46:18 INFO - mozfile == 1.2 05:46:18 INFO - mozhttpd == 0.7 05:46:18 INFO - mozinfo == 0.10 05:46:18 INFO - mozleak == 0.1 05:46:18 INFO - mozlog == 3.5 05:46:18 INFO - moznetwork == 0.27 05:46:18 INFO - mozprocess == 0.25 05:46:18 INFO - mozprofile == 0.28 05:46:18 INFO - mozrunner == 6.13 05:46:18 INFO - mozscreenshot == 0.1 05:46:18 INFO - mozsystemmonitor == 0.3 05:46:18 INFO - moztest == 0.8 05:46:18 INFO - mozversion == 1.4 05:46:18 INFO - psutil == 3.1.1 05:46:18 INFO - requests == 1.2.3 05:46:18 INFO - wsgiref == 0.1.2 05:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46: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')]} 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46: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')]} 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46: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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46: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 05:46: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 05:46:18 INFO - Using env: {'DISPLAY': ':0', 05:46:18 INFO - 'HOME': '/home/cltbld', 05:46:18 INFO - 'LANG': 'en_US.UTF-8', 05:46:18 INFO - 'LANGUAGE': 'en_US:en', 05:46:18 INFO - 'LOGNAME': 'cltbld', 05:46:18 INFO - 'MAIL': '/var/mail/cltbld', 05:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:18 INFO - 'MOZ_NO_REMOTE': '1', 05:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:18 INFO - 'NO_EM_RESTART': '1', 05:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:18 INFO - 'PWD': '/builds/slave/test', 05:46:18 INFO - 'SHELL': '/bin/bash', 05:46:18 INFO - 'SHLVL': '1', 05:46:18 INFO - 'TERM': 'linux', 05:46:18 INFO - 'TMOUT': '86400', 05:46:18 INFO - 'USER': 'cltbld', 05:46:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:18 INFO - '_': '/tools/buildbot/bin/python'} 05:46:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:46:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:46:18 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:46:19 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:46:19 INFO - Installing collected packages: marionette-driver, simplejson 05:46:19 INFO - Running setup.py install for marionette-driver 05:46:19 INFO - Running setup.py install for simplejson 05:46:20 INFO - building 'simplejson._speedups' extension 05:46: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 05:46:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:46:20 INFO - Successfully installed marionette-driver simplejson 05:46:20 INFO - Cleaning up... 05:46:20 INFO - Return code: 0 05:46:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:20 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 0x18061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19d4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b77b90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, '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': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:46:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:46:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:46:20 INFO - Using env: {'DISPLAY': ':0', 05:46:20 INFO - 'HOME': '/home/cltbld', 05:46:20 INFO - 'LANG': 'en_US.UTF-8', 05:46:20 INFO - 'LANGUAGE': 'en_US:en', 05:46:20 INFO - 'LOGNAME': 'cltbld', 05:46:20 INFO - 'MAIL': '/var/mail/cltbld', 05:46:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:20 INFO - 'MOZ_NO_REMOTE': '1', 05:46:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:20 INFO - 'NO_EM_RESTART': '1', 05:46:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:20 INFO - 'PWD': '/builds/slave/test', 05:46:20 INFO - 'SHELL': '/bin/bash', 05:46:20 INFO - 'SHLVL': '1', 05:46:20 INFO - 'TERM': 'linux', 05:46:20 INFO - 'TMOUT': '86400', 05:46:20 INFO - 'USER': 'cltbld', 05:46:20 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:20 INFO - '_': '/tools/buildbot/bin/python'} 05:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:21 INFO - Cleaning up... 05:46:21 INFO - Return code: 0 05:46:21 INFO - Running post-action listener: _resource_record_post_action 05:46:21 INFO - Running post-action listener: _start_resource_monitoring 05:46:21 INFO - Starting resource monitoring. 05:46:21 INFO - [mozharness: 2017-07-17 12:46:21.235762Z] Finished create-virtualenv step (success) 05:46:21 INFO - [mozharness: 2017-07-17 12:46:21.236278Z] Running install step. 05:46:21 INFO - Running pre-action listener: _resource_record_pre_action 05:46:21 INFO - Running main action method: install 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:21 INFO - Reading from file tmpfile_stdout 05:46:21 INFO - Output received: 05:46:21 INFO - Usage: mozinstall [options] installer 05:46:21 INFO - Options: 05:46:21 INFO - -h, --help show this help message and exit 05:46:21 INFO - -d DEST, --destination=DEST 05:46:21 INFO - Directory to install application into. [default: 05:46:21 INFO - "/builds/slave/test"] 05:46:21 INFO - --app=APP Application being installed. [default: firefox] 05:46:21 INFO - mkdir: /builds/slave/test/build/application 05:46:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:46:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:46:39 INFO - Reading from file tmpfile_stdout 05:46:39 INFO - Output received: 05:46:39 INFO - /builds/slave/test/build/application/firefox/firefox 05:46:39 INFO - Running post-action listener: _resource_record_post_action 05:46:39 INFO - [mozharness: 2017-07-17 12:46:39.572450Z] Finished install step (success) 05:46:39 INFO - [mozharness: 2017-07-17 12:46:39.572571Z] Running setup-mitmproxy step. 05:46:39 INFO - Running pre-action listener: _resource_record_pre_action 05:46:39 INFO - Running main action method: setup_mitmproxy 05:46:39 INFO - Skipping: mitmproxy is not required 05:46:39 INFO - Running post-action listener: _resource_record_post_action 05:46:39 INFO - [mozharness: 2017-07-17 12:46:39.573109Z] Finished setup-mitmproxy step (success) 05:46:39 INFO - [mozharness: 2017-07-17 12:46:39.573211Z] Running run-tests step. 05:46:39 INFO - Running pre-action listener: _resource_record_pre_action 05:46:39 INFO - Running pre-action listener: _set_gcov_prefix 05:46:39 INFO - Running main action method: run_tests 05:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:39 INFO - Python 2.7.3 05:46:39 INFO - Return code: 0 05:46:39 INFO - grabbing minidump binary from tooltool 05:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:39 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 0x1b74d10>, '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 0x1b75c10>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b760c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:46:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:46:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:46:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:39 INFO - Return code: 0 05:46:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:46:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:39 INFO - ENV: RUST_BACKTRACE is now 1 05:46:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:46:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 05:46:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:46:39 INFO - Using env: {'DISPLAY': ':0', 05:46:39 INFO - 'HOME': '/home/cltbld', 05:46:39 INFO - 'LANG': 'en_US.UTF-8', 05:46:39 INFO - 'LANGUAGE': 'en_US:en', 05:46:39 INFO - 'LOGNAME': 'cltbld', 05:46:39 INFO - 'MAIL': '/var/mail/cltbld', 05:46:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:39 INFO - 'MOZ_NO_REMOTE': '1', 05:46:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:46:39 INFO - 'NO_EM_RESTART': '1', 05:46:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:39 INFO - 'PWD': '/builds/slave/test', 05:46:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:39 INFO - 'RUST_BACKTRACE': '1', 05:46:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:46:39 INFO - 'SHELL': '/bin/bash', 05:46:39 INFO - 'SHLVL': '1', 05:46:39 INFO - 'TERM': 'linux', 05:46:39 INFO - 'TMOUT': '86400', 05:46:39 INFO - 'USER': 'cltbld', 05:46:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325', 05:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:39 INFO - '_': '/tools/buildbot/bin/python'} 05:46:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:46:39 INFO - mozversion application_buildid: 20170717120507 05:46:39 INFO - mozversion application_changeset: b8783d6fffdbebed01455743185cea68784d5367 05:46:39 INFO - mozversion application_display_name: Nightly 05:46:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:39 INFO - mozversion application_name: Firefox 05:46:39 INFO - mozversion application_remotingname: firefox 05:46:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:39 INFO - mozversion application_vendor: Mozilla 05:46:39 INFO - mozversion application_version: 56.0a1 05:46:39 INFO - mozversion platform_buildid: 20170717120507 05:46:39 INFO - mozversion platform_changeset: b8783d6fffdbebed01455743185cea68784d5367 05:46:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:39 INFO - mozversion platform_version: 56.0a1 05:46:39 INFO - using testdate: 1500295599 05:46:39 INFO - actual date: 1500295599 05:46:39 INFO - starting webserver on 'localhost:54126' 05:46:39 INFO - SUITE-START | Running 2 tests 05:46:39 INFO - TEST-START | dromaeo_css 05:46:39 INFO - Initialising browser for dromaeo_css test... 05:46:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54126/getInfo.html -profile /tmp/tmpjuudVr/profile 05:46:39 INFO - TEST-INFO | started process 17117 (/builds/slave/test/build/application/firefox/firefox http://localhost:54126/getInfo.html) 05:46:46 INFO - TEST-INFO | 17117: exit 0 05:46:46 INFO - Browser initialized. 05:46:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:46 INFO - TEST-INFO | started process 17322 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjuudVr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:57 INFO - PID 17322 | RSS: Main: 167534592 05:46:57 INFO - PID 17322 | 05:49:54 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54126/tests/dromaeo/cssquery-ext.html) 05:49:57 INFO - PID 17322 | RSS: Main: 176062464 05:49:57 INFO - PID 17322 | 05:52:59 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-ext.html (next: http://localhost:54126/tests/dromaeo/cssquery-jquery.html) 05:52:59 INFO - PID 17322 | RSS: Main: 173588480 05:52:59 INFO - PID 17322 | 05:56:01 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54126/tests/dromaeo/cssquery-mootools.html) 05:56:01 INFO - PID 17322 | RSS: Main: 176205824 05:56:01 INFO - PID 17322 | 05:59:03 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54126/tests/dromaeo/cssquery-prototype.html) 05:59:04 INFO - PID 17322 | RSS: Main: 172396544 05:59:04 INFO - PID 17322 | 06:02:07 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54126/tests/dromaeo/cssquery-yui.html) 06:02:07 INFO - PID 17322 | RSS: Main: 174575616 06:02:07 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | Cycle 1(1): loaded http://localhost:54126/tests/dromaeo/cssquery-yui.html (next: http://localhost:54126/tests/dromaeo/cssquery-dojo.html) 06:05:09 INFO - PID 17322 | RSS: Main: 177848320 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | __start_tp_report 06:05:09 INFO - PID 17322 | _x_x_mozilla_page_load 06:05:09 INFO - PID 17322 | _x_x_mozilla_page_load_details 06:05:09 INFO - PID 17322 | |i|pagename|runs| 06:05:09 INFO - PID 17322 | |0;dojo.html;3029.757619390449;3085.0898984799483;3098.6281646202456;3111.0511294055304;3131.8590663420146;5882.85292867678;5938.970305148479;5952.6726030068385;5963.926493231216;6025.548083893704;6036.607620504675;6063.605865618742;6070.514358851292;6073.271207455112;6090.451859332659;5441.075017247058;5488.451154884509;5571.303587051619;5597.216389705444;5603.859903502404;5480.972595137018;5510.283663123809;5533.391326954032;5539.141433077859;5581.916271255935;5369.919451208235;5379.139337705968;5391.622586418952;5408.215808707735;5522.889542209154;5351.571874250089;5354.554270346985;5357.571394288487;5358.571314294847;5373.650712703662;5274.525292723673;5309.787608495655;5311.309529761106;5319.946800532022;5326.7070311132875;5682.914756278659;5694;5705.486506214461;5715.1713001614535;5742.454466825645;6131.202943617346;6179.81460556184;6184.6907654617535;6195.287541932646;6203.2866220384785;6270.46701030413;6281.403266689657;6282.748690052393;6306.590071645374;6309.432151106376;5824.737886795105;5853.64878107315;5964.910526342108;5980.102984552352;6044.455998960071;6566.343365663491;6572.441342485942;6628.536002479828;6675.365840245169;6696.129503164655;6107.083937409336;6159.353267906805;6190.102435146969;6297.992321228673;6361.332060133619;6268.435840774352;6268.843278917972;6271.717772700239;6274.623522588659;6279.717412716439;5266.4470230626;6193.876122477525;6242;6251.062340648939;6465.515086368541;6388.840278993062;6397.648129352837;6458.6770661466735;6465.353464653591;6468.482521398277;5100.209467532539;5150.48495150482;5196.298499702491;5243.213517972258;5252.868678283074;4388.2759344707765;4424.446944131983;4427.158839820424;4469.08383781324;4480.708753930984;5467.371252306036;5476.863078423071;5483.341998960151;5486.423925487767;5492.1212605982855;6255.218097737783;6289.465395441347;6431.292557818636;6435.388638079375;6493.642849643221;5563.13771365439;5571.9442805572235;5594.132909398968;5620.297462817148;5633.690147041952;5607.074832652648;5636.464535869086;5695.231143795618;5710.143478478261;5712.828615141552;6109.84725381869;6166.630002199882;6170.413810687977;6171.660558669317;6176.845578860474;6230.719617617127;6243.188385509855;6251.312355640966;6252.718627661675;6274.968625156845;6011.579189456871;6101.206843110367;6110.847228819315;6114.021756518936;6127.6936153193055;6125.326214116354;6187.3503282154725;6189.628622282497;6192.690365481618;6195.070739388947;5487.204355368529;6278.529110316653;6346.936530634819;6417.839554011187;6418.518611104092;6174.9073763892675;6188;6279.686015699105;6284.3087260402235;6290.0879372491645;6136.171616831671;6190.1952746142715;6276.529260305404;6277.278113016879;6287.245530536365;6014.368491308524;6093;6099.054646529795;6105.175801266772;6111.938880611137;6159.876802464015;6175.475084617858;6189.535784816247;6193.81418557444;6195.4424101831055;6015.488683461955;6024.849378765566;6025.548083893638;6047.153398524298;6048.637081775108 06:05:09 INFO - PID 17322 | |1;ext.html;768.7002069193015;843.1231519220004;872.0581771686577;897.1163404047013;897.5243121145795;40509;41193.58806411935;41413.7929310353;41458.17083658329;41798;38568.421473677845;38613.613863861356;38646.613533864656;38750.418743718794;38820.80589597055;6750.594964302145;6829.726810927557;6917.550359226634;6918.377346038856;6933.72265109395;6801.4558835293055;6900.137482814648;6901.861962760741;6904.378605925465;6914.412274956635;6859.897101543481;6879.380855722984;6886.75896343628;6894.517383783137;6904.344087311697;6757.459403247728;6811.046453496514;6835.213950395719;6857.348551887562;6859.519833611649;6240.625562466266;6274.435300822948;6311.2426508819235;6312.621242725451;6326.588771729869;33740.49389259163;33889.491657625156;33966.32067358639;34023.31953360919;34241.14397140066;3386.508956201337;3403.5405220295193;3440.9827950860085;3480.095175254427;3588.5693716753894;31241.53137702936;31610.367792644247;31626.683733162605;31667.683323166704;31674.683253167404;4752.809887604491;4787.8563643090765;4836.22620380741;4846.878828029292;4899.583535399495;186840;187002;190321;192426;192666;42286.788566056974;44989.32516012262;47198.82002949885;47287;47545.5245447548;48271.5172848267;48589;48658.27012594814;48750.75624621925;48826;16043.919780401024;16150.273237704096;16246.187690615421;16260.349586016428;16366.590835229215;13337.333133343294;13372.598822035354;13394.799078013837;13395.732085358239;13497.66255843592;13918.512852050331;14010.789838152436;14042.297885105909;14074.085184462978;14265.714685706227;5681.801136960186;5736.196932429463;5823.621464604787;5900.7608402235155;5937.198478205387;978.1929907826072;978.8727465429448;991.1575161113141;1030.30454443252;1035.2804800663466;22414.663780043313;22761.544769104526;22815.771842281698;22905.770942290696;23101.19145829888;1097.6268068856627;1103.2167161315556;1107.3355986408092;1125.7354521687396;1129.9943500282445;11769.411529423494;11773.646790596296;11985.041196704242;12079.456424460921;12164.08769342303;230229;232740;233467;233971;235025;50434.74782626063;50577.24134137991;50911;51137.744311278206;51446.485535144915;1436.1598464898152;1460.9269536523343;1484.2356186563927;1493.6041948883556;1499.7900293958855;21339.573208536054;21679.791580318626;21721.456963576038;22404;22762.65856012194;36415;36464.635353646125;36481.452778207815;36574.4513832298;36750;187613;187853;188635.0568247205;188706;189508;33274.667253327156;33714;34567.481487778205;36493;36767.81616091902;44081.11837763291;44714.776426118966;44950.325745113194;45068;46036.53963460323;32070.83964580162;32639;32679.673203267663;32731.018069457954;33049.83475082609;31744.60700715069;32292.838535807172;32697.509537356484;32795.672043279264;32895.342093158484;35510;35949.1012724684;36143.63856361508;36176.819115904254;36435.27129457343;28645.856770716015;30574.694253057183;31000.844995774878;31974.200644984063;32107.518387224678;23555.76444235604;23928.760712392654;24049.879750601136;24091.759082408953;24184.274471765875 06:05:09 INFO - PID 17322 | |2;jquery.html;565.7765182752815;568.1960026562415;569.106502790619;585.1106318396037;590.9202257695212;15910.84089159108;21580.244691435782;22188.334349969507;22296;22515.662265066017;18932.337368192115;19254.807451925477;19364.806351936477;21177.68233476499;22148.557028859454;3847.442120892476;3953.6639385652256;6569.7700580479695;6583.506237032242;6590.901136482957;6409.519286053542;6572.244191917919;6586.209654841402;6598.505112116586;6620.337966203389;6528.445082168021;6571.572847764904;6573.211214654224;6583.275839657657;6588.934110658904;6467;6548.05053267276;6570.8685826283445;6578.80263592093;6584.078229047937;5327.813526526592;5532.1425179097305;5839.357670656267;5850.590458667895;5856.882862342772;27207.45585088307;27735.445291094267;27755.444891102066;27761.444771104463;27762;1842.0973722875829;1865.3005123078844;1872.7097299918535;1876.4276895546852;1876.8498520118358;17093.487195384158;17463;17926.91036544822;17961.10194490283;17970;2269.2851751698163;2325.3140323604575;2361.6221404575185;2363.409147713072;2365.1840115160244;118710.21934670987;125443.60947366798;125462.3726881369;131919;146276;19215.423537293904;20096.296629617893;20322.89838550798;20793.480162996046;22207.66688499674;41252;41352;41820.16359672789;41976;42030.789846050575;10641.04230619248;10901.945490272497;11030.28303160292;11030.669079927615;11094.261313752018;8895.644174233088;8912.376133670581;9078.682246121354;9087.136722011399;9191.586378612978;10660.507528945955;10905.709800941891;11377.431128443544;11429.942850285695;11452.427378631035;4201.579842015774;4208.905684522047;4218.282891908383;4228.894277643083;4284.657227421799;958.712386284112;960.2222200017868;975.4488713876636;981.5926390547843;985.9950700246453;17925.56089222958;18496.260149593865;18788.342408015655;18802.717959230624;19262.80737192638;1013.2501948558162;1033.6692258477215;1033.6743925663393;1042.8279333909973;1053.6259627832162;10309.94845025785;10359.274850760374;10502.737431564272;10577;10644.89355106439;448868;456238;460823;475136;491619;101628;101703.49148254211;103703.96296037093;105144;105704;1198.2211562484456;1219.9329036903055;1240.2186622427812;1257.4718618180386;1257.6227131860587;15985.600359991093;16582.756293277813;16801;16814.915925420293;17220.569485762455;52662;52979.20531192112;54324.45675543352;54346;54535.72732136473;63996.68001659962;66127;66133.008004879;66457.66771166114;66713.33286667266;19000.429987100408;19186;19232.807671923103;19321.710174347114;19505.70741438851;21426.357209283746;21769.782302176776;21912.671309930683;22135.44661383478;22218.666719999535;17229.483115506555;17401.738973915653;17564.473065807535;17646;17768.822311777232;14051;15081.924590376977;15260.23698815077;16262.186890655657;16448.424305149263;17837.73243401324;18004.099795010457;19142.234310627977;19315.4205373839;19334.61330773405;14023.579292621238;14427.49503767363;14432.494862679756;14467.638309042359;14478.348474318891;13854.238016909167;14611;17126.571835704206;18409.355672551395;18419.81580184181 06:05:09 INFO - PID 17322 | |3;mootools.html;1303.1594621469153;1345.0853419674625;1364.8362196536418;1372.5401990333237;1380.2546624822596;13134.671633209175;13797.24115173665;13847.238401887893;13851.09967852089;13871.375788089535;13320.533781317656;13957.511487097954;13977.860221397783;13978.860211397883;14029.719405611882;2605.8175927685024;2666.0668765931864;2681.5307321218806;2686.5164270431414;2704.445588654331;2472.468419289852;2546.8471891686468;2558.8976440942433;2560.2063360358256;2562.5643640581147;2562.2185233503774;2579.21333993132;2600.8829602667925;2610.6345111684377;2613.7255588163252;2438.3904023994;2468.160825319391;2471.1104002559064;2477.4301910560494;2490.452100537879;2440.1703420836825;2443.621238708003;2455.0670745116918;2458.31167273162;2463.8275320727557;13150;13421.993350498751;13451.32743362828;13461.596152115451;13465.461381544726;7145.857082858366;7414.925850741478;7418.777436676908;7447.292507211806;7467.402607791364;4978.2034874419915;5000.2499625056535;5070.138076527;5234.476552344773;5244.842654720364;1867.1037901807074;1881.990590047041;1892.706630472279;1942.5532127610588;1955.6773132433132;19081.61836763271;19694.80305196944;21425.785742142692;21863.344099677037;21867.234646787445;5602.971985140048;6284.151639528605;6550.528220043385;6586.110875031809;6631.469482441393;15314.846851531565;15333.539993800205;15396.153211573472;15411.152386618844;15462.768058479132;7173.10336207974;7381.224971378036;7397.704091836374;7415.40676745859;7435.8141046474275;6732.3267673232285;6749.966250168718;6808.08090907731;6858.931410685829;6866.896996545056;4755.595774359149;4917.803287868517;4925.532074452921;4961.479044700327;4967.4784147664695;1421.076300404745;1431.355889849551;1443.8050863133553;1479.659678274003;1485.4058376649211;891.9643214271357;895.8611415230649;910.9544522773834;924.6162842420455;937.2642475656577;7057.541259818096;7113.146422429341;7186.568805871664;7223.097112860893;7276.96361518189;729.6278897762179;731.4148681055241;731.6012773038707;741.3328004795727;751.7444069016451;4596.724196548218;4860.36815214027;5188.792448302026;5301.946980530145;5390.838274851761;17176.570585735208;18175.182116804775;18498.907505462656;18534.721979170325;18663.44009679712;17944.37194698179;18146.3648772295;18695.532611684815;18827.623447530972;18917.7162342565;9507.239420846316;10499.160067194605;10573;10598.523066462181;10603.628872989408;7373.741919032808;7478.1400138982535;7760.883586746316;7784.494007889469;7821.335186509211;15334;15883.047017179006;16002.919985399998;16253.59366015859;16266;16007.279672414536;16318.18409079565;16666.833331666527;16724.832751672813;16886.40897568579;10137;10220.540075696761;11538.538458461904;11556.248843825124;11565.710857228636;12705.555305564261;12803.359832008176;12893.290869002294;12900.225986440844;12903.419346129635;9797.21622270231;10135;10139.949300253451;10250.846237306298;10319.742006449598;10044.296899216984;10145.898541014496;10184.643537476153;10352.327098738559;10510.78978420412;8408.2432581068;8442.957785211034;8501.95749021251;8503.107173746668;8540.10328915455;6643.136392268974;6896.413804826445;6969.02433659278;7094.503384763017;7124.750633727795;6794.966025169842;6832.93167068323;7066.434685225273;7080.2919708028785;7164.820879478055 06:05:09 INFO - PID 17322 | |4;prototype.html;476.3045952908753;489.94610592834783;509.7629602234961;510.41557416757814;519.0682724509505;6042.425969532893;6059.121427393031;6159.260888693358;6183.75264989401;6232.59488133271;5856.736446859891;5922.792702255411;5991;6071.180390647272;6115.908261376083;4904.583110435599;4920.8277710280145;4934.703917764928;4945.134601444751;4988.127077761395;4827.951720482803;4889.926651100236;4928.457869634337;4958.355413796201;4965.627577931651;4855.660103792736;4925.581325587329;4951.23255895335;4954.529319714621;4967.850964471072;4629.6990695604845;4799.208130658437;4827.551734479677;4828.396450443659;4914.852554423355;4297.119090586422;4412.470503539564;4419;4420.690551661385;4443.644508439317;5858.98262394867;5900.704964751745;5949.107633854913;5971.343152253248;5981.252343457068;5569.164625306196;5610.6336198281115;5639.774409023634;5656.953463609246;5667.4615911488345;6427.614343139427;6437.034444833265;6482.773102941374;6532.150820393366;6538.738450461976;4807.158747219222;4821.951780482221;4840.419149702023;4843.58829499493;4849.806007759686;6704.564203326817;6718.83202919926;6844.657767111675;6871.9656401717675;6904.4821638377325;4939.604831613462;5011.824586139468;5023.1711767557945;5025.095482813129;5027.271045698426;5039.622028347889;5056.772445239973;5077.974610126926;5087.745612719349;5109.846704598868;5523.364813046551;5531.3362396511875;5550.583706221969;5581.330240371181;5636.154576813429;6315.778947736807;6347.39699728525;6409.775657852046;6464.612123272619;6477.935220647733;1751.3169863753146;1768.8761786674809;1771.3446024970842;1778.0665150795935;1781.5724226185882;1110.6445937300148;1229.3668760588305;1240.2248594628356;1248.1076030638137;1249.7562975219744;5498.285222920995;5547.8890422192135;5607.80372686954;5611.597100724819;5714.314282286069;6546.70539825709;6563.733573177473;6566.277709451956;6627;6639.734410623521;5556.333240011144;5571.60998730085;5588.776448941997;5593.580481463825;5648.971755141198;3461.567304086989;3506.386382383124;3518.4546395308766;3525.3654342218133;3542.6457354264367;6401.295857455676;6402.231732192166;6442.2591401989375;6481.740730370827;6492.707828147744;6695.196576410862;6829.829254268584;6840.179178498612;6849.760258390932;6858.862822743617;6402.423781859655;6442.516811239082;6475;6476.158099447231;6515.837104072436;6651.966740166268;6682.797096522672;6705.396514313735;6712.563683360566;6717.462602991651;6485.902711459237;6506.869862602816;6617.536772426077;6632.104665870046;6640.468762498892;6379.266384365857;6422.871542569029;6430.549861509649;6457.580257283262;6471.741130354922;4925.753712314298;4933.358663373882;4947.406311242674;4958.826441074545;4972.7762250699525;6555.737770489318;6561.540692151694;6588.8023359299295;6617.5110600114585;6618.172728408949;6387.233531976192;6442.581232219891;6476.449501792212;6497.837554061186;6518.576292541159;6414.198225221848;6418.293987661447;6436.650622522652;6443.452306553995;6471.7734879279;6400.263969643551;6400.615963042046;6425.389587989133;6439.903401449075;6451.516136289703;5933.406659334032;6457.354264573693;6465.321141280097;6479.838004049748;6482.319356467503;6178.845528861814;6203.325102222465;6204.5036397089025;6262.373762623702;6295.150154729236 06:05:09 INFO - PID 17322 | |5;yui.html;887.3566664168475;909.8134882349119;915.066632035324;919.9632014719411;937.7983733497297;15655;16236.756448653265;17242.48272551824;17576.121193940315;17583.73624395632;17657.293708251655;19163.520911977208;19250.51873703158;19307.227710891548;19459;1049.511976930727;1075.623531763884;1078.1213311151425;1078.2398409121552;1080.200651517879;1053.531178625512;1053.8682664666917;1059.221472217923;1060.1571750458365;1061.3207547169818;1046.7540128069897;1096.5942601237552;1099.5052226498067;1123.1183520936067;1125.0774365020645;1080.173667144635;1080.3032044331442;1082.86464191976;1082.9025387715103;1083.8590983172217;792.3225642076058;797.784598158494;798.8202654402771;798.872180451125;799.5602418669708;15319.770203446957;15455.149966751824;15539.5338139856;15552.222388880511;15899.682006359924;19219.135138918784;19225.51936201606;19361.709574356395;19540.120694568777;19869.20523179071;15563.922180389025;15633.140177290245;15659.530214093595;15698.215089245607;15713.528594142193;3414.5048967899515;3453.8100404477746;3488.9651103488895;3515.1739341254784;3541;106185;108282.45858770734;110865.44567277192;111211.44394277976;112348.438257809;14491.275436228147;14638.560843174722;14773.33519991603;14781.187034713193;15079.095254284777;25792.8710356447;26582.6012609811;27189.184324470298;27291;27295.181144565693;8477.152284771473;8481.363897707697;8499.065102838682;8511.616977236039;8512.65949362031;3876.2441323942126;3983.50206224222;3999.420084087791;4000.879973600797;4022.316206244887;4693.413323334583;4790.904181916342;4818.060478206716;4825.372701548777;4828.251620998751;887.1926546842343;926.754410081329;927.1794461901266;946.3848498476045;948.8576713492894;638.1958731997717;705.3933617089299;711.210556282526;722.8554289142193;732.0702707561474;11154.330740155454;11585;12061.758764824654;12246.326452045223;12318.445669944695;661.5567569728294;681.2063945503432;686.498855835243;704.5279662626053;720.1789959446236;5408.296921400193;5431;5509.146082357241;5524.640898341595;5571.832845014656;103116;107045.4647726772;107167;108197;108888.45555772171;89746.55126724455;91811.54094229486;93563.53218233865;94104.52947735354;95102.52448737712;77417.61291193508;79856;81439.59280203443;81828;82113.17886821175;10454.947725261629;10716.732081697708;10910.563577457131;10962.287451315638;11190.160737944849;35402.29195416129;35417.468737969466;35740.82129589335;36369.45445818262;37086.072848179014;45782;46881;48795.51204488052;49212.75393623009;49868.750656246484;14510.564683059525;14775.482858099915;15135.621609459851;15139.924300378869;15374.308156133224;17146;17385.217665204844;17554.297828086732;17592.208350623998;17813.1984060715;14373;17686.292548297923;18943.71584426207;19001.524961876064;19077.332293369665;18538;18679;19059.332923347618;19165.520861978563;19380.224791008764;17171;18000.729989049913;18419.26322947067;18862.717059244398;19668.114934828252;11594.47824847867;12479.438425271066;12920.289384083966;13282.601521954357;13851.16892986424;12852.742945141232;13063.281519516519;14138.50515231962;14173.22047287409;14372.85627143757 06:05:09 INFO - PID 17322 | __end_tp_report 06:05:09 INFO - PID 17322 | __start_cc_report 06:05:09 INFO - PID 17322 | _x_x_mozilla_cycle_collect,365 06:05:09 INFO - PID 17322 | __end_cc_report 06:05:09 INFO - PID 17322 | __startTimestamp1500296709749__endTimestamp 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | ------- Summary: start ------- 06:05:09 INFO - PID 17322 | Number of tests: 6 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#0] dojo.html Cycles:165 Average:5830.95 Median:6073.27 stddev:666.59 (11.0%) stddev-sans-first:631.37 06:05:09 INFO - PID 17322 | Values: 3029.8 3085.1 3098.6 3111.1 3131.9 5882.9 5939.0 5952.7 5963.9 6025.5 6036.6 6063.6 6070.5 6073.3 6090.5 5441.1 5488.5 5571.3 5597.2 5603.9 5481.0 5510.3 5533.4 5539.1 5581.9 5369.9 5379.1 5391.6 5408.2 5522.9 5351.6 5354.6 5357.6 5358.6 5373.7 5274.5 5309.8 5311.3 5319.9 5326.7 5682.9 5694.0 5705.5 5715.2 5742.5 6131.2 6179.8 6184.7 6195.3 6203.3 6270.5 6281.4 6282.7 6306.6 6309.4 5824.7 5853.6 5964.9 5980.1 6044.5 6566.3 6572.4 6628.5 6675.4 6696.1 6107.1 6159.4 6190.1 6298.0 6361.3 6268.4 6268.8 6271.7 6274.6 6279.7 5266.4 6193.9 6242.0 6251.1 6465.5 6388.8 6397.6 6458.7 6465.4 6468.5 5100.2 5150.5 5196.3 5243.2 5252.9 4388.3 4424.4 4427.2 4469.1 4480.7 5467.4 5476.9 5483.3 5486.4 5492.1 6255.2 6289.5 6431.3 6435.4 6493.6 5563.1 5571.9 5594.1 5620.3 5633.7 5607.1 5636.5 5695.2 5710.1 5712.8 6109.8 6166.6 6170.4 6171.7 6176.8 6230.7 6243.2 6251.3 6252.7 6275.0 6011.6 6101.2 6110.8 6114.0 6127.7 6125.3 6187.4 6189.6 6192.7 6195.1 5487.2 6278.5 6346.9 6417.8 6418.5 6174.9 6188.0 6279.7 6284.3 6290.1 6136.2 6190.2 6276.5 6277.3 6287.2 6014.4 6093.0 6099.1 6105.2 6111.9 6159.9 6175.5 6189.5 6193.8 6195.4 6015.5 6024.8 6025.5 6047.2 6048.6 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#1] ext.html Cycles:180 Average:36873.42 Median:18841.06 stddev:53111.21 (281.9%) stddev-sans-first:53191.01 06:05:09 INFO - PID 17322 | Values: 768.7 843.1 872.1 897.1 897.5 40509.0 41193.6 41413.8 41458.2 41798.0 38568.4 38613.6 38646.6 38750.4 38820.8 6750.6 6829.7 6917.6 6918.4 6933.7 6801.5 6900.1 6901.9 6904.4 6914.4 6859.9 6879.4 6886.8 6894.5 6904.3 6757.5 6811.0 6835.2 6857.3 6859.5 6240.6 6274.4 6311.2 6312.6 6326.6 33740.5 33889.5 33966.3 34023.3 34241.1 3386.5 3403.5 3441.0 3480.1 3588.6 31241.5 31610.4 31626.7 31667.7 31674.7 4752.8 4787.9 4836.2 4846.9 4899.6 186840.0 187002.0 190321.0 192426.0 192666.0 42286.8 44989.3 47198.8 47287.0 47545.5 48271.5 48589.0 48658.3 48750.8 48826.0 16043.9 16150.3 16246.2 16260.3 16366.6 13337.3 13372.6 13394.8 13395.7 13497.7 13918.5 14010.8 14042.3 14074.1 14265.7 5681.8 5736.2 5823.6 5900.8 5937.2 978.2 978.9 991.2 1030.3 1035.3 22414.7 22761.5 22815.8 22905.8 23101.2 1097.6 1103.2 1107.3 1125.7 1130.0 11769.4 11773.6 11985.0 12079.5 12164.1 230229.0 232740.0 233467.0 233971.0 235025.0 50434.7 50577.2 50911.0 51137.7 51446.5 1436.2 1460.9 1484.2 1493.6 1499.8 21339.6 21679.8 21721.5 22404.0 22762.7 36415.0 36464.6 36481.5 36574.5 36750.0 187613.0 187853.0 188635.1 188706.0 189508.0 33274.7 33714.0 34567.5 36493.0 36767.8 44081.1 44714.8 44950.3 45068.0 46036.5 32070.8 32639.0 32679.7 32731.0 33049.8 31744.6 32292.8 32697.5 32795.7 32895.3 35510.0 35949.1 36143.6 36176.8 36435.3 28645.9 30574.7 31000.8 31974.2 32107.5 23555.8 23928.8 24049.9 24091.8 24184.3 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#2] jquery.html Cycles:180 Average:33657.69 Median:20209.60 stddev:78311.00 (387.5%) stddev-sans-first:78491.26 06:05:09 INFO - PID 17322 | Values: 565.8 568.2 569.1 585.1 590.9 15910.8 21580.2 22188.3 22296.0 22515.7 18932.3 19254.8 19364.8 21177.7 22148.6 3847.4 3953.7 6569.8 6583.5 6590.9 6409.5 6572.2 6586.2 6598.5 6620.3 6528.4 6571.6 6573.2 6583.3 6588.9 6467.0 6548.1 6570.9 6578.8 6584.1 5327.8 5532.1 5839.4 5850.6 5856.9 27207.5 27735.4 27755.4 27761.4 27762.0 1842.1 1865.3 1872.7 1876.4 1876.8 17093.5 17463.0 17926.9 17961.1 17970.0 2269.3 2325.3 2361.6 2363.4 2365.2 118710.2 125443.6 125462.4 131919.0 146276.0 19215.4 20096.3 20322.9 20793.5 22207.7 41252.0 41352.0 41820.2 41976.0 42030.8 10641.0 10901.9 11030.3 11030.7 11094.3 8895.6 8912.4 9078.7 9087.1 9191.6 10660.5 10905.7 11377.4 11429.9 11452.4 4201.6 4208.9 4218.3 4228.9 4284.7 958.7 960.2 975.4 981.6 986.0 17925.6 18496.3 18788.3 18802.7 19262.8 1013.3 1033.7 1033.7 1042.8 1053.6 10309.9 10359.3 10502.7 10577.0 10644.9 448868.0 456238.0 460823.0 475136.0 491619.0 101628.0 101703.5 103704.0 105144.0 105704.0 1198.2 1219.9 1240.2 1257.5 1257.6 15985.6 16582.8 16801.0 16814.9 17220.6 52662.0 52979.2 54324.5 54346.0 54535.7 63996.7 66127.0 66133.0 66457.7 66713.3 19000.4 19186.0 19232.8 19321.7 19505.7 21426.4 21769.8 21912.7 22135.4 22218.7 17229.5 17401.7 17564.5 17646.0 17768.8 14051.0 15081.9 15260.2 16262.2 16448.4 17837.7 18004.1 19142.2 19315.4 19334.6 14023.6 14427.5 14432.5 14467.6 14478.3 13854.2 14611.0 17126.6 18409.4 18419.8 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#3] mootools.html Cycles:180 Average:8337.29 Median:2471.79 stddev:5597.57 (226.5%) stddev-sans-first:5588.31 06:05:09 INFO - PID 17322 | Values: 1303.2 1345.1 1364.8 1372.5 1380.3 13134.7 13797.2 13847.2 13851.1 13871.4 13320.5 13957.5 13977.9 13978.9 14029.7 2605.8 2666.1 2681.5 2686.5 2704.4 2472.5 2546.8 2558.9 2560.2 2562.6 2562.2 2579.2 2600.9 2610.6 2613.7 2438.4 2468.2 2471.1 2477.4 2490.5 2440.2 2443.6 2455.1 2458.3 2463.8 13150.0 13422.0 13451.3 13461.6 13465.5 7145.9 7414.9 7418.8 7447.3 7467.4 4978.2 5000.2 5070.1 5234.5 5244.8 1867.1 1882.0 1892.7 1942.6 1955.7 19081.6 19694.8 21425.8 21863.3 21867.2 5603.0 6284.2 6550.5 6586.1 6631.5 15314.8 15333.5 15396.2 15411.2 15462.8 7173.1 7381.2 7397.7 7415.4 7435.8 6732.3 6750.0 6808.1 6858.9 6866.9 4755.6 4917.8 4925.5 4961.5 4967.5 1421.1 1431.4 1443.8 1479.7 1485.4 892.0 895.9 911.0 924.6 937.3 7057.5 7113.1 7186.6 7223.1 7277.0 729.6 731.4 731.6 741.3 751.7 4596.7 4860.4 5188.8 5301.9 5390.8 17176.6 18175.2 18498.9 18534.7 18663.4 17944.4 18146.4 18695.5 18827.6 18917.7 9507.2 10499.2 10573.0 10598.5 10603.6 7373.7 7478.1 7760.9 7784.5 7821.3 15334.0 15883.0 16002.9 16253.6 16266.0 16007.3 16318.2 16666.8 16724.8 16886.4 10137.0 10220.5 11538.5 11556.2 11565.7 12705.6 12803.4 12893.3 12900.2 12903.4 9797.2 10135.0 10139.9 10250.8 10319.7 10044.3 10145.9 10184.6 10352.3 10510.8 8408.2 8443.0 8502.0 8503.1 8540.1 6643.1 6896.4 6969.0 7094.5 7124.8 6795.0 6832.9 7066.4 7080.3 7164.8 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#4] prototype.html Cycles:180 Average:5430.41 Median:5960.23 stddev:1519.90 (25.5%) stddev-sans-first:1477.98 06:05:09 INFO - PID 17322 | Values: 476.3 489.9 509.8 510.4 519.1 6042.4 6059.1 6159.3 6183.8 6232.6 5856.7 5922.8 5991.0 6071.2 6115.9 4904.6 4920.8 4934.7 4945.1 4988.1 4828.0 4889.9 4928.5 4958.4 4965.6 4855.7 4925.6 4951.2 4954.5 4967.9 4629.7 4799.2 4827.6 4828.4 4914.9 4297.1 4412.5 4419.0 4420.7 4443.6 5859.0 5900.7 5949.1 5971.3 5981.3 5569.2 5610.6 5639.8 5657.0 5667.5 6427.6 6437.0 6482.8 6532.2 6538.7 4807.2 4822.0 4840.4 4843.6 4849.8 6704.6 6718.8 6844.7 6872.0 6904.5 4939.6 5011.8 5023.2 5025.1 5027.3 5039.6 5056.8 5078.0 5087.7 5109.8 5523.4 5531.3 5550.6 5581.3 5636.2 6315.8 6347.4 6409.8 6464.6 6477.9 1751.3 1768.9 1771.3 1778.1 1781.6 1110.6 1229.4 1240.2 1248.1 1249.8 5498.3 5547.9 5607.8 5611.6 5714.3 6546.7 6563.7 6566.3 6627.0 6639.7 5556.3 5571.6 5588.8 5593.6 5649.0 3461.6 3506.4 3518.5 3525.4 3542.6 6401.3 6402.2 6442.3 6481.7 6492.7 6695.2 6829.8 6840.2 6849.8 6858.9 6402.4 6442.5 6475.0 6476.2 6515.8 6652.0 6682.8 6705.4 6712.6 6717.5 6485.9 6506.9 6617.5 6632.1 6640.5 6379.3 6422.9 6430.5 6457.6 6471.7 4925.8 4933.4 4947.4 4958.8 4972.8 6555.7 6561.5 6588.8 6617.5 6618.2 6387.2 6442.6 6476.4 6497.8 6518.6 6414.2 6418.3 6436.7 6443.5 6471.8 6400.3 6400.6 6425.4 6439.9 6451.5 5933.4 6457.4 6465.3 6479.8 6482.3 6178.8 6203.3 6204.5 6262.4 6295.2 06:05:09 INFO - PID 17322 | 06:05:09 INFO - PID 17322 | [#5] yui.html Cycles:180 Average:21493.39 Median:19030.43 stddev:29119.28 (153.0%) stddev-sans-first:29159.86 06:05:09 INFO - PID 17322 | Values: 887.4 909.8 915.1 920.0 937.8 15655.0 16236.8 17242.5 17576.1 17583.7 17657.3 19163.5 19250.5 19307.2 19459.0 1049.5 1075.6 1078.1 1078.2 1080.2 1053.5 1053.9 1059.2 1060.2 1061.3 1046.8 1096.6 1099.5 1123.1 1125.1 1080.2 1080.3 1082.9 1082.9 1083.9 792.3 797.8 798.8 798.9 799.6 15319.8 15455.1 15539.5 15552.2 15899.7 19219.1 19225.5 19361.7 19540.1 19869.2 15563.9 15633.1 15659.5 15698.2 15713.5 3414.5 3453.8 3489.0 3515.2 3541.0 106185.0 108282.5 110865.4 111211.4 112348.4 14491.3 14638.6 14773.3 14781.2 15079.1 25792.9 26582.6 27189.2 27291.0 27295.2 8477.2 8481.4 8499.1 8511.6 8512.7 3876.2 3983.5 3999.4 4000.9 4022.3 4693.4 4790.9 4818.1 4825.4 4828.3 887.2 926.8 927.2 946.4 948.9 638.2 705.4 711.2 722.9 732.1 11154.3 11585.0 12061.8 12246.3 12318.4 661.6 681.2 686.5 704.5 720.2 5408.3 5431.0 5509.1 5524.6 5571.8 103116.0 107045.5 107167.0 108197.0 108888.5 89746.6 91811.5 93563.5 94104.5 95102.5 77417.6 79856.0 81439.6 81828.0 82113.2 10454.9 10716.7 10910.6 10962.3 11190.2 35402.3 35417.5 35740.8 36369.5 37086.1 45782.0 46881.0 48795.5 49212.8 49868.8 14510.6 14775.5 15135.6 15139.9 15374.3 17146.0 17385.2 17554.3 17592.2 17813.2 14373.0 17686.3 18943.7 19001.5 19077.3 18538.0 18679.0 19059.3 19165.5 19380.2 17171.0 18000.7 18419.3 18862.7 19668.1 11594.5 12479.4 12920.3 13282.6 13851.2 12852.7 13063.3 14138.5 14173.2 14372.9 06:05:09 INFO - PID 17322 | -------- Summary: end -------- 06:05:09 INFO - PID 17322 | 06:05:10 INFO - TEST-INFO | 17322: exit 0 06:05:10 INFO - TEST-OK | dromaeo_css | took 1110298ms 06:05:10 INFO - TEST-START | kraken 06:05:10 INFO - Initialising browser for kraken test... 06:05:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54126/getInfo.html -profile /tmp/tmpMvfRb8/profile 06:05:10 INFO - TEST-INFO | started process 17722 (/builds/slave/test/build/application/firefox/firefox http://localhost:54126/getInfo.html) 06:05:16 INFO - TEST-INFO | 17722: exit 0 06:05:16 INFO - Browser initialized. 06:05:16 INFO - Running cycle 1/1 for kraken test... 06:05:16 INFO - TEST-INFO | started process 17930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMvfRb8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:27 INFO - PID 17930 | RSS: Main: 167014400 06:05:27 INFO - PID 17930 | 06:05:30 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54126/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:31 INFO - PID 17930 | RSS: Main: 173195264 06:05:31 INFO - PID 17930 | 06:05:33 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54126/tests/kraken/driver.html?testName=audio-dft) 06:05:34 INFO - PID 17930 | RSS: Main: 173891584 06:05:34 INFO - PID 17930 | 06:05:37 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54126/tests/kraken/driver.html?testName=audio-fft) 06:05:37 INFO - PID 17930 | RSS: Main: 168054784 06:05:37 INFO - PID 17930 | 06:05:39 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54126/tests/kraken/driver.html?testName=audio-oscillator) 06:05:40 INFO - PID 17930 | RSS: Main: 169054208 06:05:40 INFO - PID 17930 | 06:05:42 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54126/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:05:43 INFO - PID 17930 | RSS: Main: 169111552 06:05:43 INFO - PID 17930 | 06:05:46 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54126/tests/kraken/driver.html?testName=imaging-darkroom) 06:05:46 INFO - PID 17930 | RSS: Main: 172417024 06:05:46 INFO - PID 17930 | 06:05:50 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54126/tests/kraken/driver.html?testName=imaging-desaturate) 06:05:50 INFO - PID 17930 | RSS: Main: 173391872 06:05:50 INFO - PID 17930 | 06:05:53 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54126/tests/kraken/driver.html?testName=json-parse-financial) 06:05:54 INFO - PID 17930 | RSS: Main: 172367872 06:05:54 INFO - PID 17930 | 06:05:55 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54126/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:05:56 INFO - PID 17930 | RSS: Main: 172797952 06:05:56 INFO - PID 17930 | 06:05:58 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:05:58 INFO - PID 17930 | RSS: Main: 172752896 06:05:58 INFO - PID 17930 | 06:06:00 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:01 INFO - PID 17930 | RSS: Main: 172371968 06:06:01 INFO - PID 17930 | 06:06:04 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:04 INFO - PID 17930 | RSS: Main: 172896256 06:06:04 INFO - PID 17930 | 06:06:07 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:08 INFO - PID 17930 | RSS: Main: 172433408 06:06:08 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | Cycle 1(1): loaded http://localhost:54126/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54126/tests/kraken/driver.html?testName=ai-astar) 06:06:10 INFO - PID 17930 | RSS: Main: 173817856 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | __start_tp_report 06:06:10 INFO - PID 17930 | _x_x_mozilla_page_load 06:06:10 INFO - PID 17930 | _x_x_mozilla_page_load_details 06:06:10 INFO - PID 17930 | |i|pagename|runs| 06:06:10 INFO - PID 17930 | |0;ai-astar;99;108;108;107;111;109;108;110;108;110 06:06:10 INFO - PID 17930 | |1;audio-beat-detection;153;120;147;183;123;146;149;124;174;128 06:06:10 INFO - PID 17930 | |2;audio-dft;166;169;163;165;167;165;165;168;169;169 06:06:10 INFO - PID 17930 | |3;audio-fft;75;74;75;180;76;74;74;74;95;76 06:06:10 INFO - PID 17930 | |4;audio-oscillator;82;82;134;80;81;82;142;81;82;131 06:06:10 INFO - PID 17930 | |5;imaging-gaussian-blur;113;114;114;115;114;114;115;114;114;115 06:06:10 INFO - PID 17930 | |6;imaging-darkroom;150;150;150;152;150;151;152;154;150;149 06:06:10 INFO - PID 17930 | |7;imaging-desaturate;94;94;95;94;95;95;93;95;94;94 06:06:10 INFO - PID 17930 | |8;json-parse-financial;54;56;54;57;58;55;55;55;54;55 06:06:10 INFO - PID 17930 | |9;json-stringify-tinderbox;55;55;57;55;55;57;55;55;55;55 06:06:10 INFO - PID 17930 | |10;stanford-crypto-aes;78;78;78;79;77;84;78;80;76;76 06:06:10 INFO - PID 17930 | |11;stanford-crypto-ccm;129;136;134;126;126;127;126;127;127;159 06:06:10 INFO - PID 17930 | |12;stanford-crypto-pbkdf2;186;198;188;181;181;185;183;181;186;189 06:06:10 INFO - PID 17930 | |13;stanford-crypto-sha256-iterative;68;68;71;71;68;69;67;68;68;70 06:06:10 INFO - PID 17930 | __end_tp_report 06:06:10 INFO - PID 17930 | __start_cc_report 06:06:10 INFO - PID 17930 | _x_x_mozilla_cycle_collect,943 06:06:10 INFO - PID 17930 | __end_cc_report 06:06:10 INFO - PID 17930 | __startTimestamp1500296770594__endTimestamp 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | ------- Summary: start ------- 06:06:10 INFO - PID 17930 | Number of tests: 14 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#0] ai-astar Cycles:10 Average:107.80 Median:109.50 stddev:3.33 (3.0%) stddev-sans-first:1.30 06:06:10 INFO - PID 17930 | Values: 99.0 108.0 108.0 107.0 111.0 109.0 108.0 110.0 108.0 110.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:148.00 stddev:21.62 (14.6%) stddev-sans-first:22.73 06:06:10 INFO - PID 17930 | Values: 153.0 120.0 147.0 183.0 123.0 146.0 149.0 124.0 174.0 128.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#2] audio-dft Cycles:10 Average:166.60 Median:167.50 stddev:2.12 (1.3%) stddev-sans-first:2.24 06:06:10 INFO - PID 17930 | Values: 166.0 169.0 163.0 165.0 167.0 165.0 165.0 168.0 169.0 169.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.00 stddev:33.20 (44.3%) stddev-sans-first:34.91 06:06:10 INFO - PID 17930 | Values: 75.0 74.0 75.0 180.0 76.0 74.0 74.0 74.0 95.0 76.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:81.50 stddev:26.34 (32.3%) stddev-sans-first:27.32 06:06:10 INFO - PID 17930 | Values: 82.0 82.0 134.0 80.0 81.0 82.0 142.0 81.0 82.0 131.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.50 06:06:10 INFO - PID 17930 | Values: 113.0 114.0 114.0 115.0 114.0 114.0 115.0 114.0 114.0 115.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.48 (1.0%) stddev-sans-first:1.54 06:06:10 INFO - PID 17930 | Values: 150.0 150.0 150.0 152.0 150.0 151.0 152.0 154.0 150.0 149.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:06:10 INFO - PID 17930 | Values: 94.0 94.0 95.0 94.0 95.0 95.0 93.0 95.0 94.0 94.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.34 (2.4%) stddev-sans-first:1.33 06:06:10 INFO - PID 17930 | Values: 54.0 56.0 54.0 57.0 58.0 55.0 55.0 55.0 54.0 55.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:0.84 (1.5%) stddev-sans-first:0.88 06:06:10 INFO - PID 17930 | Values: 55.0 55.0 57.0 55.0 55.0 57.0 55.0 55.0 55.0 55.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:2.32 (3.0%) stddev-sans-first:2.46 06:06:10 INFO - PID 17930 | Values: 78.0 78.0 78.0 79.0 77.0 84.0 78.0 80.0 76.0 76.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:128.00 stddev:10.22 (8.0%) stddev-sans-first:10.79 06:06:10 INFO - PID 17930 | Values: 129.0 136.0 134.0 126.0 126.0 127.0 126.0 127.0 127.0 159.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.80 Median:186.00 stddev:5.18 (2.8%) stddev-sans-first:5.49 06:06:10 INFO - PID 17930 | Values: 186.0 198.0 188.0 181.0 181.0 185.0 183.0 181.0 186.0 189.0 06:06:10 INFO - PID 17930 | 06:06:10 INFO - PID 17930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.40 (2.0%) stddev-sans-first:1.45 06:06:10 INFO - PID 17930 | Values: 68.0 68.0 71.0 71.0 68.0 69.0 67.0 68.0 68.0 70.0 06:06:10 INFO - PID 17930 | -------- Summary: end -------- 06:06:10 INFO - PID 17930 | 06:06:11 INFO - PID 17930 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:06:11 INFO - TEST-INFO | 17930: exit 0 06:06:11 INFO - TEST-OK | kraken | took 61172ms 06:06:11 INFO - SUITE-END | took 1171s 06:06:11 INFO - Completed test suite (00:19:31) 06:06:11 INFO - javascript benchmark 06:06:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8201.71898886463, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3029.757619390449, 3085.0898984799483, 3098.6281646202456, 3111.0511294055304, 3131.8590663420146, 5882.85292867678, 5938.970305148479, 5952.6726030068385, 5963.926493231216, 6025.548083893704, 6036.607620504675, 6063.605865618742, 6070.514358851292, 6073.271207455112, 6090.451859332659, 5441.075017247058, 5488.451154884509, 5571.303587051619, 5597.216389705444, 5603.859903502404, 5480.972595137018, 5510.283663123809, 5533.391326954032, 5539.141433077859, 5581.916271255935, 5369.919451208235, 5379.139337705968, 5391.622586418952, 5408.215808707735, 5522.889542209154, 5351.571874250089, 5354.554270346985, 5357.571394288487, 5358.571314294847, 5373.650712703662, 5274.525292723673, 5309.787608495655, 5311.309529761106, 5319.946800532022, 5326.7070311132875, 5682.914756278659, 5694.0, 5705.486506214461, 5715.1713001614535, 5742.454466825645, 6131.202943617346, 6179.81460556184, 6184.6907654617535, 6195.287541932646, 6203.2866220384785, 6270.46701030413, 6281.403266689657, 6282.748690052393, 6306.590071645374, 6309.432151106376, 5824.737886795105, 5853.64878107315, 5964.910526342108, 5980.102984552352, 6044.455998960071, 6566.343365663491, 6572.441342485942, 6628.536002479828, 6675.365840245169, 6696.129503164655, 6107.083937409336, 6159.353267906805, 6190.102435146969, 6297.992321228673, 6361.332060133619, 6268.435840774352, 6268.843278917972, 6271.717772700239, 6274.623522588659, 6279.717412716439, 5266.4470230626, 6193.876122477525, 6242.0, 6251.062340648939, 6465.515086368541, 6388.840278993062, 6397.648129352837, 6458.6770661466735, 6465.353464653591, 6468.482521398277, 5100.209467532539, 5150.48495150482, 5196.298499702491, 5243.213517972258, 5252.868678283074, 4388.2759344707765, 4424.446944131983, 4427.158839820424, 4469.08383781324, 4480.708753930984, 5467.371252306036, 5476.863078423071, 5483.341998960151, 5486.423925487767, 5492.1212605982855, 6255.218097737783, 6289.465395441347, 6431.292557818636, 6435.388638079375, 6493.642849643221, 5563.13771365439, 5571.9442805572235, 5594.132909398968, 5620.297462817148, 5633.690147041952, 5607.074832652648, 5636.464535869086, 5695.231143795618, 5710.143478478261, 5712.828615141552, 6109.84725381869, 6166.630002199882, 6170.413810687977, 6171.660558669317, 6176.845578860474, 6230.719617617127, 6243.188385509855, 6251.312355640966, 6252.718627661675, 6274.968625156845, 6011.579189456871, 6101.206843110367, 6110.847228819315, 6114.021756518936, 6127.6936153193055, 6125.326214116354, 6187.3503282154725, 6189.628622282497, 6192.690365481618, 6195.070739388947, 5487.204355368529, 6278.529110316653, 6346.936530634819, 6417.839554011187, 6418.518611104092, 6174.9073763892675, 6188.0, 6279.686015699105, 6284.3087260402235, 6290.0879372491645, 6136.171616831671, 6190.1952746142715, 6276.529260305404, 6277.278113016879, 6287.245530536365, 6014.368491308524, 6093.0, 6099.054646529795, 6105.175801266772, 6111.938880611137, 6159.876802464015, 6175.475084617858, 6189.535784816247, 6193.81418557444, 6195.4424101831055, 6015.488683461955, 6024.849378765566, 6025.548083893638, 6047.153398524298, 6048.637081775108], "value": 5783.861294591423, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.7002069193015, 843.1231519220004, 872.0581771686577, 897.1163404047013, 897.5243121145795, 40509.0, 41193.58806411935, 41413.7929310353, 41458.17083658329, 41798.0, 38568.421473677845, 38613.613863861356, 38646.613533864656, 38750.418743718794, 38820.80589597055, 6750.594964302145, 6829.726810927557, 6917.550359226634, 6918.377346038856, 6933.72265109395, 6801.4558835293055, 6900.137482814648, 6901.861962760741, 6904.378605925465, 6914.412274956635, 6859.897101543481, 6879.380855722984, 6886.75896343628, 6894.517383783137, 6904.344087311697, 6757.459403247728, 6811.046453496514, 6835.213950395719, 6857.348551887562, 6859.519833611649, 6240.625562466266, 6274.435300822948, 6311.2426508819235, 6312.621242725451, 6326.588771729869, 33740.49389259163, 33889.491657625156, 33966.32067358639, 34023.31953360919, 34241.14397140066, 3386.508956201337, 3403.5405220295193, 3440.9827950860085, 3480.095175254427, 3588.5693716753894, 31241.53137702936, 31610.367792644247, 31626.683733162605, 31667.683323166704, 31674.683253167404, 4752.809887604491, 4787.8563643090765, 4836.22620380741, 4846.878828029292, 4899.583535399495, 186840.0, 187002.0, 190321.0, 192426.0, 192666.0, 42286.788566056974, 44989.32516012262, 47198.82002949885, 47287.0, 47545.5245447548, 48271.5172848267, 48589.0, 48658.27012594814, 48750.75624621925, 48826.0, 16043.919780401024, 16150.273237704096, 16246.187690615421, 16260.349586016428, 16366.590835229215, 13337.333133343294, 13372.598822035354, 13394.799078013837, 13395.732085358239, 13497.66255843592, 13918.512852050331, 14010.789838152436, 14042.297885105909, 14074.085184462978, 14265.714685706227, 5681.801136960186, 5736.196932429463, 5823.621464604787, 5900.7608402235155, 5937.198478205387, 978.1929907826072, 978.8727465429448, 991.1575161113141, 1030.30454443252, 1035.2804800663466, 22414.663780043313, 22761.544769104526, 22815.771842281698, 22905.770942290696, 23101.19145829888, 1097.6268068856627, 1103.2167161315556, 1107.3355986408092, 1125.7354521687396, 1129.9943500282445, 11769.411529423494, 11773.646790596296, 11985.041196704242, 12079.456424460921, 12164.08769342303, 230229.0, 232740.0, 233467.0, 233971.0, 235025.0, 50434.74782626063, 50577.24134137991, 50911.0, 51137.744311278206, 51446.485535144915, 1436.1598464898152, 1460.9269536523343, 1484.2356186563927, 1493.6041948883556, 1499.7900293958855, 21339.573208536054, 21679.791580318626, 21721.456963576038, 22404.0, 22762.65856012194, 36415.0, 36464.635353646125, 36481.452778207815, 36574.4513832298, 36750.0, 187613.0, 187853.0, 188635.0568247205, 188706.0, 189508.0, 33274.667253327156, 33714.0, 34567.481487778205, 36493.0, 36767.81616091902, 44081.11837763291, 44714.776426118966, 44950.325745113194, 45068.0, 46036.53963460323, 32070.83964580162, 32639.0, 32679.673203267663, 32731.018069457954, 33049.83475082609, 31744.60700715069, 32292.838535807172, 32697.509537356484, 32795.672043279264, 32895.342093158484, 35510.0, 35949.1012724684, 36143.63856361508, 36176.819115904254, 36435.27129457343, 28645.856770716015, 30574.694253057183, 31000.844995774878, 31974.200644984063, 32107.518387224678, 23555.76444235604, 23928.760712392654, 24049.879750601136, 24091.759082408953, 24184.274471765875], "value": 16644.442570605177, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7765182752815, 568.1960026562415, 569.106502790619, 585.1106318396037, 590.9202257695212, 15910.84089159108, 21580.244691435782, 22188.334349969507, 22296.0, 22515.662265066017, 18932.337368192115, 19254.807451925477, 19364.806351936477, 21177.68233476499, 22148.557028859454, 3847.442120892476, 3953.6639385652256, 6569.7700580479695, 6583.506237032242, 6590.901136482957, 6409.519286053542, 6572.244191917919, 6586.209654841402, 6598.505112116586, 6620.337966203389, 6528.445082168021, 6571.572847764904, 6573.211214654224, 6583.275839657657, 6588.934110658904, 6467.0, 6548.05053267276, 6570.8685826283445, 6578.80263592093, 6584.078229047937, 5327.813526526592, 5532.1425179097305, 5839.357670656267, 5850.590458667895, 5856.882862342772, 27207.45585088307, 27735.445291094267, 27755.444891102066, 27761.444771104463, 27762.0, 1842.0973722875829, 1865.3005123078844, 1872.7097299918535, 1876.4276895546852, 1876.8498520118358, 17093.487195384158, 17463.0, 17926.91036544822, 17961.10194490283, 17970.0, 2269.2851751698163, 2325.3140323604575, 2361.6221404575185, 2363.409147713072, 2365.1840115160244, 118710.21934670987, 125443.60947366798, 125462.3726881369, 131919.0, 146276.0, 19215.423537293904, 20096.296629617893, 20322.89838550798, 20793.480162996046, 22207.66688499674, 41252.0, 41352.0, 41820.16359672789, 41976.0, 42030.789846050575, 10641.04230619248, 10901.945490272497, 11030.28303160292, 11030.669079927615, 11094.261313752018, 8895.644174233088, 8912.376133670581, 9078.682246121354, 9087.136722011399, 9191.586378612978, 10660.507528945955, 10905.709800941891, 11377.431128443544, 11429.942850285695, 11452.427378631035, 4201.579842015774, 4208.905684522047, 4218.282891908383, 4228.894277643083, 4284.657227421799, 958.712386284112, 960.2222200017868, 975.4488713876636, 981.5926390547843, 985.9950700246453, 17925.56089222958, 18496.260149593865, 18788.342408015655, 18802.717959230624, 19262.80737192638, 1013.2501948558162, 1033.6692258477215, 1033.6743925663393, 1042.8279333909973, 1053.6259627832162, 10309.94845025785, 10359.274850760374, 10502.737431564272, 10577.0, 10644.89355106439, 448868.0, 456238.0, 460823.0, 475136.0, 491619.0, 101628.0, 101703.49148254211, 103703.96296037093, 105144.0, 105704.0, 1198.2211562484456, 1219.9329036903055, 1240.2186622427812, 1257.4718618180386, 1257.6227131860587, 15985.600359991093, 16582.756293277813, 16801.0, 16814.915925420293, 17220.569485762455, 52662.0, 52979.20531192112, 54324.45675543352, 54346.0, 54535.72732136473, 63996.68001659962, 66127.0, 66133.008004879, 66457.66771166114, 66713.33286667266, 19000.429987100408, 19186.0, 19232.807671923103, 19321.710174347114, 19505.70741438851, 21426.357209283746, 21769.782302176776, 21912.671309930683, 22135.44661383478, 22218.666719999535, 17229.483115506555, 17401.738973915653, 17564.473065807535, 17646.0, 17768.822311777232, 14051.0, 15081.924590376977, 15260.23698815077, 16262.186890655657, 16448.424305149263, 17837.73243401324, 18004.099795010457, 19142.234310627977, 19315.4205373839, 19334.61330773405, 14023.579292621238, 14427.49503767363, 14432.494862679756, 14467.638309042359, 14478.348474318891, 13854.238016909167, 14611.0, 17126.571835704206, 18409.355672551395, 18419.81580184181], "value": 12053.788445645047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.1594621469153, 1345.0853419674625, 1364.8362196536418, 1372.5401990333237, 1380.2546624822596, 13134.671633209175, 13797.24115173665, 13847.238401887893, 13851.09967852089, 13871.375788089535, 13320.533781317656, 13957.511487097954, 13977.860221397783, 13978.860211397883, 14029.719405611882, 2605.8175927685024, 2666.0668765931864, 2681.5307321218806, 2686.5164270431414, 2704.445588654331, 2472.468419289852, 2546.8471891686468, 2558.8976440942433, 2560.2063360358256, 2562.5643640581147, 2562.2185233503774, 2579.21333993132, 2600.8829602667925, 2610.6345111684377, 2613.7255588163252, 2438.3904023994, 2468.160825319391, 2471.1104002559064, 2477.4301910560494, 2490.452100537879, 2440.1703420836825, 2443.621238708003, 2455.0670745116918, 2458.31167273162, 2463.8275320727557, 13150.0, 13421.993350498751, 13451.32743362828, 13461.596152115451, 13465.461381544726, 7145.857082858366, 7414.925850741478, 7418.777436676908, 7447.292507211806, 7467.402607791364, 4978.2034874419915, 5000.2499625056535, 5070.138076527, 5234.476552344773, 5244.842654720364, 1867.1037901807074, 1881.990590047041, 1892.706630472279, 1942.5532127610588, 1955.6773132433132, 19081.61836763271, 19694.80305196944, 21425.785742142692, 21863.344099677037, 21867.234646787445, 5602.971985140048, 6284.151639528605, 6550.528220043385, 6586.110875031809, 6631.469482441393, 15314.846851531565, 15333.539993800205, 15396.153211573472, 15411.152386618844, 15462.768058479132, 7173.10336207974, 7381.224971378036, 7397.704091836374, 7415.40676745859, 7435.8141046474275, 6732.3267673232285, 6749.966250168718, 6808.08090907731, 6858.931410685829, 6866.896996545056, 4755.595774359149, 4917.803287868517, 4925.532074452921, 4961.479044700327, 4967.4784147664695, 1421.076300404745, 1431.355889849551, 1443.8050863133553, 1479.659678274003, 1485.4058376649211, 891.9643214271357, 895.8611415230649, 910.9544522773834, 924.6162842420455, 937.2642475656577, 7057.541259818096, 7113.146422429341, 7186.568805871664, 7223.097112860893, 7276.96361518189, 729.6278897762179, 731.4148681055241, 731.6012773038707, 741.3328004795727, 751.7444069016451, 4596.724196548218, 4860.36815214027, 5188.792448302026, 5301.946980530145, 5390.838274851761, 17176.570585735208, 18175.182116804775, 18498.907505462656, 18534.721979170325, 18663.44009679712, 17944.37194698179, 18146.3648772295, 18695.532611684815, 18827.623447530972, 18917.7162342565, 9507.239420846316, 10499.160067194605, 10573.0, 10598.523066462181, 10603.628872989408, 7373.741919032808, 7478.1400138982535, 7760.883586746316, 7784.494007889469, 7821.335186509211, 15334.0, 15883.047017179006, 16002.919985399998, 16253.59366015859, 16266.0, 16007.279672414536, 16318.18409079565, 16666.833331666527, 16724.832751672813, 16886.40897568579, 10137.0, 10220.540075696761, 11538.538458461904, 11556.248843825124, 11565.710857228636, 12705.555305564261, 12803.359832008176, 12893.290869002294, 12900.225986440844, 12903.419346129635, 9797.21622270231, 10135.0, 10139.949300253451, 10250.846237306298, 10319.742006449598, 10044.296899216984, 10145.898541014496, 10184.643537476153, 10352.327098738559, 10510.78978420412, 8408.2432581068, 8442.957785211034, 8501.95749021251, 8503.107173746668, 8540.10328915455, 6643.136392268974, 6896.413804826445, 6969.02433659278, 7094.503384763017, 7124.750633727795, 6794.966025169842, 6832.93167068323, 7066.434685225273, 7080.2919708028785, 7164.820879478055], "value": 6109.394221403416, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.3045952908753, 489.94610592834783, 509.7629602234961, 510.41557416757814, 519.0682724509505, 6042.425969532893, 6059.121427393031, 6159.260888693358, 6183.75264989401, 6232.59488133271, 5856.736446859891, 5922.792702255411, 5991.0, 6071.180390647272, 6115.908261376083, 4904.583110435599, 4920.8277710280145, 4934.703917764928, 4945.134601444751, 4988.127077761395, 4827.951720482803, 4889.926651100236, 4928.457869634337, 4958.355413796201, 4965.627577931651, 4855.660103792736, 4925.581325587329, 4951.23255895335, 4954.529319714621, 4967.850964471072, 4629.6990695604845, 4799.208130658437, 4827.551734479677, 4828.396450443659, 4914.852554423355, 4297.119090586422, 4412.470503539564, 4419.0, 4420.690551661385, 4443.644508439317, 5858.98262394867, 5900.704964751745, 5949.107633854913, 5971.343152253248, 5981.252343457068, 5569.164625306196, 5610.6336198281115, 5639.774409023634, 5656.953463609246, 5667.4615911488345, 6427.614343139427, 6437.034444833265, 6482.773102941374, 6532.150820393366, 6538.738450461976, 4807.158747219222, 4821.951780482221, 4840.419149702023, 4843.58829499493, 4849.806007759686, 6704.564203326817, 6718.83202919926, 6844.657767111675, 6871.9656401717675, 6904.4821638377325, 4939.604831613462, 5011.824586139468, 5023.1711767557945, 5025.095482813129, 5027.271045698426, 5039.622028347889, 5056.772445239973, 5077.974610126926, 5087.745612719349, 5109.846704598868, 5523.364813046551, 5531.3362396511875, 5550.583706221969, 5581.330240371181, 5636.154576813429, 6315.778947736807, 6347.39699728525, 6409.775657852046, 6464.612123272619, 6477.935220647733, 1751.3169863753146, 1768.8761786674809, 1771.3446024970842, 1778.0665150795935, 1781.5724226185882, 1110.6445937300148, 1229.3668760588305, 1240.2248594628356, 1248.1076030638137, 1249.7562975219744, 5498.285222920995, 5547.8890422192135, 5607.80372686954, 5611.597100724819, 5714.314282286069, 6546.70539825709, 6563.733573177473, 6566.277709451956, 6627.0, 6639.734410623521, 5556.333240011144, 5571.60998730085, 5588.776448941997, 5593.580481463825, 5648.971755141198, 3461.567304086989, 3506.386382383124, 3518.4546395308766, 3525.3654342218133, 3542.6457354264367, 6401.295857455676, 6402.231732192166, 6442.2591401989375, 6481.740730370827, 6492.707828147744, 6695.196576410862, 6829.829254268584, 6840.179178498612, 6849.760258390932, 6858.862822743617, 6402.423781859655, 6442.516811239082, 6475.0, 6476.158099447231, 6515.837104072436, 6651.966740166268, 6682.797096522672, 6705.396514313735, 6712.563683360566, 6717.462602991651, 6485.902711459237, 6506.869862602816, 6617.536772426077, 6632.104665870046, 6640.468762498892, 6379.266384365857, 6422.871542569029, 6430.549861509649, 6457.580257283262, 6471.741130354922, 4925.753712314298, 4933.358663373882, 4947.406311242674, 4958.826441074545, 4972.7762250699525, 6555.737770489318, 6561.540692151694, 6588.8023359299295, 6617.5110600114585, 6618.172728408949, 6387.233531976192, 6442.581232219891, 6476.449501792212, 6497.837554061186, 6518.576292541159, 6414.198225221848, 6418.293987661447, 6436.650622522652, 6443.452306553995, 6471.7734879279, 6400.263969643551, 6400.615963042046, 6425.389587989133, 6439.903401449075, 6451.516136289703, 5933.406659334032, 6457.354264573693, 6465.321141280097, 6479.838004049748, 6482.319356467503, 6178.845528861814, 6203.325102222465, 6204.5036397089025, 6262.373762623702, 6295.150154729236], "value": 4984.335788966024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [887.3566664168475, 909.8134882349119, 915.066632035324, 919.9632014719411, 937.7983733497297, 15655.0, 16236.756448653265, 17242.48272551824, 17576.121193940315, 17583.73624395632, 17657.293708251655, 19163.520911977208, 19250.51873703158, 19307.227710891548, 19459.0, 1049.511976930727, 1075.623531763884, 1078.1213311151425, 1078.2398409121552, 1080.200651517879, 1053.531178625512, 1053.8682664666917, 1059.221472217923, 1060.1571750458365, 1061.3207547169818, 1046.7540128069897, 1096.5942601237552, 1099.5052226498067, 1123.1183520936067, 1125.0774365020645, 1080.173667144635, 1080.3032044331442, 1082.86464191976, 1082.9025387715103, 1083.8590983172217, 792.3225642076058, 797.784598158494, 798.8202654402771, 798.872180451125, 799.5602418669708, 15319.770203446957, 15455.149966751824, 15539.5338139856, 15552.222388880511, 15899.682006359924, 19219.135138918784, 19225.51936201606, 19361.709574356395, 19540.120694568777, 19869.20523179071, 15563.922180389025, 15633.140177290245, 15659.530214093595, 15698.215089245607, 15713.528594142193, 3414.5048967899515, 3453.8100404477746, 3488.9651103488895, 3515.1739341254784, 3541.0, 106185.0, 108282.45858770734, 110865.44567277192, 111211.44394277976, 112348.438257809, 14491.275436228147, 14638.560843174722, 14773.33519991603, 14781.187034713193, 15079.095254284777, 25792.8710356447, 26582.6012609811, 27189.184324470298, 27291.0, 27295.181144565693, 8477.152284771473, 8481.363897707697, 8499.065102838682, 8511.616977236039, 8512.65949362031, 3876.2441323942126, 3983.50206224222, 3999.420084087791, 4000.879973600797, 4022.316206244887, 4693.413323334583, 4790.904181916342, 4818.060478206716, 4825.372701548777, 4828.251620998751, 887.1926546842343, 926.754410081329, 927.1794461901266, 946.3848498476045, 948.8576713492894, 638.1958731997717, 705.3933617089299, 711.210556282526, 722.8554289142193, 732.0702707561474, 11154.330740155454, 11585.0, 12061.758764824654, 12246.326452045223, 12318.445669944695, 661.5567569728294, 681.2063945503432, 686.498855835243, 704.5279662626053, 720.1789959446236, 5408.296921400193, 5431.0, 5509.146082357241, 5524.640898341595, 5571.832845014656, 103116.0, 107045.4647726772, 107167.0, 108197.0, 108888.45555772171, 89746.55126724455, 91811.54094229486, 93563.53218233865, 94104.52947735354, 95102.52448737712, 77417.61291193508, 79856.0, 81439.59280203443, 81828.0, 82113.17886821175, 10454.947725261629, 10716.732081697708, 10910.563577457131, 10962.287451315638, 11190.160737944849, 35402.29195416129, 35417.468737969466, 35740.82129589335, 36369.45445818262, 37086.072848179014, 45782.0, 46881.0, 48795.51204488052, 49212.75393623009, 49868.750656246484, 14510.564683059525, 14775.482858099915, 15135.621609459851, 15139.924300378869, 15374.308156133224, 17146.0, 17385.217665204844, 17554.297828086732, 17592.208350623998, 17813.1984060715, 14373.0, 17686.292548297923, 18943.71584426207, 19001.524961876064, 19077.332293369665, 18538.0, 18679.0, 19059.332923347618, 19165.520861978563, 19380.224791008764, 17171.0, 18000.729989049913, 18419.26322947067, 18862.717059244398, 19668.114934828252, 11594.47824847867, 12479.438425271066, 12920.289384083966, 13282.601521954357, 13851.16892986424, 12852.742945141232, 13063.281519516519, 14138.50515231962, 14173.22047287409, 14372.85627143757], "value": 8613.60692053929, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 108.0, 107.0, 111.0, 109.0, 108.0, 110.0, 108.0, 110.0], "value": 107.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 147.0, 183.0, 123.0, 146.0, 149.0, 124.0, 174.0, 128.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 169.0, 163.0, 165.0, 167.0, 165.0, 165.0, 168.0, 169.0, 169.0], "value": 166.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 180.0, 76.0, 74.0, 74.0, 74.0, 95.0, 76.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 134.0, 80.0, 81.0, 82.0, 142.0, 81.0, 82.0, 131.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 152.0, 150.0, 151.0, 152.0, 154.0, 150.0, 149.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 93.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 57.0, 58.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 55.0, 57.0, 55.0, 55.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 77.0, 84.0, 78.0, 80.0, 76.0, 76.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 136.0, 134.0, 126.0, 126.0, 127.0, 126.0, 127.0, 127.0, 159.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 198.0, 188.0, 181.0, 181.0, 185.0, 183.0, 181.0, 186.0, 189.0], "value": 185.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 71.0, 71.0, 68.0, 69.0, 67.0, 68.0, 68.0, 70.0], "value": 68.8, "unit": "score"}]}]} 06:06:11 INFO - Return code: 0 06:06:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:11 INFO - # TBPL SUCCESS # 06:06:11 INFO - Running post-action listener: _package_coverage_data 06:06:11 INFO - Running post-action listener: _resource_record_post_action 06:06:11 INFO - [mozharness: 2017-07-17 13:06:11.865008Z] Finished run-tests step (success) 06:06:11 INFO - Running post-run listener: _resource_record_post_run 06:06:11 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 8192; Write bytes: 436785152; Read time: 172; Write time: 280512 06:06:11 INFO - TinderboxPrint: CPU usage
13.1% 06:06:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 06:06:11 INFO - TinderboxPrint: I/O write bytes / time
436,785,152 / 280,512 06:06:11 INFO - TinderboxPrint: CPU idle
8,248.0 (86.9%) 06:06:11 INFO - TinderboxPrint: CPU user
1,195.1 (12.6%) 06:06:11 INFO - TinderboxPrint: Swap in / out
0 / 0 06:06:11 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107257856; Read time: 0; Write time: 84664 06:06:11 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:06:11 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 4096; Write bytes: 329527296; Read time: 164; Write time: 195848 06:06:12 INFO - Running post-run listener: _upload_blobber_files 06:06:12 INFO - Blob upload gear active. 06:06:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:12 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 06:06:12 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:06:12 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:06:12 INFO - Traceback (most recent call last): 06:06:12 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 06:06:12 INFO - main() 06:06:12 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 06:06:12 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 06:06:12 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 06:06:12 INFO - return set(response.json().get('whitelist', [])) 06:06:12 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 06:06:12 INFO - return json.loads(self.text or self.content, **kwargs) 06:06:12 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 06:06:12 INFO - return _default_decoder.decode(s) 06:06:12 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 06:06:12 INFO - obj, end = self.raw_decode(s) 06:06:12 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 06:06:12 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 06:06:12 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 06:06:12 ERROR - Return code: 1 06:06:12 INFO - Setting buildbot property blobber_files to {} 06:06:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:12 INFO - Contents: 06:06:12 INFO - blobber_files:{} 06:06:12 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:12 INFO - Copying logs to upload dir... 06:06:12 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.912134 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-07-17 06:06:12.739143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:06:12.742986) ========= 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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/EmfxPxPpS3uapCru3yn1cQ/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:06:12.795100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:06:12.795498) ========= 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=523ca41ca1e0623de333ad52000001bf-1500294212.271841-480867325 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004406 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:06:12.847466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:06:12.847845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:06:12.848155) ========= ========= Total master_lag: 0.15 =========