builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1490813363.97 results: success (0) revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:23.969301) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:23.969863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:23.970148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:23.985961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:23.986386) ========= 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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 11:49:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-03-29 11:49:24 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111154 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.111892) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.112246) ========= 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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018943 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.162374) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.162749) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4c7c05a49f3ce40aa0969beccb397380a8907f4a --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 4c7c05a49f3ce40aa0969beccb397380a8907f4a --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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 11:49:24,350 truncating revision to first 12 chars 2017-03-29 11:49:24,350 Setting DEBUG logging. 2017-03-29 11:49:24,350 attempt 1/10 2017-03-29 11:49:24,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4c7c05a49f3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 11:49:24,672 unpacking tar archive at: mozilla-central-4c7c05a49f3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703996 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.881564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.882088) ========= script_repo_revision: 4c7c05a49f3ce40aa0969beccb397380a8907f4a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.882735) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.883182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 11:49:24.895906) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-29 11:49:24.896490) ========= /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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:25 INFO - MultiFileLogger online at 20170329 11:49:25 in /builds/slave/test 11:49:25 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 11:49:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:25 INFO - {'append_to_log': False, 11:49:25 INFO - 'base_work_dir': '/builds/slave/test', 11:49:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:49:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:25 INFO - 'branch': 'Firefox-Non-PGO', 11:49:25 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:25 INFO - 'config_files': ('talos/linux_config.py',), 11:49:25 INFO - 'default_actions': ('clobber', 11:49:25 INFO - 'read-buildbot-config', 11:49:25 INFO - 'download-and-extract', 11:49:25 INFO - 'populate-webroot', 11:49:25 INFO - 'create-virtualenv', 11:49:25 INFO - 'install', 11:49:25 INFO - 'run-tests'), 11:49:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:25 INFO - 'download_minidump_stackwalk': True, 11:49:25 INFO - 'download_symbols': 'ondemand', 11:49:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:25 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:25 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:25 INFO - 'gecko_profile': False, 11:49:25 INFO - 'gecko_profile_interval': 0, 11:49:25 INFO - 'installer_path': 'installer.exe', 11:49:25 INFO - 'log_level': 'info', 11:49:25 INFO - 'log_name': 'talos', 11:49:25 INFO - 'log_to_console': True, 11:49:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:25 INFO - 'opt_config_files': (), 11:49:25 INFO - 'pip_index': False, 11:49:25 INFO - 'suite': 'dromaeojs-e10s', 11:49:25 INFO - 'system_bits': '32', 11:49:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:25 INFO - 'title': 'talos-linux64-ix-023', 11:49:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:25 INFO - 'use_talos_json': True, 11:49:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:25 INFO - 'work_dir': 'build'} 11:49:25 INFO - [mozharness: 2017-03-29 18:49:25.177793Z] Running clobber step. 11:49:25 INFO - Running pre-action listener: _resource_record_pre_action 11:49:25 INFO - Running main action method: clobber 11:49:25 INFO - rmtree: /builds/slave/test/build 11:49:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:26 INFO - Running post-action listener: _resource_record_post_action 11:49:26 INFO - [mozharness: 2017-03-29 18:49:26.213546Z] Finished clobber step (success) 11:49:26 INFO - [mozharness: 2017-03-29 18:49:26.213646Z] Running read-buildbot-config step. 11:49:26 INFO - Running pre-action listener: _resource_record_pre_action 11:49:26 INFO - Running main action method: read_buildbot_config 11:49:26 INFO - Using buildbot properties: 11:49:26 INFO - { 11:49:26 INFO - "project": "", 11:49:26 INFO - "product": "firefox", 11:49:26 INFO - "who": "kwierso@gmail.com", 11:49:26 INFO - "installer_path": "public/build/target.tar.bz2", 11:49:26 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:49:26 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:49:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:49:26 INFO - "stage_platform": "linux64", 11:49:26 INFO - "basedir": "/builds/slave/test", 11:49:26 INFO - "buildnumber": 492, 11:49:26 INFO - "platform": "ubuntu64_hw", 11:49:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:49:26 INFO - "slavebuilddir": "test", 11:49:26 INFO - "taskId": "fyrI1RNGQ0yGYh-fmxMFTw", 11:49:26 INFO - "branch": "mozilla-central", 11:49:26 INFO - "script_repo_revision": "production", 11:49:26 INFO - "revision": "4c7c05a49f3ce40aa0969beccb397380a8907f4a", 11:49:26 INFO - "slavename": "talos-linux64-ix-023", 11:49:26 INFO - "repo_path": "mozilla-central" 11:49:26 INFO - } 11:49:26 INFO - Finding installer, test and symbols from parent task. 11:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyrI1RNGQ0yGYh-fmxMFTw'}, attempt #1 11:49:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fyrI1RNGQ0yGYh-fmxMFTw'}, attempt #1 11:49:27 INFO - Task dependencies: dkptLtbpSxq5ska9dxYCFw 11:49:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw'}, attempt #1 11:49:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/test_packages.json 11:49:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip 11:49:27 INFO - Running post-action listener: _resource_record_post_action 11:49:27 INFO - [mozharness: 2017-03-29 18:49:27.589606Z] Finished read-buildbot-config step (success) 11:49:27 INFO - [mozharness: 2017-03-29 18:49:27.589827Z] Running download-and-extract step. 11:49:27 INFO - Running pre-action listener: _resource_record_pre_action 11:49:27 INFO - Running main action method: download_and_extract 11:49:27 INFO - mkdir: /builds/slave/test/build/tests 11:49:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:27 INFO - trying https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json 11:49:27 INFO - Downloading https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:49:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:49:28 INFO - Downloaded 986 bytes. 11:49:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:49:28 INFO - Using the following test package requirements: 11:49:28 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:49:28 INFO - u'common': [u'target.common.tests.zip'], 11:49:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:49:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:49:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:49:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:49:28 INFO - u'mozbase': [u'target.common.tests.zip'], 11:49:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:49:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:49:28 INFO - u'web-platform': [u'target.common.tests.zip', 11:49:28 INFO - u'target.web-platform.tests.zip'], 11:49:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:49:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:49:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip 11:49:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:28 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip into memory 11:49:29 INFO - Expected file size: 58224462 11:49:29 INFO - Obtained file size: 58224462 11:49:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:49:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip 11:49:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:39 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.common.tests.zip into memory 11:49:40 INFO - Expected file size: 58224462 11:49:40 INFO - Obtained file size: 58224462 11:49:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip 11:49:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:49:50 INFO - Fetch https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.talos.tests.zip into memory 11:49:51 INFO - Expected file size: 14404171 11:49:51 INFO - Obtained file size: 14404171 11:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:52 INFO - trying https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:52 INFO - Downloading https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:49:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:49:53 INFO - Downloaded 62494062 bytes. 11:49:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:53 INFO - mkdir: /builds/slave/test/properties 11:49:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:49:53 INFO - Writing to file /builds/slave/test/properties/build_url 11:49:53 INFO - Contents: 11:49:53 INFO - build_url:https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 11:49:53 INFO - Running post-action listener: _resource_record_post_action 11:49:53 INFO - Running post-action listener: set_extra_try_arguments 11:49:53 INFO - [mozharness: 2017-03-29 18:49:53.139440Z] Finished download-and-extract step (success) 11:49:53 INFO - [mozharness: 2017-03-29 18:49:53.139536Z] Running populate-webroot step. 11:49:53 INFO - Running pre-action listener: _resource_record_pre_action 11:49:53 INFO - Running main action method: populate_webroot 11:49:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:49:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:49:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:49:53 INFO - '--tppagecycles', 11:49:53 INFO - '7'], 11:49:53 INFO - 'tests': ['tsvgm']}}, 11:49:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:49:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:49:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:49:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:49:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:49:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['damp', 'tps']}, 11:49:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'tests': ['damp', 'tps']}, 11:49:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['dromaeo_dom']}, 11:49:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:49:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['basic_compositor_video']}, 11:49:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:49:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'other-e10s': {'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['a11yr', 11:49:53 INFO - 'ts_paint', 11:49:53 INFO - 'tpaint', 11:49:53 INFO - 'sessionrestore', 11:49:53 INFO - 'sessionrestore_no_auto_restore', 11:49:53 INFO - 'tabpaint']}, 11:49:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['tsvgx', 11:49:53 INFO - 'tsvgr_opacity', 11:49:53 INFO - 'tart', 11:49:53 INFO - 'tscrollx', 11:49:53 INFO - 'cart', 11:49:53 INFO - 'tsvg_static']}, 11:49:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:49:53 INFO - 'tsvgr_opacity', 11:49:53 INFO - 'tart', 11:49:53 INFO - 'tscrollx', 11:49:53 INFO - 'cart', 11:49:53 INFO - 'tsvg_static']}, 11:49:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'talos_options': ['--disable-e10s'], 11:49:53 INFO - 'tests': ['tp5o']}, 11:49:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:49:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'talos_options': ['--disable-e10s', 11:49:53 INFO - '--xperf_path', 11:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:53 INFO - 'tests': ['tp5n']}, 11:49:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:49:53 INFO - 'talos_options': ['--xperf_path', 11:49:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:49:53 INFO - 'tests': ['tp5n']}}, 11:49:53 INFO - 'talos.zip': {'path': '', 11:49:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:49:53 INFO - Running post-action listener: _resource_record_post_action 11:49:53 INFO - [mozharness: 2017-03-29 18:49:53.152614Z] Finished populate-webroot step (success) 11:49:53 INFO - [mozharness: 2017-03-29 18:49:53.152703Z] Running create-virtualenv step. 11:49:53 INFO - Running pre-action listener: _resource_record_pre_action 11:49:53 INFO - Running main action method: create_virtualenv 11:49:53 INFO - Creating virtualenv /builds/slave/test/build/venv 11:49:53 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 11:49:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:49:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:49:53 INFO - Using real prefix '/usr' 11:49:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:49:53 INFO - Installing distribute.............................................................................................................................................................................................done. 11:49:55 INFO - Installing pip.................done. 11:49:55 INFO - Return code: 0 11:49:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:49:55 INFO - Reading from file tmpfile_stdout 11:49:55 INFO - Output received: 11:49:55 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) 11:49:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:55 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:49:55 INFO - Using env: {'DISPLAY': ':0', 11:49:55 INFO - 'HOME': '/home/cltbld', 11:49:55 INFO - 'LANG': 'en_US.UTF-8', 11:49:55 INFO - 'LANGUAGE': 'en_US:en', 11:49:55 INFO - 'LOGNAME': 'cltbld', 11:49:55 INFO - 'MAIL': '/var/mail/cltbld', 11:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:55 INFO - 'MOZ_NO_REMOTE': '1', 11:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:55 INFO - 'NO_EM_RESTART': '1', 11:49:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:55 INFO - 'PWD': '/builds/slave/test', 11:49:55 INFO - 'SHELL': '/bin/bash', 11:49:55 INFO - 'SHLVL': '1', 11:49:55 INFO - 'TERM': 'linux', 11:49:55 INFO - 'TMOUT': '86400', 11:49:55 INFO - 'USER': 'cltbld', 11:49:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:55 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:56 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 11:49:56 INFO - Cleaning up... 11:49:56 INFO - Return code: 0 11:49:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:56 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:49:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:49:56 INFO - Using env: {'DISPLAY': ':0', 11:49:56 INFO - 'HOME': '/home/cltbld', 11:49:56 INFO - 'LANG': 'en_US.UTF-8', 11:49:56 INFO - 'LANGUAGE': 'en_US:en', 11:49:56 INFO - 'LOGNAME': 'cltbld', 11:49:56 INFO - 'MAIL': '/var/mail/cltbld', 11:49:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:56 INFO - 'MOZ_NO_REMOTE': '1', 11:49:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:56 INFO - 'NO_EM_RESTART': '1', 11:49:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:56 INFO - 'PWD': '/builds/slave/test', 11:49:56 INFO - 'SHELL': '/bin/bash', 11:49:56 INFO - 'SHLVL': '1', 11:49:56 INFO - 'TERM': 'linux', 11:49:56 INFO - 'TMOUT': '86400', 11:49:56 INFO - 'USER': 'cltbld', 11:49:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:49:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:56 INFO - '_': '/tools/buildbot/bin/python'} 11:49:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:56 INFO - Downloading/unpacking psutil>=3.1.1 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:58 INFO - Installing collected packages: psutil 11:49:58 INFO - Running setup.py install for psutil 11:49:58 INFO - building 'psutil._psutil_linux' extension 11:49:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:49:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:49:58 INFO - building 'psutil._psutil_posix' extension 11:49:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:49:58 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:49:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:49:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:49:59 INFO - Successfully installed psutil 11:49:59 INFO - Cleaning up... 11:49:59 INFO - Return code: 0 11:49:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:49:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:49:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:49:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:49:59 INFO - Using env: {'DISPLAY': ':0', 11:49:59 INFO - 'HOME': '/home/cltbld', 11:49:59 INFO - 'LANG': 'en_US.UTF-8', 11:49:59 INFO - 'LANGUAGE': 'en_US:en', 11:49:59 INFO - 'LOGNAME': 'cltbld', 11:49:59 INFO - 'MAIL': '/var/mail/cltbld', 11:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:49:59 INFO - 'MOZ_NO_REMOTE': '1', 11:49:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:49:59 INFO - 'NO_EM_RESTART': '1', 11:49:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:49:59 INFO - 'PWD': '/builds/slave/test', 11:49:59 INFO - 'SHELL': '/bin/bash', 11:49:59 INFO - 'SHLVL': '1', 11:49:59 INFO - 'TERM': 'linux', 11:49:59 INFO - 'TMOUT': '86400', 11:49:59 INFO - 'USER': 'cltbld', 11:49:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:49:59 INFO - '_': '/tools/buildbot/bin/python'} 11:49:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:49:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:49:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:50:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:50:01 INFO - Installing collected packages: mozsystemmonitor 11:50:01 INFO - Running setup.py install for mozsystemmonitor 11:50:01 INFO - Successfully installed mozsystemmonitor 11:50:01 INFO - Cleaning up... 11:50:01 INFO - Return code: 0 11:50:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:01 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:50:01 INFO - Using env: {'DISPLAY': ':0', 11:50:01 INFO - 'HOME': '/home/cltbld', 11:50:01 INFO - 'LANG': 'en_US.UTF-8', 11:50:01 INFO - 'LANGUAGE': 'en_US:en', 11:50:01 INFO - 'LOGNAME': 'cltbld', 11:50:01 INFO - 'MAIL': '/var/mail/cltbld', 11:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:01 INFO - 'MOZ_NO_REMOTE': '1', 11:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:01 INFO - 'NO_EM_RESTART': '1', 11:50:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:01 INFO - 'PWD': '/builds/slave/test', 11:50:01 INFO - 'SHELL': '/bin/bash', 11:50:01 INFO - 'SHLVL': '1', 11:50:01 INFO - 'TERM': 'linux', 11:50:01 INFO - 'TMOUT': '86400', 11:50:01 INFO - 'USER': 'cltbld', 11:50:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:01 INFO - '_': '/tools/buildbot/bin/python'} 11:50:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:01 INFO - Downloading/unpacking jsonschema==2.5.1 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:04 INFO - warning: no files found matching '*.txt' 11:50:04 INFO - no previously-included directories found matching 'build' 11:50:04 INFO - no previously-included directories found matching 'dist' 11:50:04 INFO - no previously-included directories found matching '.git*' 11:50:04 INFO - Installing collected packages: jsonschema, functools32 11:50:04 INFO - Running setup.py install for functools32 11:50:04 INFO - warning: no files found matching '*.txt' 11:50:04 INFO - no previously-included directories found matching 'build' 11:50:04 INFO - no previously-included directories found matching 'dist' 11:50:04 INFO - no previously-included directories found matching '.git*' 11:50:04 INFO - Successfully installed jsonschema functools32 11:50:04 INFO - Cleaning up... 11:50:04 INFO - Return code: 0 11:50:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:50:04 INFO - Using env: {'DISPLAY': ':0', 11:50:04 INFO - 'HOME': '/home/cltbld', 11:50:04 INFO - 'LANG': 'en_US.UTF-8', 11:50:04 INFO - 'LANGUAGE': 'en_US:en', 11:50:04 INFO - 'LOGNAME': 'cltbld', 11:50:04 INFO - 'MAIL': '/var/mail/cltbld', 11:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:04 INFO - 'MOZ_NO_REMOTE': '1', 11:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:04 INFO - 'NO_EM_RESTART': '1', 11:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:04 INFO - 'PWD': '/builds/slave/test', 11:50:04 INFO - 'SHELL': '/bin/bash', 11:50:04 INFO - 'SHLVL': '1', 11:50:04 INFO - 'TERM': 'linux', 11:50:04 INFO - 'TMOUT': '86400', 11:50:04 INFO - 'USER': 'cltbld', 11:50:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:04 INFO - '_': '/tools/buildbot/bin/python'} 11:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:50:04 INFO - Cleaning up... 11:50:04 INFO - Return code: 0 11:50:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:50:04 INFO - Using env: {'DISPLAY': ':0', 11:50:04 INFO - 'HOME': '/home/cltbld', 11:50:04 INFO - 'LANG': 'en_US.UTF-8', 11:50:04 INFO - 'LANGUAGE': 'en_US:en', 11:50:04 INFO - 'LOGNAME': 'cltbld', 11:50:04 INFO - 'MAIL': '/var/mail/cltbld', 11:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:04 INFO - 'MOZ_NO_REMOTE': '1', 11:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:04 INFO - 'NO_EM_RESTART': '1', 11:50:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:04 INFO - 'PWD': '/builds/slave/test', 11:50:04 INFO - 'SHELL': '/bin/bash', 11:50:04 INFO - 'SHLVL': '1', 11:50:04 INFO - 'TERM': 'linux', 11:50:04 INFO - 'TMOUT': '86400', 11:50:04 INFO - 'USER': 'cltbld', 11:50:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:04 INFO - '_': '/tools/buildbot/bin/python'} 11:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:50: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 11:50: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 11:50:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50: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 11:50: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 11:50:06 INFO - Downloading blobuploader-1.2.4.tar.gz 11:50:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:50:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:50: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 11:50: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 11:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50: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 11:50: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 11:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:50:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:50: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 11:50: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 11:50:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50: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 11:50: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 11:50:07 INFO - Downloading docopt-0.6.1.tar.gz 11:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:50:07 INFO - Installing collected packages: blobuploader, requests, docopt 11:50:07 INFO - Running setup.py install for blobuploader 11:50:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:50:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:50:07 INFO - Running setup.py install for requests 11:50:07 INFO - Running setup.py install for docopt 11:50:08 INFO - Successfully installed blobuploader requests docopt 11:50:08 INFO - Cleaning up... 11:50:08 INFO - Return code: 0 11:50:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:50:08 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:08 INFO - Using env: {'DISPLAY': ':0', 11:50:08 INFO - 'HOME': '/home/cltbld', 11:50:08 INFO - 'LANG': 'en_US.UTF-8', 11:50:08 INFO - 'LANGUAGE': 'en_US:en', 11:50:08 INFO - 'LOGNAME': 'cltbld', 11:50:08 INFO - 'MAIL': '/var/mail/cltbld', 11:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:08 INFO - 'MOZ_NO_REMOTE': '1', 11:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:08 INFO - 'NO_EM_RESTART': '1', 11:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:08 INFO - 'PWD': '/builds/slave/test', 11:50:08 INFO - 'SHELL': '/bin/bash', 11:50:08 INFO - 'SHLVL': '1', 11:50:08 INFO - 'TERM': 'linux', 11:50:08 INFO - 'TMOUT': '86400', 11:50:08 INFO - 'USER': 'cltbld', 11:50:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:08 INFO - '_': '/tools/buildbot/bin/python'} 11:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:08 INFO - Running setup.py (path:/tmp/pip-7EEvrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:08 INFO - Running setup.py (path:/tmp/pip-Uvb4j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:08 INFO - Running setup.py (path:/tmp/pip-nto27d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:08 INFO - Running setup.py (path:/tmp/pip-_6sCFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:08 INFO - Running setup.py (path:/tmp/pip-X6TIj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:08 INFO - Running setup.py (path:/tmp/pip-otHxmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:08 INFO - Running setup.py (path:/tmp/pip-t9QE7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:08 INFO - Running setup.py (path:/tmp/pip-K5YUY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:08 INFO - Running setup.py (path:/tmp/pip-xeUot8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:08 INFO - Running setup.py (path:/tmp/pip-6BsIAm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:09 INFO - Running setup.py (path:/tmp/pip-8HEqhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:09 INFO - Running setup.py (path:/tmp/pip-iUYohI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:09 INFO - Running setup.py (path:/tmp/pip-j0_zYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:09 INFO - Running setup.py (path:/tmp/pip-FGdCJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:09 INFO - Running setup.py (path:/tmp/pip-ddiP8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:09 INFO - Running setup.py (path:/tmp/pip-lFXz7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:09 INFO - Running setup.py (path:/tmp/pip-x_4HWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:50:09 INFO - Running setup.py install for manifestparser 11:50:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:50:09 INFO - Running setup.py install for mozcrash 11:50:09 INFO - Running setup.py install for mozdebug 11:50:09 INFO - Running setup.py install for mozdevice 11:50:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:50:09 INFO - Running setup.py install for mozfile 11:50:10 INFO - Running setup.py install for mozhttpd 11:50:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for mozinfo 11:50:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for mozInstall 11:50:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for mozleak 11:50:10 INFO - Running setup.py install for mozlog 11:50:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for moznetwork 11:50:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for mozprocess 11:50:10 INFO - Running setup.py install for mozprofile 11:50:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:50:10 INFO - Running setup.py install for mozrunner 11:50:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:50:11 INFO - Running setup.py install for mozscreenshot 11:50:11 INFO - Running setup.py install for moztest 11:50:11 INFO - Running setup.py install for mozversion 11:50:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:50:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:50:11 INFO - Cleaning up... 11:50:11 INFO - Return code: 0 11:50:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:50:11 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:11 INFO - Using env: {'DISPLAY': ':0', 11:50:11 INFO - 'HOME': '/home/cltbld', 11:50:11 INFO - 'LANG': 'en_US.UTF-8', 11:50:11 INFO - 'LANGUAGE': 'en_US:en', 11:50:11 INFO - 'LOGNAME': 'cltbld', 11:50:11 INFO - 'MAIL': '/var/mail/cltbld', 11:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:11 INFO - 'MOZ_NO_REMOTE': '1', 11:50:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:11 INFO - 'NO_EM_RESTART': '1', 11:50:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:11 INFO - 'PWD': '/builds/slave/test', 11:50:11 INFO - 'SHELL': '/bin/bash', 11:50:11 INFO - 'SHLVL': '1', 11:50:11 INFO - 'TERM': 'linux', 11:50:11 INFO - 'TMOUT': '86400', 11:50:11 INFO - 'USER': 'cltbld', 11:50:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:11 INFO - '_': '/tools/buildbot/bin/python'} 11:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:11 INFO - Running setup.py (path:/tmp/pip-NS5YgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:11 INFO - Running setup.py (path:/tmp/pip-QY6qti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:11 INFO - Running setup.py (path:/tmp/pip-FvamAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:11 INFO - Running setup.py (path:/tmp/pip-SUxI0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:11 INFO - Running setup.py (path:/tmp/pip-9BNEFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:50:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:11 INFO - Running setup.py (path:/tmp/pip-I5Uq50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:12 INFO - Running setup.py (path:/tmp/pip-E3ijz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:12 INFO - Running setup.py (path:/tmp/pip-pzhgVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:12 INFO - Running setup.py (path:/tmp/pip-CmiRfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:12 INFO - Running setup.py (path:/tmp/pip-DfhLZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:12 INFO - Running setup.py (path:/tmp/pip-3gipGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:12 INFO - Running setup.py (path:/tmp/pip-y8PUUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:12 INFO - Running setup.py (path:/tmp/pip-YL1k07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:12 INFO - Running setup.py (path:/tmp/pip-05QRsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:12 INFO - Running setup.py (path:/tmp/pip-i16Qtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:12 INFO - Running setup.py (path:/tmp/pip-nAvAd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:50:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:12 INFO - Running setup.py (path:/tmp/pip-w9NEU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:12 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:14 INFO - Downloading blessings-1.6.tar.gz 11:50:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:14 INFO - Installing collected packages: blessings 11:50:14 INFO - Running setup.py install for blessings 11:50:15 INFO - Successfully installed blessings 11:50:15 INFO - Cleaning up... 11:50:15 INFO - Return code: 0 11:50:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:15 INFO - Reading from file tmpfile_stdout 11:50:15 INFO - Current package versions: 11:50:15 INFO - argparse == 1.2.1 11:50:15 INFO - blessings == 1.6 11:50:15 INFO - blobuploader == 1.2.4 11:50:15 INFO - docopt == 0.6.1 11:50:15 INFO - functools32 == 3.2.3-2 11:50:15 INFO - jsonschema == 2.5.1 11:50:15 INFO - manifestparser == 1.1 11:50:15 INFO - mozInstall == 1.12 11:50:15 INFO - mozcrash == 1.0 11:50:15 INFO - mozdebug == 0.1 11:50:15 INFO - mozdevice == 0.49 11:50:15 INFO - mozfile == 1.2 11:50:15 INFO - mozhttpd == 0.7 11:50:15 INFO - mozinfo == 0.9 11:50:15 INFO - mozleak == 0.1 11:50:15 INFO - mozlog == 3.4 11:50:15 INFO - moznetwork == 0.27 11:50:15 INFO - mozprocess == 0.25 11:50:15 INFO - mozprofile == 0.28 11:50:15 INFO - mozrunner == 6.13 11:50:15 INFO - mozscreenshot == 0.1 11:50:15 INFO - mozsystemmonitor == 0.3 11:50:15 INFO - moztest == 0.8 11:50:15 INFO - mozversion == 1.4 11:50:15 INFO - psutil == 3.1.1 11:50:15 INFO - requests == 1.2.3 11:50:15 INFO - wsgiref == 0.1.2 11:50:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:50:15 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:15 INFO - Using env: {'DISPLAY': ':0', 11:50:15 INFO - 'HOME': '/home/cltbld', 11:50:15 INFO - 'LANG': 'en_US.UTF-8', 11:50:15 INFO - 'LANGUAGE': 'en_US:en', 11:50:15 INFO - 'LOGNAME': 'cltbld', 11:50:15 INFO - 'MAIL': '/var/mail/cltbld', 11:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:15 INFO - 'MOZ_NO_REMOTE': '1', 11:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:15 INFO - 'NO_EM_RESTART': '1', 11:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:15 INFO - 'PWD': '/builds/slave/test', 11:50:15 INFO - 'SHELL': '/bin/bash', 11:50:15 INFO - 'SHLVL': '1', 11:50:15 INFO - 'TERM': 'linux', 11:50:15 INFO - 'TMOUT': '86400', 11:50:15 INFO - 'USER': 'cltbld', 11:50:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:15 INFO - '_': '/tools/buildbot/bin/python'} 11:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:15 INFO - Cleaning up... 11:50:15 INFO - Return code: 0 11:50:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2741a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28e6b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, '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': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:50:15 INFO - Using env: {'DISPLAY': ':0', 11:50:15 INFO - 'HOME': '/home/cltbld', 11:50:15 INFO - 'LANG': 'en_US.UTF-8', 11:50:15 INFO - 'LANGUAGE': 'en_US:en', 11:50:15 INFO - 'LOGNAME': 'cltbld', 11:50:15 INFO - 'MAIL': '/var/mail/cltbld', 11:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:15 INFO - 'MOZ_NO_REMOTE': '1', 11:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:15 INFO - 'NO_EM_RESTART': '1', 11:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:15 INFO - 'PWD': '/builds/slave/test', 11:50:15 INFO - 'SHELL': '/bin/bash', 11:50:15 INFO - 'SHLVL': '1', 11:50:15 INFO - 'TERM': 'linux', 11:50:15 INFO - 'TMOUT': '86400', 11:50:15 INFO - 'USER': 'cltbld', 11:50:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:15 INFO - '_': '/tools/buildbot/bin/python'} 11:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:50:15 INFO - Cleaning up... 11:50:15 INFO - Return code: 0 11:50:15 INFO - Running post-action listener: _resource_record_post_action 11:50:15 INFO - Running post-action listener: _start_resource_monitoring 11:50:15 INFO - Starting resource monitoring. 11:50:15 INFO - [mozharness: 2017-03-29 18:50:15.962595Z] Finished create-virtualenv step (success) 11:50:15 INFO - [mozharness: 2017-03-29 18:50:15.963109Z] Running install step. 11:50:15 INFO - Running pre-action listener: _resource_record_pre_action 11:50:15 INFO - Running main action method: install 11:50:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:16 INFO - Reading from file tmpfile_stdout 11:50:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:16 INFO - Reading from file tmpfile_stdout 11:50:16 INFO - Output received: 11:50:16 INFO - Usage: mozinstall [options] installer 11:50:16 INFO - Options: 11:50:16 INFO - -h, --help show this help message and exit 11:50:16 INFO - -d DEST, --destination=DEST 11:50:16 INFO - Directory to install application into. [default: 11:50:16 INFO - "/builds/slave/test"] 11:50:16 INFO - --app=APP Application being installed. [default: firefox] 11:50:16 INFO - mkdir: /builds/slave/test/build/application 11:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:50:31 INFO - Reading from file tmpfile_stdout 11:50:31 INFO - Output received: 11:50:31 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:31 INFO - Running post-action listener: _resource_record_post_action 11:50:31 INFO - [mozharness: 2017-03-29 18:50:31.888189Z] Finished install step (success) 11:50:31 INFO - [mozharness: 2017-03-29 18:50:31.888462Z] Running run-tests step. 11:50:31 INFO - Running pre-action listener: _resource_record_pre_action 11:50:31 INFO - Running main action method: run_tests 11:50:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:31 INFO - Python 2.7.3 11:50:31 INFO - Return code: 0 11:50:31 INFO - grabbing minidump binary from tooltool 11:50:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:31 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 0x28e4290>, '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 0x28e4b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28e5040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:31 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 11:50:31 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 11:50:31 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 11:50:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:31 INFO - Return code: 0 11:50:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:31 INFO - ENV: RUST_BACKTRACE is now 1 11:50:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:31 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/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:50:31 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/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:50:31 INFO - Using env: {'DISPLAY': ':0', 11:50:31 INFO - 'HOME': '/home/cltbld', 11:50:31 INFO - 'LANG': 'en_US.UTF-8', 11:50:31 INFO - 'LANGUAGE': 'en_US:en', 11:50:31 INFO - 'LOGNAME': 'cltbld', 11:50:31 INFO - 'MAIL': '/var/mail/cltbld', 11:50:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:31 INFO - 'MOZ_NO_REMOTE': '1', 11:50:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:31 INFO - 'NO_EM_RESTART': '1', 11:50:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:31 INFO - 'PWD': '/builds/slave/test', 11:50:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:31 INFO - 'RUST_BACKTRACE': '1', 11:50:31 INFO - 'SHELL': '/bin/bash', 11:50:31 INFO - 'SHLVL': '1', 11:50:31 INFO - 'TERM': 'linux', 11:50:31 INFO - 'TMOUT': '86400', 11:50:31 INFO - 'USER': 'cltbld', 11:50:31 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271', 11:50:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:31 INFO - '_': '/tools/buildbot/bin/python'} 11:50:31 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/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:50:32 INFO - mozversion application_buildid: 20170329182208 11:50:32 INFO - mozversion application_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 11:50:32 INFO - mozversion application_display_name: Nightly 11:50:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:32 INFO - mozversion application_name: Firefox 11:50:32 INFO - mozversion application_remotingname: firefox 11:50:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:50:32 INFO - mozversion application_vendor: Mozilla 11:50:32 INFO - mozversion application_version: 55.0a1 11:50:32 INFO - mozversion platform_buildid: 20170329182208 11:50:32 INFO - mozversion platform_changeset: 4c7c05a49f3ce40aa0969beccb397380a8907f4a 11:50:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:50:32 INFO - mozversion platform_version: 55.0a1 11:50:32 INFO - using testdate: 1490813432 11:50:32 INFO - actual date: 1490813432 11:50:32 INFO - starting webserver on 'localhost:34343' 11:50:32 INFO - SUITE-START | Running 2 tests 11:50:32 INFO - TEST-START | dromaeo_css 11:50:32 INFO - operating with platform_type : linux_ 11:50:32 INFO - Initialising browser for dromaeo_css test... 11:50:32 INFO - TEST-INFO | started process 14557 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIL86K/profile http://localhost:34343/getInfo.html) 11:50:36 INFO - PID 14557 | __metrics Screen width/height:1600/1200 11:50:36 INFO - PID 14557 | colorDepth:24 11:50:36 INFO - PID 14557 | Browser inner width/height: 1024/697 11:50:36 INFO - PID 14557 | __metrics 11:50:37 ERROR - PID 14557 | 1490813437223 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpyIL86K/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpyIL86K/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpyIL86K/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpyIL86K/profile/extensions/talos-powers@TalosPowersService.js:55:9 11:50:37 ERROR - PID 14557 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 11:50:38 INFO - TEST-INFO | 14557: exit 0 11:50:38 INFO - Browser initialized. 11:50:38 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:38 INFO - TEST-INFO | started process 14687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIL86K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:50 INFO - PID 14687 | RSS: Main: 155504640 11:50:50 INFO - PID 14687 | 11:53:56 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34343/tests/dromaeo/cssquery-ext.html) 11:53:57 INFO - PID 14687 | RSS: Main: 165564416 11:53:57 INFO - PID 14687 | 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | A coding exception was thrown and uncaught in a Task. 11:55:38 INFO - PID 14687 | 11:55:38 ERROR - PID 14687 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:38 INFO - PID 14687 | Full stack: 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | A coding exception was thrown and uncaught in a Task. 11:55:38 INFO - PID 14687 | 11:55:38 ERROR - PID 14687 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:38 INFO - PID 14687 | Full stack: 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | A coding exception was thrown and uncaught in a Task. 11:55:38 INFO - PID 14687 | 11:55:38 ERROR - PID 14687 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:38 INFO - PID 14687 | Full stack: 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | ************************* 11:55:38 INFO - PID 14687 | A coding exception was thrown and uncaught in a Task. 11:55:38 INFO - PID 14687 | 11:55:38 ERROR - PID 14687 | Full message: TypeError: NetworkError when attempting to fetch resource. 11:55:38 INFO - PID 14687 | Full stack: 11:55:38 INFO - PID 14687 | ************************* 11:56:59 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-ext.html (next: http://localhost:34343/tests/dromaeo/cssquery-jquery.html) 11:57:00 INFO - PID 14687 | RSS: Main: 162131968 11:57:00 INFO - PID 14687 | 12:00:02 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34343/tests/dromaeo/cssquery-mootools.html) 12:00:03 INFO - PID 14687 | RSS: Main: 169799680 12:00:03 INFO - PID 14687 | 12:03:05 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34343/tests/dromaeo/cssquery-prototype.html) 12:03:05 INFO - PID 14687 | RSS: Main: 161345536 12:03:05 INFO - PID 14687 | 12:06:08 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34343/tests/dromaeo/cssquery-yui.html) 12:06:09 INFO - PID 14687 | RSS: Main: 169349120 12:06:09 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | Cycle 1(1): loaded http://localhost:34343/tests/dromaeo/cssquery-yui.html (next: http://localhost:34343/tests/dromaeo/cssquery-dojo.html) 12:09:12 INFO - PID 14687 | RSS: Main: 162017280 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | __start_tp_report 12:09:12 INFO - PID 14687 | _x_x_mozilla_page_load 12:09:12 INFO - PID 14687 | _x_x_mozilla_page_load_details 12:09:12 INFO - PID 14687 | |i|pagename|runs| 12:09:12 INFO - PID 14687 | |0;dojo.html;2716.9320766980823;2738.082742281336;2750.174947515745;2772.2237773423435;2773.7226277372265;5255.605829562788;5414.702191379478;5423.999999999995;5443.237946687467;5455.836324910254;5357.8392648220615;5377.139657654776;5401.594880383967;5481.835544933649;5497.038018346783;4923.926141107877;4950.405951285851;4957.206846904496;4968.080905032581;5001.6998980061135;4933.136701077315;4985.40175178979;5026.623003274751;5033.723145227011;5034.219695947116;4784.40194975628;4829.7102173869325;4865.586425153866;4910.950890491085;4960.975195124038;4917.72952487613;4940.802367905279;4960.70235785854;4984.6261530385;4988.176950803113;4858.271259311132;4860.270959356089;4874.195757699975;4895.681780684244;4959.82640607577;5142.820001299937;5225.059489291926;5385.192221166817;5386.757595908193;5416.674999500043;5839.532837373;5867.266591676041;5916.112583112525;5918.763249470016;5925.555583331225;5903.3801450847905;5913.46778789911;5920.348761636216;5921.61509501881;5921.8815623687715;5267.104592219255;5459.426760190202;5480.972595136999;5482.533984611353;5483.4516548344845;5896.1450589664255;5985.790497332572;6016.1878146450545;6056.697165141725;6081.543884208702;5515.696636685021;5596.496315331639;5720.2849643794525;5775.509081728016;5802.419758024248;5873.177755114288;5887.234659494238;5891.293044834647;5895.675737834375;5928.051511758098;5829.183914252008;5836.1245813127525;5840.795572154954;5859.384764599741;5872.823815285548;5588;5689.231953686282;5691.715414229272;5692.975264452439;5821.09772985188;4754.857354279377;4774.21225497789;4777.402824646919;4783.569478746929;4784.521547845257;4120.835166593302;4121.8969525762095;4128.112455821953;4132.834686612562;4136.627703506639;4754.953910139764;4760.357351757538;4762.190427627312;4762.64280178988;4781.426228852491;5667.404922483162;5716.142578613241;5723.7996670116345;5725.77096916127;5732.570057245724;4767.237242041257;4767.998720268783;4768.546988036131;4769.998300356894;4773.307870358848;5102.948970510248;5106.310648062464;5124.9743751281;5134;5146.665466744649;5426.538744206708;5446.918296225639;5463.289772329572;5472.616916815785;5515.4760297771645;5607.579431542732;5668.518175954925;5844.590878638624;5871.089981052944;5872.412758724094;5313.54834839043;5347.652402593819;5353.089974704231;5359.598030147677;5369.865753356197;5677.716114194356;5750.5112065474905;5821.301443826768;5848.64908105515;5858.150568167506;5736.663320856613;5843.474087332161;5846.853828654318;5850.619709718854;5852.502537284378;5628.183913332626;5632.5212356950115;5643.576731745217;5643.71781410936;5645.491905728504;5402.729863506887;5506.64206826555;5610.410906854721;5614.382417933943;5670.631408958405;5572.86067848307;5576.10782274834;5580.832575022756;5583.69289689071;5590.888182236414;5673.801416950387;5697.686627235542;5715.057015592381;5716.685582293014;5717.199592057199;5354.812581559627;5420.53925416344;5520.834374968757;5525.972370138124;5561.888762224814 12:09:12 INFO - PID 14687 | |1;ext.html;637.1398611873971;689.6758523493958;710.8684893294741;1079.8650168728914;1091.0889407344866;32693.67306326936;33636.663633363656;33751.49372759405;33762.831185844065;33794.15514612136;35441.468377974285;35959.82020089903;35994.8200258999;36002.27995440096;36200.27599448009;7435.367993720541;7557.92442075579;7656.042994625672;7681.8079548011465;7685.385169186479;7581.279778421069;7693.30760231579;7699.153093159748;7701.383889288872;7701.499402538817;7671.194524574895;7675.616219189018;7723;7739.032620922385;7739.458237923348;7642.541447513167;7686.961565192139;7688.616049111158;7696.769096927129;7716.189800070968;7464.925350746477;7525.887111693329;7530.736424225126;7535.472516923817;7539.208383119803;36042.09894752626;36149.27701445956;36281.81859090714;36318;36319.4552081719;2342.8360014798973;2371.4071482129466;2398.6282126270457;2648.735126487336;2752.2844060544203;23359.7664023361;23382.883085584464;23424.18015369454;24028.27915162548;24382.756172438225;2510.221831232324;2532.987335063331;2541.542522345977;2553.438243586408;2565.2432532402986;129901;130531.34734326362;155989;158191;158534;41739.791301043304;41774;41774.79112604478;41820;41887.27732697365;43640.563594364285;43693.78153109214;43821.78089109534;43857.122857543305;43939.34090988638;10581.89418105809;10681.946590266998;10691.946540267249;10701.19741019411;10739.677809665722;8246.09292977772;8260.752177434686;8292.12932642064;8326;8335.916640833635;13544.59366219015;13559.796603050961;13613.251271179983;13663.726725465434;13774.311284435738;5561.888762224814;5655;5680.914786278209;5702.087665973424;5830.4461076197695;853.4154104438479;887.7039522297518;888.4225253585221;893.9687110951086;929.6839074714629;20520;21800.781992180193;21946.670799938012;21950.560988780137;22368.888155559445;943.3962264150949;960.519740129935;967.7338731848657;972.6595691507915;987.274353350287;11113.44432778374;11497.080233581293;11628.6511404658;11641.59254426091;11645.88354116448;242374;242848;244705;245094;245169;43531;43856.12287754227;44081.338779918326;44168;44315.55684443114;1150.9712257193637;1214.6659668591208;1218.1533833985295;1218.8963938065187;1227.5887577661583;20052;20632.17471301191;20943.162273509497;21619.459513512287;22025;31896.36207275795;31916.5212521817;32026.83986580052;32027.83986080055;32058.519122212718;212782;213515;213579;213766;214075;29505.409891802472;29593.40813183681;30693.53959690562;30697.53953690741;30699.2325191872;36078.27843443169;36472.63527364693;37082;37446;37673.246535069695;27820;27846.16461506158;27923.301917452227;28108.43783124367;29193;27758.861205693844;27931;27962;29201;29278.7072129276;30813.075607731804;31286.217844554067;31305.37389252248;31747.52378714275;31846;25805.6129158059;26702.93188272525;27936.580951286152;27945.301367465978;28590.285242868264;20897.791022090194;22803.88598056999;22915.54168916579;23038;23131.4217144566 12:09:12 INFO - PID 14687 | |2;jquery.html;414.53364964415033;417.56816255805467;429.94410726605525;438.83982346443554;440.96031357177867;17622.471325860213;17935.73096403555;18530.53673658159;18572.164252608633;18857;15566.143862087582;15681.451149209779;15886.364545418199;16213.027218366877;16340.918295408535;5391.353037635479;5483.479069488392;5537.446255374471;5665.745041473144;5779.190913272145;5668.829935101953;5750.856228594277;5760.711964401763;5768.221290125843;5770.163326317682;5533.833984980437;5665.518430933375;5711.7715291388295;5720.056190728525;5749.59752817303;5728.14077888318;5731.828045158611;5762.9135562966585;5768.942310576904;5770.365259821417;5049.949500504985;5196.740162991835;5198.376194856642;5231.215317702337;5238.449962753894;21488.033038513306;21979.670304945437;22271.770593263886;22408.439789005242;22525.436864078365;1552.285948463708;1562.9452969146025;1566.8119825621;1566.9764953525707;1586.0562965035786;13161.605151845364;13405.865941340558;13685.247311397969;14014.369353379021;14686.90493445219;1725.6548690261873;1753.465193116099;1795.6318954614273;1811.6195598924241;1821.7719609847136;84540.57729711373;85474;85783;87422.56288718579;88235.99999999936;10474.47627618616;10651.467426628793;10742.248042637097;11186.720331991766;11345.716357090974;15152.166630835189;15182.848171518364;15202.315895784715;15212.695746085237;15239.3904243829;6738.966305168443;6848.828779280459;7006.369426751617;7085.326893945067;7109.360157585842;6165.475934545614;6185.907211391833;6357;6362.300146983828;6363.809085727436;6826.133024129877;6992.259141359348;7023.8244043898285;7033.964830175919;7051.400630946427;2046.6827641715558;2065.8863762493206;2069.286096296805;2092.62332780098;2231.129859354853;844.5355054720002;866.7183165471121;880.2188652313451;886.9733907982771;896.950667713269;16139.35442582307;16197.352105915867;16402.09788461646;16522.695460907627;17084.145792710315;864.7578677970179;866.7486428935538;868.6004437958484;874.3005595523556;880.5157163560017;9131.634734610541;9154.26765858743;9155.992840787509;9286.72139835806;9396.859047114298;435510.73871135665;437434;443831;443833;446643;80773.96130193467;81353;81534.59232703799;81614.18385816185;82126.58936705279;1050.6900464363032;1097.1661537231762;1119.4011204005817;1137.9146564007733;1140.5665846978095;16507;16864;17149.142542873054;17173.398931037354;17639.470815875546;43670.344944825214;43754.34368484539;43801.34297985597;43879;44282.77858610686;53711.46288537221;54093.72953135209;55431.445685542625;56038.439615604955;56165;7912.84174316522;7950.840983180419;8002.359811215205;8225.136360682282;8405.991281046314;11665.125115616533;11677;11790.469428875549;11847.822282665595;12309.507619695112;10564.15486761042;10891.945540272249;10892.077853340974;11073.446327683745;11298.49156787963;9757.512124393894;10047.447390393598;10056.547455364673;10184.083432491112;10580.629677961235;10941.507632156412;11053.778924421305;11133.220674552704;11515.30908145514;11677.240979336317;8103;8186.713465028695;8323.95838020806;8327.250547450758;8410.579471026547;10600.575976960836;10970.780584388427;11419.972202501815;11431.885681143081;11542 12:09:12 INFO - PID 14687 | |3;mootools.html;1253.6051143889674;1306.3011288960402;1306.314185052847;1322.4181360201505;1333.1134795361088;9530;9921.801563968726;9933.850992235113;9935.751606209848;10245.12916402105;10024;10153.847692284622;10204.438755868425;10206.948965255164;10208.846867296996;2119.395972147934;2157;2161.8270538356974;2162.372911855568;2171.283476452767;2179.3570896585547;2218.3344996500987;2240.529488807352;2290.278562252893;2295.552367288371;2193.4954960359128;2265.2071774878827;2266.172846910882;2282.8173746100356;2283.577538155438;2154.6983422320886;2246.86518808872;2256.4133325335447;2263;2263.4228271790753;2186.835987300959;2211.5245222277126;2217.1796435319034;2249.246502421691;2303.124812571229;10006.79986400268;10081.848772268422;10096.545655445523;10097.192224622013;10097.343672661253;5072.416672082721;5268.236105764643;5270.631055826094;5272.051030814452;5277.525022747971;3183.984080079608;3255.7395408367274;3306.041248038066;3350.731941444679;3359.5128706337446;1039;1042.9113525350353;1047.748540350318;1072.6031368393744;1088.542812018946;14471;14494.260688717315;14567.980241383108;14576.562703118923;14583.56249312533;4713.19283641582;4749.62003039756;4749.952500474951;4831.492693267156;4906.362172917569;10788.56845726178;10840.891591084146;10866.348019118721;10887.183461240438;10889.292196007234;5152.639315247897;5153.948460515422;5173.482651734872;5190.403103643054;5207.218917162456;4478.39541661878;4689;4718.457377401643;4726.952730472652;4727.078219747116;3806.5447786178315;3859.9421008684894;3870.6903447724117;3943.7830919299713;3946.9210615787524;1136.9317840929405;1158.623447379605;1159.756451145252;1167.737259116692;1172.4313707851686;668.2949488289901;672.414998950906;686.2691233835949;692.6190595172735;697.4141720954423;5782.335031471434;5836.591438599257;5980.85047873798;6056.152138700585;6092.058886578982;799.5122974985254;801.527099011586;817.9100298967109;840.3319361107934;841.0286119531951;3419.452887537982;3591.5510561179854;3765.1151979284846;3797.088698712289;3820.7898565578603;12596.55912043074;12914.22514649124;12957.611271661865;13016.609501714964;13066.934665326802;12430.37848107591;12840.550580729816;12869.099163058496;12888.420021099073;12988.935055324851;9247.12152345526;9430.717078487656;9440.763980900532;9442.95278523603;9470.626759119888;5820.359760426434;5951.880962380642;6026.608270462406;6264.843378915563;6286.277078136073;11348.432578370883;11351.205415620827;11372;11507.252028618113;11540;11258.817824128677;11733.941330293294;11804.70488237801;11835.822462662894;11883.702907427383;8154.673813047411;8319.542425166674;8325.16748325187;8386.916130838857;8395;8928.687495937871;8972.28221742246;8973;9089.136532029446;9152.542372881197;7480.3641690456925;7561.584112873845;7615.200403957726;7621.352185064332;7855.293023627901;7744.070711514654;7749;7765.41759368061;7938.563379013978;8052.436329456882;6431.421172094534;6523.445507131947;6550.181227346582;6569.901451478136;6588.341165883565;4959.256111583291;5049.065922804293;5211.348581427322;5211.869703257449;5292.126799078109;5148.794048238028;5163.535281824504;5212.9739351303;5237.895242095061;5294.867628309323 12:09:12 INFO - PID 14687 | |4;prototype.html;401.5201833808598;401.5743312089186;403.1936127744511;404.583279222401;417.75352542000235;5605.915911261329;5647.548196144309;5658.8019419320335;5665.348484924235;5666.57500687448;5441.347038355403;5539.224508568804;5548.55611551076;5572.247746554214;5586.91619625706;4436.933445998313;4445.444319460067;4446;4447.243968525342;4463.040446304044;4462.642988560908;4467.218236808561;4475.373447717306;4482.708623939449;4493.820247190125;4351.6518678505645;4390.517043125254;4414.80133393998;4446.3997360356425;4452.287633978564;4356.891077723082;4390.363397307405;4393.538678438782;4401.3397990301555;4420.668449866257;3964.187341594995;3983.960160398417;3990.5809889961715;4001.4998125234347;4008.2384346974272;5263.8682683222905;5424.484673955968;5460.754266058037;5461.371942226655;5463.972680136574;5118.131881863131;5125.692948298198;5127.8205262816;5134.152864777345;5137.357830271216;5832.300123985149;5832.766689332421;5845.649261044351;5846.269216347957;5920.585559010871;3914.7846868422225;4090.8568200112854;4098.631123198897;4101.179764047172;4396.120775844844;5958.702064896738;6121.1024582379605;6168.87662246757;6179.938200617981;6181.041938499495;4148.834046638161;4194.937075943863;4204.873853784391;4213.536510983789;4213.536510983789;4235.555266697014;4255.382969469471;4259.680523960716;4267.402563641031;4277.529471758104;4674.135284972291;4885.511448855086;4893.4617192108835;4907.9263811042865;4909.533594308535;5821.2141360916585;5853.268341457318;5854.209681692917;5867.301041520863;5888.705564721747;1472.5582325302366;1484.92575371231;1487;1489.7839813227022;1490.6720521485256;955.1356022799378;1005.3565717940523;1010.5301035018751;1014.9238807089498;1020.6223697232072;5008.624353173526;5008.974955125201;5009.599232061426;5010.724410157403;5011.52390522907;6002.0996850472775;6040.459682780863;6050.364711705296;6070.544709146743;6087.391260873877;4798.136335459651;4951.480094590088;4957.876053098629;4980.950190498121;4984.828565287155;3190.202449387653;3215.903522894317;3222.9838850806063;3229.7416206703406;3235.320582677617;5621.18492818539;5636.154576813511;5644.491995720405;5655.123455864347;5655.236543066633;5899.321578018497;6229.190205273286;6250.4374606285655;6262.4577249134845;6264.21697287839;5647.943520564824;5662.518685911744;5664.0937450007805;5683.857903552444;5688.971555142198;5867.474456641389;6048.879022419615;6079.422454866781;6085.421884920926;6115.143879856734;6009.639421634716;6017.789377371771;6031.969840150771;6035.185249991195;6051.788187413419;5521.751521181476;5615.438456154516;5629.943700562942;5679.9148012779015;5690.5163061140265;4224.408582798472;4250.234957707518;4251.95748042528;4256.723312984646;4271.615554600101;5952.214335699359;6068.120122582289;6085.509050282709;6099.725512351866;6129.957907155884;5798.768049277982;5817.738201781015;5834.94165058344;5841.240638716939;5850.151727999501;5803.390643982321;5831.620944638585;5837.0368889132815;5848.356680765028;5854.336276993872;5583.888322233452;5737.8565535861935;5746.195532625352;5758.280214973129;5761.913571296518;5899.023827017997;5906.793262235801;5908.438698323653;5921.763129474945;5926.970365148147;5559.583031272751;5702.6293290935955;5729.570282228766;5731.340895797037;5752.108423194411 12:09:12 INFO - PID 14687 | |5;yui.html;600.678636929243;602.484875431506;604.3352312456296;615.6275453350722;620.9410106039925;11334.546618135275;11374.658760237206;11680;11808.527658893645;11827.290362578251;12075.456604452798;12100.152989290731;12144;12212.694682632939;12213.20614160079;873.9563021848898;893.3300024981264;894.6734441928681;898.703427868805;926.0276709455079;929.2751653710117;935.8783358163429;938.9014153513886;939.8026414452974;941.1106504353389;943.5329511891623;952.5332587032374;952.9523523823781;953.2421724728822;954.7947191353858;942.6229508196708;944.0465130218461;946.3895787217207;948.1229862377343;949.0462085603958;689.1592257445908;692.8094773937157;699.7795694356262;699.9545029573112;700.1178515071047;11848.111391645662;12046;12101.334426606532;12108.21296615717;12151.817722734166;13228.338583070808;13828.792568111487;14032.859671403257;14209;14308.499202527966;9459.148676619137;9604.471754053524;9765.218782497454;9908.405495670282;10232.69301920936;2256.9435764105865;2278.100150440583;2302.1827251325703;2327.2203811723093;2342.0865862313713;59318;60545.69727151336;60814;60897.999999999556;61867;10213.744656383502;10282.07461328484;10301.793964120676;10516.369017858953;10572.471376431147;20838.791612083987;20839.374818755463;20901.268455604284;21041.158353665684;21089.472763181042;5706.115552089433;5732.627379220337;5766.596338256366;5793.536517078624;5958.433948774859;2902.6371703537056;2991.835449050323;3017.1853599528004;3036.4534383810683;3094.071778466451;3297.225152089257;3347.8828241011447;3350.1289664687356;3387.8475468603974;3410.5907291125222;588.8292395205342;589.0810335876047;603.1977469964936;611.0284647410639;611.248164757351;465.62982428969053;478.5664894013978;480.6275136769032;492.27948320619663;500.15973165082283;7118.252583478764;7250.891236631349;7289.380402665727;7573.242675732493;7582.810429739301;474.5823675165832;484.1454832221132;488.42853860982024;492.0945460352968;496.5630245384111;3180.6978337058404;3239.076863094007;3248.480243161083;3251.3009702913987;3335.933281334408;60209.698951504964;60473;61285;63378.36621633817;63852.68073659602;51365.48634513607;52622.736886315324;52716;53245.46754532483;53506;43842.342364864555;44932.3260151098;44940.101197975855;45364.319535206996;47685;8471;8760.861088058511;8927.598258078531;8931.629036753966;9114.908850911406;23591.528169436173;24104.638430423205;24165.51668966646;24206.878965605058;24954.500909981336;40682.18635627212;41197.58802411937;41391.1721765557;41821.79089104535;43910.56089439192;10247.180225581786;10311.278210525192;10339.534720937425;10388.636397726043;10470.759342466314;11184.273022253528;11401.885981140415;11526.250793698382;11754.823677645014;11767.52929882795;10131.442770647685;10210.693679189637;10384.844227336445;10435.582576696846;10732.51703673321;10537.262391632512;10633.734156646145;11203.383813890314;11622.128340374675;11629.24409913353;10565.841512377167;10710.785784284426;10941.07000904932;11186.944065279622;11582.305061696325;8526.488410695378;8631.238003838711;8635.784105397415;8646;8928.955355223183;9349.439033658002;9402.34183607141;9549.140577348073;9553.140217380469;9559 12:09:12 INFO - PID 14687 | __end_tp_report 12:09:12 INFO - PID 14687 | __start_cc_report 12:09:12 INFO - PID 14687 | _x_x_mozilla_cycle_collect,394 12:09:12 INFO - PID 14687 | __end_cc_report 12:09:12 INFO - PID 14687 | __startTimestamp1490814552341__endTimestamp 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | ------- Summary: start ------- 12:09:12 INFO - PID 14687 | Number of tests: 6 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#0] dojo.html Cycles:165 Average:5314.41 Median:5480.97 stddev:633.03 (11.5%) stddev-sans-first:601.28 12:09:12 INFO - PID 14687 | Values: 2716.9 2738.1 2750.2 2772.2 2773.7 5255.6 5414.7 5424.0 5443.2 5455.8 5357.8 5377.1 5401.6 5481.8 5497.0 4923.9 4950.4 4957.2 4968.1 5001.7 4933.1 4985.4 5026.6 5033.7 5034.2 4784.4 4829.7 4865.6 4911.0 4961.0 4917.7 4940.8 4960.7 4984.6 4988.2 4858.3 4860.3 4874.2 4895.7 4959.8 5142.8 5225.1 5385.2 5386.8 5416.7 5839.5 5867.3 5916.1 5918.8 5925.6 5903.4 5913.5 5920.3 5921.6 5921.9 5267.1 5459.4 5481.0 5482.5 5483.5 5896.1 5985.8 6016.2 6056.7 6081.5 5515.7 5596.5 5720.3 5775.5 5802.4 5873.2 5887.2 5891.3 5895.7 5928.1 5829.2 5836.1 5840.8 5859.4 5872.8 5588.0 5689.2 5691.7 5693.0 5821.1 4754.9 4774.2 4777.4 4783.6 4784.5 4120.8 4121.9 4128.1 4132.8 4136.6 4755.0 4760.4 4762.2 4762.6 4781.4 5667.4 5716.1 5723.8 5725.8 5732.6 4767.2 4768.0 4768.5 4770.0 4773.3 5102.9 5106.3 5125.0 5134.0 5146.7 5426.5 5446.9 5463.3 5472.6 5515.5 5607.6 5668.5 5844.6 5871.1 5872.4 5313.5 5347.7 5353.1 5359.6 5369.9 5677.7 5750.5 5821.3 5848.6 5858.2 5736.7 5843.5 5846.9 5850.6 5852.5 5628.2 5632.5 5643.6 5643.7 5645.5 5402.7 5506.6 5610.4 5614.4 5670.6 5572.9 5576.1 5580.8 5583.7 5590.9 5673.8 5697.7 5715.1 5716.7 5717.2 5354.8 5420.5 5520.8 5526.0 5561.9 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#1] ext.html Cycles:180 Average:34444.85 Median:31796.76 stddev:53619.18 (168.6%) stddev-sans-first:53709.51 12:09:12 INFO - PID 14687 | Values: 637.1 689.7 710.9 1079.9 1091.1 32693.7 33636.7 33751.5 33762.8 33794.2 35441.5 35959.8 35994.8 36002.3 36200.3 7435.4 7557.9 7656.0 7681.8 7685.4 7581.3 7693.3 7699.2 7701.4 7701.5 7671.2 7675.6 7723.0 7739.0 7739.5 7642.5 7687.0 7688.6 7696.8 7716.2 7464.9 7525.9 7530.7 7535.5 7539.2 36042.1 36149.3 36281.8 36318.0 36319.5 2342.8 2371.4 2398.6 2648.7 2752.3 23359.8 23382.9 23424.2 24028.3 24382.8 2510.2 2533.0 2541.5 2553.4 2565.2 129901.0 130531.3 155989.0 158191.0 158534.0 41739.8 41774.0 41774.8 41820.0 41887.3 43640.6 43693.8 43821.8 43857.1 43939.3 10581.9 10681.9 10691.9 10701.2 10739.7 8246.1 8260.8 8292.1 8326.0 8335.9 13544.6 13559.8 13613.3 13663.7 13774.3 5561.9 5655.0 5680.9 5702.1 5830.4 853.4 887.7 888.4 894.0 929.7 20520.0 21800.8 21946.7 21950.6 22368.9 943.4 960.5 967.7 972.7 987.3 11113.4 11497.1 11628.7 11641.6 11645.9 242374.0 242848.0 244705.0 245094.0 245169.0 43531.0 43856.1 44081.3 44168.0 44315.6 1151.0 1214.7 1218.2 1218.9 1227.6 20052.0 20632.2 20943.2 21619.5 22025.0 31896.4 31916.5 32026.8 32027.8 32058.5 212782.0 213515.0 213579.0 213766.0 214075.0 29505.4 29593.4 30693.5 30697.5 30699.2 36078.3 36472.6 37082.0 37446.0 37673.2 27820.0 27846.2 27923.3 28108.4 29193.0 27758.9 27931.0 27962.0 29201.0 29278.7 30813.1 31286.2 31305.4 31747.5 31846.0 25805.6 26702.9 27936.6 27945.3 28590.3 20897.8 22803.9 22915.5 23038.0 23131.4 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#2] jquery.html Cycles:180 Average:27106.60 Median:22096.59 stddev:73007.16 (330.4%) stddev-sans-first:73184.46 12:09:12 INFO - PID 14687 | Values: 414.5 417.6 429.9 438.8 441.0 17622.5 17935.7 18530.5 18572.2 18857.0 15566.1 15681.5 15886.4 16213.0 16340.9 5391.4 5483.5 5537.4 5665.7 5779.2 5668.8 5750.9 5760.7 5768.2 5770.2 5533.8 5665.5 5711.8 5720.1 5749.6 5728.1 5731.8 5762.9 5768.9 5770.4 5049.9 5196.7 5198.4 5231.2 5238.4 21488.0 21979.7 22271.8 22408.4 22525.4 1552.3 1562.9 1566.8 1567.0 1586.1 13161.6 13405.9 13685.2 14014.4 14686.9 1725.7 1753.5 1795.6 1811.6 1821.8 84540.6 85474.0 85783.0 87422.6 88236.0 10474.5 10651.5 10742.2 11186.7 11345.7 15152.2 15182.8 15202.3 15212.7 15239.4 6739.0 6848.8 7006.4 7085.3 7109.4 6165.5 6185.9 6357.0 6362.3 6363.8 6826.1 6992.3 7023.8 7034.0 7051.4 2046.7 2065.9 2069.3 2092.6 2231.1 844.5 866.7 880.2 887.0 897.0 16139.4 16197.4 16402.1 16522.7 17084.1 864.8 866.7 868.6 874.3 880.5 9131.6 9154.3 9156.0 9286.7 9396.9 435510.7 437434.0 443831.0 443833.0 446643.0 80774.0 81353.0 81534.6 81614.2 82126.6 1050.7 1097.2 1119.4 1137.9 1140.6 16507.0 16864.0 17149.1 17173.4 17639.5 43670.3 43754.3 43801.3 43879.0 44282.8 53711.5 54093.7 55431.4 56038.4 56165.0 7912.8 7950.8 8002.4 8225.1 8406.0 11665.1 11677.0 11790.5 11847.8 12309.5 10564.2 10891.9 10892.1 11073.4 11298.5 9757.5 10047.4 10056.5 10184.1 10580.6 10941.5 11053.8 11133.2 11515.3 11677.2 8103.0 8186.7 8324.0 8327.3 8410.6 10600.6 10970.8 11420.0 11431.9 11542.0 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#3] mootools.html Cycles:180 Average:6177.46 Median:3813.67 stddev:3929.15 (103.0%) stddev-sans-first:3922.75 12:09:12 INFO - PID 14687 | Values: 1253.6 1306.3 1306.3 1322.4 1333.1 9530.0 9921.8 9933.9 9935.8 10245.1 10024.0 10153.8 10204.4 10206.9 10208.8 2119.4 2157.0 2161.8 2162.4 2171.3 2179.4 2218.3 2240.5 2290.3 2295.6 2193.5 2265.2 2266.2 2282.8 2283.6 2154.7 2246.9 2256.4 2263.0 2263.4 2186.8 2211.5 2217.2 2249.2 2303.1 10006.8 10081.8 10096.5 10097.2 10097.3 5072.4 5268.2 5270.6 5272.1 5277.5 3184.0 3255.7 3306.0 3350.7 3359.5 1039.0 1042.9 1047.7 1072.6 1088.5 14471.0 14494.3 14568.0 14576.6 14583.6 4713.2 4749.6 4750.0 4831.5 4906.4 10788.6 10840.9 10866.3 10887.2 10889.3 5152.6 5153.9 5173.5 5190.4 5207.2 4478.4 4689.0 4718.5 4727.0 4727.1 3806.5 3859.9 3870.7 3943.8 3946.9 1136.9 1158.6 1159.8 1167.7 1172.4 668.3 672.4 686.3 692.6 697.4 5782.3 5836.6 5980.9 6056.2 6092.1 799.5 801.5 817.9 840.3 841.0 3419.5 3591.6 3765.1 3797.1 3820.8 12596.6 12914.2 12957.6 13016.6 13066.9 12430.4 12840.6 12869.1 12888.4 12988.9 9247.1 9430.7 9440.8 9443.0 9470.6 5820.4 5951.9 6026.6 6264.8 6286.3 11348.4 11351.2 11372.0 11507.3 11540.0 11258.8 11733.9 11804.7 11835.8 11883.7 8154.7 8319.5 8325.2 8386.9 8395.0 8928.7 8972.3 8973.0 9089.1 9152.5 7480.4 7561.6 7615.2 7621.4 7855.3 7744.1 7749.0 7765.4 7938.6 8052.4 6431.4 6523.4 6550.2 6569.9 6588.3 4959.3 5049.1 5211.3 5211.9 5292.1 5148.8 5163.5 5213.0 5237.9 5294.9 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#4] prototype.html Cycles:180 Average:4869.78 Median:5530.49 stddev:1406.91 (25.4%) stddev-sans-first:1370.30 12:09:12 INFO - PID 14687 | Values: 401.5 401.6 403.2 404.6 417.8 5605.9 5647.5 5658.8 5665.3 5666.6 5441.3 5539.2 5548.6 5572.2 5586.9 4436.9 4445.4 4446.0 4447.2 4463.0 4462.6 4467.2 4475.4 4482.7 4493.8 4351.7 4390.5 4414.8 4446.4 4452.3 4356.9 4390.4 4393.5 4401.3 4420.7 3964.2 3984.0 3990.6 4001.5 4008.2 5263.9 5424.5 5460.8 5461.4 5464.0 5118.1 5125.7 5127.8 5134.2 5137.4 5832.3 5832.8 5845.6 5846.3 5920.6 3914.8 4090.9 4098.6 4101.2 4396.1 5958.7 6121.1 6168.9 6179.9 6181.0 4148.8 4194.9 4204.9 4213.5 4213.5 4235.6 4255.4 4259.7 4267.4 4277.5 4674.1 4885.5 4893.5 4907.9 4909.5 5821.2 5853.3 5854.2 5867.3 5888.7 1472.6 1484.9 1487.0 1489.8 1490.7 955.1 1005.4 1010.5 1014.9 1020.6 5008.6 5009.0 5009.6 5010.7 5011.5 6002.1 6040.5 6050.4 6070.5 6087.4 4798.1 4951.5 4957.9 4981.0 4984.8 3190.2 3215.9 3223.0 3229.7 3235.3 5621.2 5636.2 5644.5 5655.1 5655.2 5899.3 6229.2 6250.4 6262.5 6264.2 5647.9 5662.5 5664.1 5683.9 5689.0 5867.5 6048.9 6079.4 6085.4 6115.1 6009.6 6017.8 6032.0 6035.2 6051.8 5521.8 5615.4 5629.9 5679.9 5690.5 4224.4 4250.2 4252.0 4256.7 4271.6 5952.2 6068.1 6085.5 6099.7 6130.0 5798.8 5817.7 5834.9 5841.2 5850.2 5803.4 5831.6 5837.0 5848.4 5854.3 5583.9 5737.9 5746.2 5758.3 5761.9 5899.0 5906.8 5908.4 5921.8 5927.0 5559.6 5702.6 5729.6 5731.3 5752.1 12:09:12 INFO - PID 14687 | 12:09:12 INFO - PID 14687 | [#5] yui.html Cycles:180 Average:13624.37 Median:470.11 stddev:16901.78 (3595.3%) stddev-sans-first:16920.90 12:09:12 INFO - PID 14687 | Values: 600.7 602.5 604.3 615.6 620.9 11334.5 11374.7 11680.0 11808.5 11827.3 12075.5 12100.2 12144.0 12212.7 12213.2 874.0 893.3 894.7 898.7 926.0 929.3 935.9 938.9 939.8 941.1 943.5 952.5 953.0 953.2 954.8 942.6 944.0 946.4 948.1 949.0 689.2 692.8 699.8 700.0 700.1 11848.1 12046.0 12101.3 12108.2 12151.8 13228.3 13828.8 14032.9 14209.0 14308.5 9459.1 9604.5 9765.2 9908.4 10232.7 2256.9 2278.1 2302.2 2327.2 2342.1 59318.0 60545.7 60814.0 60898.0 61867.0 10213.7 10282.1 10301.8 10516.4 10572.5 20838.8 20839.4 20901.3 21041.2 21089.5 5706.1 5732.6 5766.6 5793.5 5958.4 2902.6 2991.8 3017.2 3036.5 3094.1 3297.2 3347.9 3350.1 3387.8 3410.6 588.8 589.1 603.2 611.0 611.2 465.6 478.6 480.6 492.3 500.2 7118.3 7250.9 7289.4 7573.2 7582.8 474.6 484.1 488.4 492.1 496.6 3180.7 3239.1 3248.5 3251.3 3335.9 60209.7 60473.0 61285.0 63378.4 63852.7 51365.5 52622.7 52716.0 53245.5 53506.0 43842.3 44932.3 44940.1 45364.3 47685.0 8471.0 8760.9 8927.6 8931.6 9114.9 23591.5 24104.6 24165.5 24206.9 24954.5 40682.2 41197.6 41391.2 41821.8 43910.6 10247.2 10311.3 10339.5 10388.6 10470.8 11184.3 11401.9 11526.3 11754.8 11767.5 10131.4 10210.7 10384.8 10435.6 10732.5 10537.3 10633.7 11203.4 11622.1 11629.2 10565.8 10710.8 10941.1 11186.9 11582.3 8526.5 8631.2 8635.8 8646.0 8929.0 9349.4 9402.3 9549.1 9553.1 9559.0 12:09:12 INFO - PID 14687 | -------- Summary: end -------- 12:09:12 INFO - PID 14687 | 12:09:13 INFO - TEST-INFO | 14687: exit 0 12:09:13 INFO - TEST-OK | dromaeo_css | took 1121035ms 12:09:13 INFO - TEST-START | kraken 12:09:13 INFO - operating with platform_type : linux_ 12:09:13 INFO - Initialising browser for kraken test... 12:09:13 INFO - TEST-INFO | started process 15063 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0fbPz/profile http://localhost:34343/getInfo.html) 12:09:17 INFO - PID 15063 | __metrics Screen width/height:1600/1200 12:09:17 INFO - PID 15063 | colorDepth:24 12:09:17 INFO - PID 15063 | Browser inner width/height: 1024/697 12:09:17 INFO - PID 15063 | __metrics 12:09:17 ERROR - PID 15063 | 1490814557877 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6376:36 < canClose@browser.js:5227:12 < forceQuit@jar:file:///tmp/tmpV0fbPz/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpV0fbPz/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpV0fbPz/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpV0fbPz/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:09:17 ERROR - PID 15063 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 12:09:18 INFO - TEST-INFO | 15063: exit 0 12:09:18 INFO - Browser initialized. 12:09:18 INFO - Running cycle 1/1 for kraken test... 12:09:18 INFO - TEST-INFO | started process 15195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV0fbPz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:31 INFO - PID 15195 | RSS: Main: 156241920 12:09:31 INFO - PID 15195 | 12:09:33 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34343/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:34 INFO - PID 15195 | RSS: Main: 162910208 12:09:34 INFO - PID 15195 | 12:09:37 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34343/tests/kraken/driver.html?testName=audio-dft) 12:09:38 INFO - PID 15195 | RSS: Main: 161333248 12:09:38 INFO - PID 15195 | 12:09:41 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34343/tests/kraken/driver.html?testName=audio-fft) 12:09:41 INFO - PID 15195 | RSS: Main: 157814784 12:09:41 INFO - PID 15195 | 12:09:43 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34343/tests/kraken/driver.html?testName=audio-oscillator) 12:09:44 INFO - PID 15195 | RSS: Main: 158601216 12:09:44 INFO - PID 15195 | 12:09:46 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:47 INFO - PID 15195 | RSS: Main: 158883840 12:09:47 INFO - PID 15195 | 12:09:50 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34343/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:51 INFO - PID 15195 | RSS: Main: 163504128 12:09:51 INFO - PID 15195 | 12:09:54 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34343/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:55 INFO - PID 15195 | RSS: Main: 161386496 12:09:55 INFO - PID 15195 | 12:09:58 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34343/tests/kraken/driver.html?testName=json-parse-financial) 12:09:58 INFO - PID 15195 | RSS: Main: 162574336 12:09:58 INFO - PID 15195 | 12:10:00 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:01 INFO - PID 15195 | RSS: Main: 163287040 12:10:01 INFO - PID 15195 | 12:10:03 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:03 INFO - PID 15195 | RSS: Main: 163233792 12:10:03 INFO - PID 15195 | 12:10:05 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:06 INFO - PID 15195 | RSS: Main: 163409920 12:10:06 INFO - PID 15195 | 12:10:09 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:10 INFO - PID 15195 | RSS: Main: 163938304 12:10:10 INFO - PID 15195 | 12:10:13 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:14 INFO - PID 15195 | RSS: Main: 163495936 12:10:14 INFO - PID 15195 | 12:10:15 INFO - PID 15195 | Cycle 1(1): loaded http://localhost:34343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34343/tests/kraken/driver.html?testName=ai-astar) 12:10:16 INFO - PID 15195 | RSS: Main: 165154816 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | __start_tp_report 12:10:16 INFO - PID 15195 | _x_x_mozilla_page_load 12:10:16 INFO - PID 15195 | _x_x_mozilla_page_load_details 12:10:16 INFO - PID 15195 | |i|pagename|runs| 12:10:16 INFO - PID 15195 | |0;ai-astar;103;113;112;115;113;112;112;113;111;112 12:10:16 INFO - PID 15195 | |1;audio-beat-detection;151;126;126;162;128;127;126;125;144;127 12:10:16 INFO - PID 15195 | |2;audio-dft;166;166;166;169;172;173;166;165;166;166 12:10:16 INFO - PID 15195 | |3;audio-fft;75;74;76;115;77;76;78;77;96;76 12:10:16 INFO - PID 15195 | |4;audio-oscillator;85;85;115;85;85;86;99;87;86;106 12:10:16 INFO - PID 15195 | |5;imaging-gaussian-blur;115;114;115;116;116;115;114;114;114;114 12:10:16 INFO - PID 15195 | |6;imaging-darkroom;151;152;153;152;151;151;153;151;152;153 12:10:16 INFO - PID 15195 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;95;95 12:10:16 INFO - PID 15195 | |8;json-parse-financial;71;70;71;71;74;71;79;74;73;72 12:10:16 INFO - PID 15195 | |9;json-stringify-tinderbox;55;54;55;55;56;55;56;56;55;55 12:10:16 INFO - PID 15195 | |10;stanford-crypto-aes;85;84;92;91;83;85;85;85;84;82 12:10:16 INFO - PID 15195 | |11;stanford-crypto-ccm;144;154;144;135;134;136;135;138;195;134 12:10:16 INFO - PID 15195 | |12;stanford-crypto-pbkdf2;191;197;195;196;201;200;197;195;196;198 12:10:16 INFO - PID 15195 | |13;stanford-crypto-sha256-iterative;72;74;72;73;75;72;71;72;73;72 12:10:16 INFO - PID 15195 | __end_tp_report 12:10:16 INFO - PID 15195 | __start_cc_report 12:10:16 INFO - PID 15195 | _x_x_mozilla_cycle_collect,893 12:10:16 INFO - PID 15195 | __end_cc_report 12:10:16 INFO - PID 15195 | __startTimestamp1490814616210__endTimestamp 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | ------- Summary: start ------- 12:10:16 INFO - PID 15195 | Number of tests: 14 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.20 (2.8%) stddev-sans-first:1.13 12:10:16 INFO - PID 15195 | Values: 103.0 113.0 112.0 115.0 113.0 112.0 112.0 113.0 111.0 112.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:127.50 stddev:13.25 (10.4%) stddev-sans-first:12.58 12:10:16 INFO - PID 15195 | Values: 151.0 126.0 126.0 162.0 128.0 127.0 126.0 125.0 144.0 127.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#2] audio-dft Cycles:10 Average:167.50 Median:166.00 stddev:2.84 (1.7%) stddev-sans-first:2.96 12:10:16 INFO - PID 15195 | Values: 166.0 166.0 166.0 169.0 172.0 173.0 166.0 165.0 166.0 166.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.50 stddev:13.22 (17.3%) stddev-sans-first:13.77 12:10:16 INFO - PID 15195 | Values: 75.0 74.0 76.0 115.0 77.0 76.0 78.0 77.0 96.0 76.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:85.50 stddev:10.89 (12.7%) stddev-sans-first:11.26 12:10:16 INFO - PID 15195 | Values: 85.0 85.0 115.0 85.0 85.0 86.0 99.0 87.0 86.0 106.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 12:10:16 INFO - PID 15195 | Values: 115.0 114.0 115.0 116.0 116.0 115.0 114.0 114.0 114.0 114.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 12:10:16 INFO - PID 15195 | Values: 151.0 152.0 153.0 152.0 151.0 151.0 153.0 151.0 152.0 153.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:10:16 INFO - PID 15195 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.50 stddev:2.63 (3.6%) stddev-sans-first:2.73 12:10:16 INFO - PID 15195 | Values: 71.0 70.0 71.0 71.0 74.0 71.0 79.0 74.0 73.0 72.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 12:10:16 INFO - PID 15195 | Values: 55.0 54.0 55.0 55.0 56.0 55.0 56.0 56.0 55.0 55.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:3.27 (3.9%) stddev-sans-first:3.46 12:10:16 INFO - PID 15195 | Values: 85.0 84.0 92.0 91.0 83.0 85.0 85.0 85.0 84.0 82.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:141.00 stddev:18.72 (13.3%) stddev-sans-first:19.86 12:10:16 INFO - PID 15195 | Values: 144.0 154.0 144.0 135.0 134.0 136.0 135.0 138.0 195.0 134.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.60 Median:197.00 stddev:2.80 (1.4%) stddev-sans-first:2.11 12:10:16 INFO - PID 15195 | Values: 191.0 197.0 195.0 196.0 201.0 200.0 197.0 195.0 196.0 198.0 12:10:16 INFO - PID 15195 | 12:10:16 INFO - PID 15195 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:72.50 stddev:1.17 (1.6%) stddev-sans-first:1.22 12:10:16 INFO - PID 15195 | Values: 72.0 74.0 72.0 73.0 75.0 72.0 71.0 72.0 73.0 72.0 12:10:16 INFO - PID 15195 | -------- Summary: end -------- 12:10:16 INFO - PID 15195 | 12:10:17 INFO - TEST-INFO | 15195: exit 0 12:10:17 INFO - TEST-OK | kraken | took 64203ms 12:10:17 INFO - SUITE-END | took 1185s 12:10:17 INFO - Completed test suite (00:19:45) 12:10:17 INFO - javascript benchmark 12:10:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6640.192369007655, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.9320766980823, 2738.082742281336, 2750.174947515745, 2772.2237773423435, 2773.7226277372265, 5255.605829562788, 5414.702191379478, 5423.999999999995, 5443.237946687467, 5455.836324910254, 5357.8392648220615, 5377.139657654776, 5401.594880383967, 5481.835544933649, 5497.038018346783, 4923.926141107877, 4950.405951285851, 4957.206846904496, 4968.080905032581, 5001.6998980061135, 4933.136701077315, 4985.40175178979, 5026.623003274751, 5033.723145227011, 5034.219695947116, 4784.40194975628, 4829.7102173869325, 4865.586425153866, 4910.950890491085, 4960.975195124038, 4917.72952487613, 4940.802367905279, 4960.70235785854, 4984.6261530385, 4988.176950803113, 4858.271259311132, 4860.270959356089, 4874.195757699975, 4895.681780684244, 4959.82640607577, 5142.820001299937, 5225.059489291926, 5385.192221166817, 5386.757595908193, 5416.674999500043, 5839.532837373, 5867.266591676041, 5916.112583112525, 5918.763249470016, 5925.555583331225, 5903.3801450847905, 5913.46778789911, 5920.348761636216, 5921.61509501881, 5921.8815623687715, 5267.104592219255, 5459.426760190202, 5480.972595136999, 5482.533984611353, 5483.4516548344845, 5896.1450589664255, 5985.790497332572, 6016.1878146450545, 6056.697165141725, 6081.543884208702, 5515.696636685021, 5596.496315331639, 5720.2849643794525, 5775.509081728016, 5802.419758024248, 5873.177755114288, 5887.234659494238, 5891.293044834647, 5895.675737834375, 5928.051511758098, 5829.183914252008, 5836.1245813127525, 5840.795572154954, 5859.384764599741, 5872.823815285548, 5588.0, 5689.231953686282, 5691.715414229272, 5692.975264452439, 5821.09772985188, 4754.857354279377, 4774.21225497789, 4777.402824646919, 4783.569478746929, 4784.521547845257, 4120.835166593302, 4121.8969525762095, 4128.112455821953, 4132.834686612562, 4136.627703506639, 4754.953910139764, 4760.357351757538, 4762.190427627312, 4762.64280178988, 4781.426228852491, 5667.404922483162, 5716.142578613241, 5723.7996670116345, 5725.77096916127, 5732.570057245724, 4767.237242041257, 4767.998720268783, 4768.546988036131, 4769.998300356894, 4773.307870358848, 5102.948970510248, 5106.310648062464, 5124.9743751281, 5134.0, 5146.665466744649, 5426.538744206708, 5446.918296225639, 5463.289772329572, 5472.616916815785, 5515.4760297771645, 5607.579431542732, 5668.518175954925, 5844.590878638624, 5871.089981052944, 5872.412758724094, 5313.54834839043, 5347.652402593819, 5353.089974704231, 5359.598030147677, 5369.865753356197, 5677.716114194356, 5750.5112065474905, 5821.301443826768, 5848.64908105515, 5858.150568167506, 5736.663320856613, 5843.474087332161, 5846.853828654318, 5850.619709718854, 5852.502537284378, 5628.183913332626, 5632.5212356950115, 5643.576731745217, 5643.71781410936, 5645.491905728504, 5402.729863506887, 5506.64206826555, 5610.410906854721, 5614.382417933943, 5670.631408958405, 5572.86067848307, 5576.10782274834, 5580.832575022756, 5583.69289689071, 5590.888182236414, 5673.801416950387, 5697.686627235542, 5715.057015592381, 5716.685582293014, 5717.199592057199, 5354.812581559627, 5420.53925416344, 5520.834374968757, 5525.972370138124, 5561.888762224814], "value": 5267.359160414674, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.1398611873971, 689.6758523493958, 710.8684893294741, 1079.8650168728914, 1091.0889407344866, 32693.67306326936, 33636.663633363656, 33751.49372759405, 33762.831185844065, 33794.15514612136, 35441.468377974285, 35959.82020089903, 35994.8200258999, 36002.27995440096, 36200.27599448009, 7435.367993720541, 7557.92442075579, 7656.042994625672, 7681.8079548011465, 7685.385169186479, 7581.279778421069, 7693.30760231579, 7699.153093159748, 7701.383889288872, 7701.499402538817, 7671.194524574895, 7675.616219189018, 7723.0, 7739.032620922385, 7739.458237923348, 7642.541447513167, 7686.961565192139, 7688.616049111158, 7696.769096927129, 7716.189800070968, 7464.925350746477, 7525.887111693329, 7530.736424225126, 7535.472516923817, 7539.208383119803, 36042.09894752626, 36149.27701445956, 36281.81859090714, 36318.0, 36319.4552081719, 2342.8360014798973, 2371.4071482129466, 2398.6282126270457, 2648.735126487336, 2752.2844060544203, 23359.7664023361, 23382.883085584464, 23424.18015369454, 24028.27915162548, 24382.756172438225, 2510.221831232324, 2532.987335063331, 2541.542522345977, 2553.438243586408, 2565.2432532402986, 129901.0, 130531.34734326362, 155989.0, 158191.0, 158534.0, 41739.791301043304, 41774.0, 41774.79112604478, 41820.0, 41887.27732697365, 43640.563594364285, 43693.78153109214, 43821.78089109534, 43857.122857543305, 43939.34090988638, 10581.89418105809, 10681.946590266998, 10691.946540267249, 10701.19741019411, 10739.677809665722, 8246.09292977772, 8260.752177434686, 8292.12932642064, 8326.0, 8335.916640833635, 13544.59366219015, 13559.796603050961, 13613.251271179983, 13663.726725465434, 13774.311284435738, 5561.888762224814, 5655.0, 5680.914786278209, 5702.087665973424, 5830.4461076197695, 853.4154104438479, 887.7039522297518, 888.4225253585221, 893.9687110951086, 929.6839074714629, 20520.0, 21800.781992180193, 21946.670799938012, 21950.560988780137, 22368.888155559445, 943.3962264150949, 960.519740129935, 967.7338731848657, 972.6595691507915, 987.274353350287, 11113.44432778374, 11497.080233581293, 11628.6511404658, 11641.59254426091, 11645.88354116448, 242374.0, 242848.0, 244705.0, 245094.0, 245169.0, 43531.0, 43856.12287754227, 44081.338779918326, 44168.0, 44315.55684443114, 1150.9712257193637, 1214.6659668591208, 1218.1533833985295, 1218.8963938065187, 1227.5887577661583, 20052.0, 20632.17471301191, 20943.162273509497, 21619.459513512287, 22025.0, 31896.36207275795, 31916.5212521817, 32026.83986580052, 32027.83986080055, 32058.519122212718, 212782.0, 213515.0, 213579.0, 213766.0, 214075.0, 29505.409891802472, 29593.40813183681, 30693.53959690562, 30697.53953690741, 30699.2325191872, 36078.27843443169, 36472.63527364693, 37082.0, 37446.0, 37673.246535069695, 27820.0, 27846.16461506158, 27923.301917452227, 28108.43783124367, 29193.0, 27758.861205693844, 27931.0, 27962.0, 29201.0, 29278.7072129276, 30813.075607731804, 31286.217844554067, 31305.37389252248, 31747.52378714275, 31846.0, 25805.6129158059, 26702.93188272525, 27936.580951286152, 27945.301367465978, 28590.285242868264, 20897.791022090194, 22803.88598056999, 22915.54168916579, 23038.0, 23131.4217144566], "value": 14931.491535693689, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.53364964415033, 417.56816255805467, 429.94410726605525, 438.83982346443554, 440.96031357177867, 17622.471325860213, 17935.73096403555, 18530.53673658159, 18572.164252608633, 18857.0, 15566.143862087582, 15681.451149209779, 15886.364545418199, 16213.027218366877, 16340.918295408535, 5391.353037635479, 5483.479069488392, 5537.446255374471, 5665.745041473144, 5779.190913272145, 5668.829935101953, 5750.856228594277, 5760.711964401763, 5768.221290125843, 5770.163326317682, 5533.833984980437, 5665.518430933375, 5711.7715291388295, 5720.056190728525, 5749.59752817303, 5728.14077888318, 5731.828045158611, 5762.9135562966585, 5768.942310576904, 5770.365259821417, 5049.949500504985, 5196.740162991835, 5198.376194856642, 5231.215317702337, 5238.449962753894, 21488.033038513306, 21979.670304945437, 22271.770593263886, 22408.439789005242, 22525.436864078365, 1552.285948463708, 1562.9452969146025, 1566.8119825621, 1566.9764953525707, 1586.0562965035786, 13161.605151845364, 13405.865941340558, 13685.247311397969, 14014.369353379021, 14686.90493445219, 1725.6548690261873, 1753.465193116099, 1795.6318954614273, 1811.6195598924241, 1821.7719609847136, 84540.57729711373, 85474.0, 85783.0, 87422.56288718579, 88235.99999999936, 10474.47627618616, 10651.467426628793, 10742.248042637097, 11186.720331991766, 11345.716357090974, 15152.166630835189, 15182.848171518364, 15202.315895784715, 15212.695746085237, 15239.3904243829, 6738.966305168443, 6848.828779280459, 7006.369426751617, 7085.326893945067, 7109.360157585842, 6165.475934545614, 6185.907211391833, 6357.0, 6362.300146983828, 6363.809085727436, 6826.133024129877, 6992.259141359348, 7023.8244043898285, 7033.964830175919, 7051.400630946427, 2046.6827641715558, 2065.8863762493206, 2069.286096296805, 2092.62332780098, 2231.129859354853, 844.5355054720002, 866.7183165471121, 880.2188652313451, 886.9733907982771, 896.950667713269, 16139.35442582307, 16197.352105915867, 16402.09788461646, 16522.695460907627, 17084.145792710315, 864.7578677970179, 866.7486428935538, 868.6004437958484, 874.3005595523556, 880.5157163560017, 9131.634734610541, 9154.26765858743, 9155.992840787509, 9286.72139835806, 9396.859047114298, 435510.73871135665, 437434.0, 443831.0, 443833.0, 446643.0, 80773.96130193467, 81353.0, 81534.59232703799, 81614.18385816185, 82126.58936705279, 1050.6900464363032, 1097.1661537231762, 1119.4011204005817, 1137.9146564007733, 1140.5665846978095, 16507.0, 16864.0, 17149.142542873054, 17173.398931037354, 17639.470815875546, 43670.344944825214, 43754.34368484539, 43801.34297985597, 43879.0, 44282.77858610686, 53711.46288537221, 54093.72953135209, 55431.445685542625, 56038.439615604955, 56165.0, 7912.84174316522, 7950.840983180419, 8002.359811215205, 8225.136360682282, 8405.991281046314, 11665.125115616533, 11677.0, 11790.469428875549, 11847.822282665595, 12309.507619695112, 10564.15486761042, 10891.945540272249, 10892.077853340974, 11073.446327683745, 11298.49156787963, 9757.512124393894, 10047.447390393598, 10056.547455364673, 10184.083432491112, 10580.629677961235, 10941.507632156412, 11053.778924421305, 11133.220674552704, 11515.30908145514, 11677.240979336317, 8103.0, 8186.713465028695, 8323.95838020806, 8327.250547450758, 8410.579471026547, 10600.575976960836, 10970.780584388427, 11419.972202501815, 11431.885681143081, 11542.0], "value": 8827.83101811525, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1253.6051143889674, 1306.3011288960402, 1306.314185052847, 1322.4181360201505, 1333.1134795361088, 9530.0, 9921.801563968726, 9933.850992235113, 9935.751606209848, 10245.12916402105, 10024.0, 10153.847692284622, 10204.438755868425, 10206.948965255164, 10208.846867296996, 2119.395972147934, 2157.0, 2161.8270538356974, 2162.372911855568, 2171.283476452767, 2179.3570896585547, 2218.3344996500987, 2240.529488807352, 2290.278562252893, 2295.552367288371, 2193.4954960359128, 2265.2071774878827, 2266.172846910882, 2282.8173746100356, 2283.577538155438, 2154.6983422320886, 2246.86518808872, 2256.4133325335447, 2263.0, 2263.4228271790753, 2186.835987300959, 2211.5245222277126, 2217.1796435319034, 2249.246502421691, 2303.124812571229, 10006.79986400268, 10081.848772268422, 10096.545655445523, 10097.192224622013, 10097.343672661253, 5072.416672082721, 5268.236105764643, 5270.631055826094, 5272.051030814452, 5277.525022747971, 3183.984080079608, 3255.7395408367274, 3306.041248038066, 3350.731941444679, 3359.5128706337446, 1039.0, 1042.9113525350353, 1047.748540350318, 1072.6031368393744, 1088.542812018946, 14471.0, 14494.260688717315, 14567.980241383108, 14576.562703118923, 14583.56249312533, 4713.19283641582, 4749.62003039756, 4749.952500474951, 4831.492693267156, 4906.362172917569, 10788.56845726178, 10840.891591084146, 10866.348019118721, 10887.183461240438, 10889.292196007234, 5152.639315247897, 5153.948460515422, 5173.482651734872, 5190.403103643054, 5207.218917162456, 4478.39541661878, 4689.0, 4718.457377401643, 4726.952730472652, 4727.078219747116, 3806.5447786178315, 3859.9421008684894, 3870.6903447724117, 3943.7830919299713, 3946.9210615787524, 1136.9317840929405, 1158.623447379605, 1159.756451145252, 1167.737259116692, 1172.4313707851686, 668.2949488289901, 672.414998950906, 686.2691233835949, 692.6190595172735, 697.4141720954423, 5782.335031471434, 5836.591438599257, 5980.85047873798, 6056.152138700585, 6092.058886578982, 799.5122974985254, 801.527099011586, 817.9100298967109, 840.3319361107934, 841.0286119531951, 3419.452887537982, 3591.5510561179854, 3765.1151979284846, 3797.088698712289, 3820.7898565578603, 12596.55912043074, 12914.22514649124, 12957.611271661865, 13016.609501714964, 13066.934665326802, 12430.37848107591, 12840.550580729816, 12869.099163058496, 12888.420021099073, 12988.935055324851, 9247.12152345526, 9430.717078487656, 9440.763980900532, 9442.95278523603, 9470.626759119888, 5820.359760426434, 5951.880962380642, 6026.608270462406, 6264.843378915563, 6286.277078136073, 11348.432578370883, 11351.205415620827, 11372.0, 11507.252028618113, 11540.0, 11258.817824128677, 11733.941330293294, 11804.70488237801, 11835.822462662894, 11883.702907427383, 8154.673813047411, 8319.542425166674, 8325.16748325187, 8386.916130838857, 8395.0, 8928.687495937871, 8972.28221742246, 8973.0, 9089.136532029446, 9152.542372881197, 7480.3641690456925, 7561.584112873845, 7615.200403957726, 7621.352185064332, 7855.293023627901, 7744.070711514654, 7749.0, 7765.41759368061, 7938.563379013978, 8052.436329456882, 6431.421172094534, 6523.445507131947, 6550.181227346582, 6569.901451478136, 6588.341165883565, 4959.256111583291, 5049.065922804293, 5211.348581427322, 5211.869703257449, 5292.126799078109, 5148.794048238028, 5163.535281824504, 5212.9739351303, 5237.895242095061, 5294.867628309323], "value": 4677.84891426297, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.5201833808598, 401.5743312089186, 403.1936127744511, 404.583279222401, 417.75352542000235, 5605.915911261329, 5647.548196144309, 5658.8019419320335, 5665.348484924235, 5666.57500687448, 5441.347038355403, 5539.224508568804, 5548.55611551076, 5572.247746554214, 5586.91619625706, 4436.933445998313, 4445.444319460067, 4446.0, 4447.243968525342, 4463.040446304044, 4462.642988560908, 4467.218236808561, 4475.373447717306, 4482.708623939449, 4493.820247190125, 4351.6518678505645, 4390.517043125254, 4414.80133393998, 4446.3997360356425, 4452.287633978564, 4356.891077723082, 4390.363397307405, 4393.538678438782, 4401.3397990301555, 4420.668449866257, 3964.187341594995, 3983.960160398417, 3990.5809889961715, 4001.4998125234347, 4008.2384346974272, 5263.8682683222905, 5424.484673955968, 5460.754266058037, 5461.371942226655, 5463.972680136574, 5118.131881863131, 5125.692948298198, 5127.8205262816, 5134.152864777345, 5137.357830271216, 5832.300123985149, 5832.766689332421, 5845.649261044351, 5846.269216347957, 5920.585559010871, 3914.7846868422225, 4090.8568200112854, 4098.631123198897, 4101.179764047172, 4396.120775844844, 5958.702064896738, 6121.1024582379605, 6168.87662246757, 6179.938200617981, 6181.041938499495, 4148.834046638161, 4194.937075943863, 4204.873853784391, 4213.536510983789, 4213.536510983789, 4235.555266697014, 4255.382969469471, 4259.680523960716, 4267.402563641031, 4277.529471758104, 4674.135284972291, 4885.511448855086, 4893.4617192108835, 4907.9263811042865, 4909.533594308535, 5821.2141360916585, 5853.268341457318, 5854.209681692917, 5867.301041520863, 5888.705564721747, 1472.5582325302366, 1484.92575371231, 1487.0, 1489.7839813227022, 1490.6720521485256, 955.1356022799378, 1005.3565717940523, 1010.5301035018751, 1014.9238807089498, 1020.6223697232072, 5008.624353173526, 5008.974955125201, 5009.599232061426, 5010.724410157403, 5011.52390522907, 6002.0996850472775, 6040.459682780863, 6050.364711705296, 6070.544709146743, 6087.391260873877, 4798.136335459651, 4951.480094590088, 4957.876053098629, 4980.950190498121, 4984.828565287155, 3190.202449387653, 3215.903522894317, 3222.9838850806063, 3229.7416206703406, 3235.320582677617, 5621.18492818539, 5636.154576813511, 5644.491995720405, 5655.123455864347, 5655.236543066633, 5899.321578018497, 6229.190205273286, 6250.4374606285655, 6262.4577249134845, 6264.21697287839, 5647.943520564824, 5662.518685911744, 5664.0937450007805, 5683.857903552444, 5688.971555142198, 5867.474456641389, 6048.879022419615, 6079.422454866781, 6085.421884920926, 6115.143879856734, 6009.639421634716, 6017.789377371771, 6031.969840150771, 6035.185249991195, 6051.788187413419, 5521.751521181476, 5615.438456154516, 5629.943700562942, 5679.9148012779015, 5690.5163061140265, 4224.408582798472, 4250.234957707518, 4251.95748042528, 4256.723312984646, 4271.615554600101, 5952.214335699359, 6068.120122582289, 6085.509050282709, 6099.725512351866, 6129.957907155884, 5798.768049277982, 5817.738201781015, 5834.94165058344, 5841.240638716939, 5850.151727999501, 5803.390643982321, 5831.620944638585, 5837.0368889132815, 5848.356680765028, 5854.336276993872, 5583.888322233452, 5737.8565535861935, 5746.195532625352, 5758.280214973129, 5761.913571296518, 5899.023827017997, 5906.793262235801, 5908.438698323653, 5921.763129474945, 5926.970365148147, 5559.583031272751, 5702.6293290935955, 5729.570282228766, 5731.340895797037, 5752.108423194411], "value": 4438.568518238095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.678636929243, 602.484875431506, 604.3352312456296, 615.6275453350722, 620.9410106039925, 11334.546618135275, 11374.658760237206, 11680.0, 11808.527658893645, 11827.290362578251, 12075.456604452798, 12100.152989290731, 12144.0, 12212.694682632939, 12213.20614160079, 873.9563021848898, 893.3300024981264, 894.6734441928681, 898.703427868805, 926.0276709455079, 929.2751653710117, 935.8783358163429, 938.9014153513886, 939.8026414452974, 941.1106504353389, 943.5329511891623, 952.5332587032374, 952.9523523823781, 953.2421724728822, 954.7947191353858, 942.6229508196708, 944.0465130218461, 946.3895787217207, 948.1229862377343, 949.0462085603958, 689.1592257445908, 692.8094773937157, 699.7795694356262, 699.9545029573112, 700.1178515071047, 11848.111391645662, 12046.0, 12101.334426606532, 12108.21296615717, 12151.817722734166, 13228.338583070808, 13828.792568111487, 14032.859671403257, 14209.0, 14308.499202527966, 9459.148676619137, 9604.471754053524, 9765.218782497454, 9908.405495670282, 10232.69301920936, 2256.9435764105865, 2278.100150440583, 2302.1827251325703, 2327.2203811723093, 2342.0865862313713, 59318.0, 60545.69727151336, 60814.0, 60897.999999999556, 61867.0, 10213.744656383502, 10282.07461328484, 10301.793964120676, 10516.369017858953, 10572.471376431147, 20838.791612083987, 20839.374818755463, 20901.268455604284, 21041.158353665684, 21089.472763181042, 5706.115552089433, 5732.627379220337, 5766.596338256366, 5793.536517078624, 5958.433948774859, 2902.6371703537056, 2991.835449050323, 3017.1853599528004, 3036.4534383810683, 3094.071778466451, 3297.225152089257, 3347.8828241011447, 3350.1289664687356, 3387.8475468603974, 3410.5907291125222, 588.8292395205342, 589.0810335876047, 603.1977469964936, 611.0284647410639, 611.248164757351, 465.62982428969053, 478.5664894013978, 480.6275136769032, 492.27948320619663, 500.15973165082283, 7118.252583478764, 7250.891236631349, 7289.380402665727, 7573.242675732493, 7582.810429739301, 474.5823675165832, 484.1454832221132, 488.42853860982024, 492.0945460352968, 496.5630245384111, 3180.6978337058404, 3239.076863094007, 3248.480243161083, 3251.3009702913987, 3335.933281334408, 60209.698951504964, 60473.0, 61285.0, 63378.36621633817, 63852.68073659602, 51365.48634513607, 52622.736886315324, 52716.0, 53245.46754532483, 53506.0, 43842.342364864555, 44932.3260151098, 44940.101197975855, 45364.319535206996, 47685.0, 8471.0, 8760.861088058511, 8927.598258078531, 8931.629036753966, 9114.908850911406, 23591.528169436173, 24104.638430423205, 24165.51668966646, 24206.878965605058, 24954.500909981336, 40682.18635627212, 41197.58802411937, 41391.1721765557, 41821.79089104535, 43910.56089439192, 10247.180225581786, 10311.278210525192, 10339.534720937425, 10388.636397726043, 10470.759342466314, 11184.273022253528, 11401.885981140415, 11526.250793698382, 11754.823677645014, 11767.52929882795, 10131.442770647685, 10210.693679189637, 10384.844227336445, 10435.582576696846, 10732.51703673321, 10537.262391632512, 10633.734156646145, 11203.383813890314, 11622.128340374675, 11629.24409913353, 10565.841512377167, 10710.785784284426, 10941.07000904932, 11186.944065279622, 11582.305061696325, 8526.488410695378, 8631.238003838711, 8635.784105397415, 8646.0, 8928.955355223183, 9349.439033658002, 9402.34183607141, 9549.140577348073, 9553.140217380469, 9559.0], "value": 5945.832693021691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 112.0, 115.0, 113.0, 112.0, 112.0, 113.0, 111.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 126.0, 162.0, 128.0, 127.0, 126.0, 125.0, 144.0, 127.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 166.0, 169.0, 172.0, 173.0, 166.0, 165.0, 166.0, 166.0], "value": 167.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 115.0, 77.0, 76.0, 78.0, 77.0, 96.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 85.0, 86.0, 99.0, 87.0, 86.0, 106.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 116.0, 116.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 153.0, 152.0, 151.0, 151.0, 153.0, 151.0, 152.0, 153.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 71.0, 74.0, 71.0, 79.0, 74.0, 73.0, 72.0], "value": 72.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 55.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 92.0, 91.0, 83.0, 85.0, 85.0, 85.0, 84.0, 82.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 154.0, 144.0, 135.0, 134.0, 136.0, 135.0, 138.0, 195.0, 134.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 197.0, 195.0, 196.0, 201.0, 200.0, 197.0, 195.0, 196.0, 198.0], "value": 196.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 72.0, 73.0, 75.0, 72.0, 71.0, 72.0, 73.0, 72.0], "value": 72.6, "unit": "score"}]}]} 12:10:17 INFO - Return code: 0 12:10:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:18 ERROR - # TBPL SUCCESS # 12:10:18 INFO - Running post-action listener: _resource_record_post_action 12:10:18 INFO - [mozharness: 2017-03-29 19:10:18.038263Z] Finished run-tests step (success) 12:10:18 INFO - Running post-run listener: _resource_record_post_run 12:10:18 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 367616000; Read time: 16; Write time: 193992 12:10:18 INFO - TinderboxPrint: CPU usage
13.3% 12:10:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 12:10:18 INFO - TinderboxPrint: I/O write bytes / time
367,616,000 / 193,992 12:10:18 INFO - TinderboxPrint: CPU idle
8,314.5 (86.7%) 12:10:18 INFO - TinderboxPrint: CPU user
1,221.8 (12.7%) 12:10:18 INFO - TinderboxPrint: Swap in / out
0 / 0 12:10:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107442176; Read time: 0; Write time: 63372 12:10:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 8192; Write bytes: 260173824; Read time: 16; Write time: 130620 12:10:18 INFO - Running post-run listener: _upload_blobber_files 12:10:18 INFO - Blob upload gear active. 12:10:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:10:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:10:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:10:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:19 INFO - (blobuploader) - INFO - Done attempting. 12:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:20 INFO - (blobuploader) - INFO - Done attempting. 12:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:21 INFO - (blobuploader) - INFO - Done attempting. 12:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:24 INFO - (blobuploader) - INFO - Done attempting. 12:10:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:24 INFO - Return code: 0 12:10:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18d91636a66366fdf288e307f6cb8fbcb2b55c1fd23f69163bd03b16a90bedd914c0cd9fa7cad4d21e975a9e07dc07d42c528b9438c4911983118938e8140114", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11112aca90d67ee1796386c848857915c270e798a17a9e8be10a39e199b762c06c5fd07b23cac2ae41ec53ef42c78b99d3aa43d5c74400cfd9668299243b8316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fa3f6c23fb27b9d4417a459cc21a4adec7564af8c3d23ba072dbbbecc6b89e3d9ce3ad5b6460e4994d5928ec9928307236c1846bad4e7ffbbcd09cfabc947c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95339e8db51eeefb8bb66f5e30aa641eb7e257fa63d8e6aa9ae8aca3870934419c25b39117cae31057f5d19cef14c686c46ff15d6b306a9d30010d7a85cf126c"} 12:10:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:24 INFO - Contents: 12:10:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18d91636a66366fdf288e307f6cb8fbcb2b55c1fd23f69163bd03b16a90bedd914c0cd9fa7cad4d21e975a9e07dc07d42c528b9438c4911983118938e8140114", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11112aca90d67ee1796386c848857915c270e798a17a9e8be10a39e199b762c06c5fd07b23cac2ae41ec53ef42c78b99d3aa43d5c74400cfd9668299243b8316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fa3f6c23fb27b9d4417a459cc21a4adec7564af8c3d23ba072dbbbecc6b89e3d9ce3ad5b6460e4994d5928ec9928307236c1846bad4e7ffbbcd09cfabc947c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95339e8db51eeefb8bb66f5e30aa641eb7e257fa63d8e6aa9ae8aca3870934419c25b39117cae31057f5d19cef14c686c46ff15d6b306a9d30010d7a85cf126c"} 12:10:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:24 INFO - Copying logs to upload dir... 12:10:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.737511 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-29 12:10:24.646988) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:24.650884) ========= 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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18d91636a66366fdf288e307f6cb8fbcb2b55c1fd23f69163bd03b16a90bedd914c0cd9fa7cad4d21e975a9e07dc07d42c528b9438c4911983118938e8140114", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11112aca90d67ee1796386c848857915c270e798a17a9e8be10a39e199b762c06c5fd07b23cac2ae41ec53ef42c78b99d3aa43d5c74400cfd9668299243b8316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fa3f6c23fb27b9d4417a459cc21a4adec7564af8c3d23ba072dbbbecc6b89e3d9ce3ad5b6460e4994d5928ec9928307236c1846bad4e7ffbbcd09cfabc947c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95339e8db51eeefb8bb66f5e30aa641eb7e257fa63d8e6aa9ae8aca3870934419c25b39117cae31057f5d19cef14c686c46ff15d6b306a9d30010d7a85cf126c"} build_url:https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/dkptLtbpSxq5ska9dxYCFw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18d91636a66366fdf288e307f6cb8fbcb2b55c1fd23f69163bd03b16a90bedd914c0cd9fa7cad4d21e975a9e07dc07d42c528b9438c4911983118938e8140114", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/11112aca90d67ee1796386c848857915c270e798a17a9e8be10a39e199b762c06c5fd07b23cac2ae41ec53ef42c78b99d3aa43d5c74400cfd9668299243b8316", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fa3f6c23fb27b9d4417a459cc21a4adec7564af8c3d23ba072dbbbecc6b89e3d9ce3ad5b6460e4994d5928ec9928307236c1846bad4e7ffbbcd09cfabc947c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95339e8db51eeefb8bb66f5e30aa641eb7e257fa63d8e6aa9ae8aca3870934419c25b39117cae31057f5d19cef14c686c46ff15d6b306a9d30010d7a85cf126c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:24.683407) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:24.683943) ========= 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=6d15e502d8e29d5d2676d664000001c3-1490813363.82016-2131039271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 12:10:24.765081) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:10:24.765407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 12:10:24.765733) ========= ========= Total master_lag: 0.17 =========