builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1484756294.93 results: success (0) revision: b3774461acc6bee2216c5f57e167f9e5795fb09d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:14.928539) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:14.929009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:14.929312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:14.943920) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:14.944188) ========= 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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-18 08:18:15-- 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.2M=0s 2017-01-18 08:18:15 (46.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123306 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.080974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.081286) ========= 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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.130291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.130611) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3774461acc6bee2216c5f57e167f9e5795fb09d --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 b3774461acc6bee2216c5f57e167f9e5795fb09d --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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-18 08:18:15,580 truncating revision to first 12 chars 2017-01-18 08:18:15,580 Setting DEBUG logging. 2017-01-18 08:18:15,580 attempt 1/10 2017-01-18 08:18:15,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3774461acc6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-18 08:18:16,057 unpacking tar archive at: mozilla-central-b3774461acc6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759566 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.906745) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.907410) ========= script_repo_revision: b3774461acc6bee2216c5f57e167f9e5795fb09d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.908288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.908906) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-18 08:18:15.920601) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-18 08:18:15.920993) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:18:16 INFO - MultiFileLogger online at 20170118 08:18:16 in /builds/slave/test 08:18:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 08:18:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:18:16 INFO - {'append_to_log': False, 08:18:16 INFO - 'base_work_dir': '/builds/slave/test', 08:18:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:18:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:18:16 INFO - 'branch': 'Firefox-Non-PGO', 08:18:16 INFO - 'buildbot_json_path': 'buildprops.json', 08:18:16 INFO - 'config_files': ('talos/linux_config.py',), 08:18:16 INFO - 'default_actions': ('clobber', 08:18:16 INFO - 'read-buildbot-config', 08:18:16 INFO - 'download-and-extract', 08:18:16 INFO - 'populate-webroot', 08:18:16 INFO - 'create-virtualenv', 08:18:16 INFO - 'install', 08:18:16 INFO - 'run-tests'), 08:18:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:18:16 INFO - 'download_minidump_stackwalk': True, 08:18:16 INFO - 'download_symbols': 'ondemand', 08:18:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:18:16 INFO - 'tooltool.py': '/tools/tooltool.py', 08:18:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:18:16 INFO - '/tools/misc-python/virtualenv.py')}, 08:18:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:18:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:18:16 INFO - 'installer_path': 'installer.exe', 08:18:16 INFO - 'log_level': 'info', 08:18:16 INFO - 'log_name': 'talos', 08:18:16 INFO - 'log_to_console': True, 08:18:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:18:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:18:16 INFO - 'opt_config_files': (), 08:18:16 INFO - 'pip_index': False, 08:18:16 INFO - 'sps_profile': False, 08:18:16 INFO - 'sps_profile_interval': 0, 08:18:16 INFO - 'suite': 'dromaeojs', 08:18:16 INFO - 'system_bits': '32', 08:18:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:18:16 INFO - 'title': 'talos-linux64-ix-038', 08:18:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:18:16 INFO - 'use_talos_json': True, 08:18:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:18:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:18:16 INFO - 'work_dir': 'build'} 08:18:16 INFO - [mozharness: 2017-01-18 16:18:16.471272Z] Running clobber step. 08:18:16 INFO - Running pre-action listener: _resource_record_pre_action 08:18:16 INFO - Running main action method: clobber 08:18:16 INFO - rmtree: /builds/slave/test/build 08:18:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:18:16 INFO - Running post-action listener: _resource_record_post_action 08:18:16 INFO - [mozharness: 2017-01-18 16:18:16.934860Z] Finished clobber step (success) 08:18:16 INFO - [mozharness: 2017-01-18 16:18:16.934963Z] Running read-buildbot-config step. 08:18:16 INFO - Running pre-action listener: _resource_record_pre_action 08:18:16 INFO - Running main action method: read_buildbot_config 08:18:16 INFO - Using buildbot properties: 08:18:16 INFO - { 08:18:16 INFO - "project": "", 08:18:16 INFO - "product": "firefox", 08:18:16 INFO - "who": "Callek@gmail.com", 08:18:16 INFO - "installer_path": "public/build/target.tar.bz2", 08:18:16 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:18:16 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:18:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:18:16 INFO - "stage_platform": "linux64", 08:18:16 INFO - "basedir": "/builds/slave/test", 08:18:16 INFO - "buildnumber": 393, 08:18:16 INFO - "platform": "ubuntu64_hw", 08:18:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:18:16 INFO - "slavebuilddir": "test", 08:18:16 INFO - "taskId": "aNopJGp5S2yuWJsFc9VgDw", 08:18:16 INFO - "branch": "mozilla-central", 08:18:16 INFO - "script_repo_revision": "production", 08:18:16 INFO - "revision": "b3774461acc6bee2216c5f57e167f9e5795fb09d", 08:18:16 INFO - "slavename": "talos-linux64-ix-038", 08:18:16 INFO - "repo_path": "mozilla-central" 08:18:16 INFO - } 08:18:16 INFO - Finding installer, test and symbols from parent task. 08:18:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aNopJGp5S2yuWJsFc9VgDw'}, attempt #1 08:18:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aNopJGp5S2yuWJsFc9VgDw'}, attempt #1 08:18:17 INFO - Task dependencies: K57oZb2JSyepiuzZMrfybQ 08:18:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ'}, attempt #1 08:18:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 08:18:18 INFO - Set test_url: https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/test_packages.json 08:18:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.crashreporter-symbols.zip 08:18:18 INFO - Running post-action listener: _resource_record_post_action 08:18:18 INFO - [mozharness: 2017-01-18 16:18:18.339067Z] Finished read-buildbot-config step (success) 08:18:18 INFO - [mozharness: 2017-01-18 16:18:18.339289Z] Running download-and-extract step. 08:18:18 INFO - Running pre-action listener: _resource_record_pre_action 08:18:18 INFO - Running main action method: download_and_extract 08:18:18 INFO - mkdir: /builds/slave/test/build/tests 08:18:18 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')]} 08:18:18 INFO - trying https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.test_packages.json 08:18:18 INFO - Downloading https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:18:19 INFO - Downloaded 896 bytes. 08:18:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:18:19 INFO - Using the following test package requirements: 08:18:19 INFO - {u'common': [u'target.common.tests.zip'], 08:18:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:18:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:18:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:18:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:18:19 INFO - u'mozbase': [u'target.common.tests.zip'], 08:18:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:18:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:18:19 INFO - u'web-platform': [u'target.common.tests.zip', 08:18:19 INFO - u'target.web-platform.tests.zip'], 08:18:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:18:19 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:18:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip 08:18:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:19 INFO - Fetch https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip into memory 08:18:20 INFO - Expected file size: 20281256 08:18:20 INFO - Obtained file size: 20281256 08:18:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:18:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip 08:18:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:18:24 INFO - Fetch https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.common.tests.zip into memory 08:18:25 INFO - Expected file size: 20281256 08:18:25 INFO - Obtained file size: 20281256 08:18:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.talos.tests.zip 08:18:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:18:30 INFO - Fetch https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.talos.tests.zip into memory 08:18:31 INFO - Expected file size: 14403463 08:18:31 INFO - Obtained file size: 14403463 08:18: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')]} 08:18:31 INFO - trying https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 08:18:31 INFO - Downloading https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:18:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:18:32 INFO - Downloaded 56085002 bytes. 08:18:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 08:18:32 INFO - mkdir: /builds/slave/test/properties 08:18:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:18:32 INFO - Writing to file /builds/slave/test/properties/build_url 08:18:32 INFO - Contents: 08:18:32 INFO - build_url:https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 08:18:32 INFO - Running post-action listener: _resource_record_post_action 08:18:32 INFO - Running post-action listener: set_extra_try_arguments 08:18:32 INFO - [mozharness: 2017-01-18 16:18:32.738180Z] Finished download-and-extract step (success) 08:18:32 INFO - [mozharness: 2017-01-18 16:18:32.738277Z] Running populate-webroot step. 08:18:32 INFO - Running pre-action listener: _resource_record_pre_action 08:18:32 INFO - Running main action method: populate_webroot 08:18:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:18:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:18:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:18:32 INFO - '--tppagecycles', 08:18:32 INFO - '7'], 08:18:32 INFO - 'tests': ['tsvgm']}}, 08:18:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:18:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:18:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:18:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:18:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:18:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['damp', 'tps']}, 08:18:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'tests': ['damp', 'tps']}, 08:18:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['dromaeo_dom']}, 08:18:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:18:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['basic_compositor_video']}, 08:18:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:18:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'other-e10s': {'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['a11yr', 08:18:32 INFO - 'ts_paint', 08:18:32 INFO - 'tpaint', 08:18:32 INFO - 'sessionrestore', 08:18:32 INFO - 'sessionrestore_no_auto_restore', 08:18:32 INFO - 'tabpaint']}, 08:18:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['tsvgx', 08:18:32 INFO - 'tsvgr_opacity', 08:18:32 INFO - 'tart', 08:18:32 INFO - 'tscrollx', 08:18:32 INFO - 'cart', 08:18:32 INFO - 'tsvg_static']}, 08:18:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:18:32 INFO - 'tsvgr_opacity', 08:18:32 INFO - 'tart', 08:18:32 INFO - 'tscrollx', 08:18:32 INFO - 'cart', 08:18:32 INFO - 'tsvg_static']}, 08:18:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'talos_options': ['--disable-e10s'], 08:18:32 INFO - 'tests': ['tp5o']}, 08:18:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:18:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'talos_options': ['--disable-e10s', 08:18:32 INFO - '--xperf_path', 08:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:32 INFO - 'tests': ['tp5n']}, 08:18:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:18:32 INFO - 'talos_options': ['--xperf_path', 08:18:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:18:32 INFO - 'tests': ['tp5n']}}, 08:18:32 INFO - 'talos.zip': {'path': '', 08:18:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:18:32 INFO - Running post-action listener: _resource_record_post_action 08:18:32 INFO - [mozharness: 2017-01-18 16:18:32.751419Z] Finished populate-webroot step (success) 08:18:32 INFO - [mozharness: 2017-01-18 16:18:32.751512Z] Running create-virtualenv step. 08:18:32 INFO - Running pre-action listener: _resource_record_pre_action 08:18:32 INFO - Running main action method: create_virtualenv 08:18:32 INFO - Creating virtualenv /builds/slave/test/build/venv 08:18:32 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 08:18:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:18:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:18:32 INFO - Using real prefix '/usr' 08:18:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:18:33 INFO - Installing distribute.............................................................................................................................................................................................done. 08:18:35 INFO - Installing pip.................done. 08:18:35 INFO - Return code: 0 08:18:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:18:35 INFO - Reading from file tmpfile_stdout 08:18:35 INFO - Output received: 08:18:35 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) 08:18:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:18:35 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')]} 08:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:35 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')]} 08:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:35 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:35 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 08:18:35 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 08:18:35 INFO - Using env: {'DISPLAY': ':0', 08:18:35 INFO - 'HOME': '/home/cltbld', 08:18:35 INFO - 'LANG': 'en_US.UTF-8', 08:18:35 INFO - 'LANGUAGE': 'en_US:en', 08:18:35 INFO - 'LOGNAME': 'cltbld', 08:18:35 INFO - 'MAIL': '/var/mail/cltbld', 08:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:35 INFO - 'MOZ_NO_REMOTE': '1', 08:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:35 INFO - 'NO_EM_RESTART': '1', 08:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:35 INFO - 'PWD': '/builds/slave/test', 08:18:35 INFO - 'SHELL': '/bin/bash', 08:18:35 INFO - 'SHLVL': '1', 08:18:35 INFO - 'TERM': 'linux', 08:18:35 INFO - 'TMOUT': '86400', 08:18:35 INFO - 'USER': 'cltbld', 08:18:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:35 INFO - '_': '/tools/buildbot/bin/python'} 08:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:35 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 08:18:35 INFO - Cleaning up... 08:18:35 INFO - Return code: 0 08:18:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:18:35 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')]} 08:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:35 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')]} 08:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:35 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:35 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 08:18:35 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 08:18:35 INFO - Using env: {'DISPLAY': ':0', 08:18:35 INFO - 'HOME': '/home/cltbld', 08:18:35 INFO - 'LANG': 'en_US.UTF-8', 08:18:35 INFO - 'LANGUAGE': 'en_US:en', 08:18:35 INFO - 'LOGNAME': 'cltbld', 08:18:35 INFO - 'MAIL': '/var/mail/cltbld', 08:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:35 INFO - 'MOZ_NO_REMOTE': '1', 08:18:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:35 INFO - 'NO_EM_RESTART': '1', 08:18:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:35 INFO - 'PWD': '/builds/slave/test', 08:18:35 INFO - 'SHELL': '/bin/bash', 08:18:35 INFO - 'SHLVL': '1', 08:18:35 INFO - 'TERM': 'linux', 08:18:35 INFO - 'TMOUT': '86400', 08:18:35 INFO - 'USER': 'cltbld', 08:18:35 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:35 INFO - '_': '/tools/buildbot/bin/python'} 08:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:35 INFO - Downloading/unpacking psutil>=3.1.1 08:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:35 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 08:18:35 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 08:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:18:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:38 INFO - Installing collected packages: psutil 08:18:38 INFO - Running setup.py install for psutil 08:18:38 INFO - building 'psutil._psutil_linux' extension 08:18:38 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 08:18:38 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 08:18:38 INFO - building 'psutil._psutil_posix' extension 08:18:38 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 08:18:38 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 08:18:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:18:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:18:38 INFO - Successfully installed psutil 08:18:38 INFO - Cleaning up... 08:18:38 INFO - Return code: 0 08:18:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:18:38 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')]} 08:18:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:38 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')]} 08:18:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:38 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:38 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 08:18:38 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 08:18:38 INFO - Using env: {'DISPLAY': ':0', 08:18:38 INFO - 'HOME': '/home/cltbld', 08:18:38 INFO - 'LANG': 'en_US.UTF-8', 08:18:38 INFO - 'LANGUAGE': 'en_US:en', 08:18:38 INFO - 'LOGNAME': 'cltbld', 08:18:38 INFO - 'MAIL': '/var/mail/cltbld', 08:18:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:38 INFO - 'MOZ_NO_REMOTE': '1', 08:18:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:38 INFO - 'NO_EM_RESTART': '1', 08:18:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:38 INFO - 'PWD': '/builds/slave/test', 08:18:38 INFO - 'SHELL': '/bin/bash', 08:18:38 INFO - 'SHLVL': '1', 08:18:38 INFO - 'TERM': 'linux', 08:18:38 INFO - 'TMOUT': '86400', 08:18:38 INFO - 'USER': 'cltbld', 08:18:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:38 INFO - '_': '/tools/buildbot/bin/python'} 08:18:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:18:38 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 08:18:38 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 08:18:38 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 08:18:38 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 08:18:38 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 08:18:38 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 08:18:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:18:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:18:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:18:40 INFO - Installing collected packages: mozsystemmonitor 08:18:40 INFO - Running setup.py install for mozsystemmonitor 08:18:41 INFO - Successfully installed mozsystemmonitor 08:18:41 INFO - Cleaning up... 08:18:41 INFO - Return code: 0 08:18:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:18:41 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')]} 08:18:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:41 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')]} 08:18:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:41 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:41 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 08:18:41 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 08:18:41 INFO - Using env: {'DISPLAY': ':0', 08:18:41 INFO - 'HOME': '/home/cltbld', 08:18:41 INFO - 'LANG': 'en_US.UTF-8', 08:18:41 INFO - 'LANGUAGE': 'en_US:en', 08:18:41 INFO - 'LOGNAME': 'cltbld', 08:18:41 INFO - 'MAIL': '/var/mail/cltbld', 08:18:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:41 INFO - 'MOZ_NO_REMOTE': '1', 08:18:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:41 INFO - 'NO_EM_RESTART': '1', 08:18:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:41 INFO - 'PWD': '/builds/slave/test', 08:18:41 INFO - 'SHELL': '/bin/bash', 08:18:41 INFO - 'SHLVL': '1', 08:18:41 INFO - 'TERM': 'linux', 08:18:41 INFO - 'TMOUT': '86400', 08:18:41 INFO - 'USER': 'cltbld', 08:18:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:41 INFO - '_': '/tools/buildbot/bin/python'} 08:18:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:41 INFO - Downloading/unpacking jsonschema==2.5.1 08:18:41 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 08:18:41 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 08:18:41 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 08:18:41 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 08:18:41 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 08:18:41 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 08:18:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:18:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:18:43 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 08:18:43 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 08:18:43 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 08:18:43 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 08:18:43 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 08:18:43 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 08:18:43 INFO - Downloading functools32-3.2.3-2.tar.gz 08:18:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:18:43 INFO - warning: no files found matching '*.txt' 08:18:43 INFO - no previously-included directories found matching 'build' 08:18:43 INFO - no previously-included directories found matching 'dist' 08:18:43 INFO - no previously-included directories found matching '.git*' 08:18:43 INFO - Installing collected packages: jsonschema, functools32 08:18:43 INFO - Running setup.py install for functools32 08:18:43 INFO - warning: no files found matching '*.txt' 08:18:43 INFO - no previously-included directories found matching 'build' 08:18:43 INFO - no previously-included directories found matching 'dist' 08:18:43 INFO - no previously-included directories found matching '.git*' 08:18:43 INFO - Successfully installed jsonschema functools32 08:18:43 INFO - Cleaning up... 08:18:43 INFO - Return code: 0 08:18:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:18:43 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')]} 08:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:43 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')]} 08:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:43 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:43 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 08:18:43 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 08:18:43 INFO - Using env: {'DISPLAY': ':0', 08:18:43 INFO - 'HOME': '/home/cltbld', 08:18:43 INFO - 'LANG': 'en_US.UTF-8', 08:18:43 INFO - 'LANGUAGE': 'en_US:en', 08:18:43 INFO - 'LOGNAME': 'cltbld', 08:18:43 INFO - 'MAIL': '/var/mail/cltbld', 08:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:43 INFO - 'MOZ_NO_REMOTE': '1', 08:18:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:43 INFO - 'NO_EM_RESTART': '1', 08:18:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:43 INFO - 'PWD': '/builds/slave/test', 08:18:43 INFO - 'SHELL': '/bin/bash', 08:18:43 INFO - 'SHLVL': '1', 08:18:43 INFO - 'TERM': 'linux', 08:18:43 INFO - 'TMOUT': '86400', 08:18:43 INFO - 'USER': 'cltbld', 08:18:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:43 INFO - '_': '/tools/buildbot/bin/python'} 08:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:18:44 INFO - Cleaning up... 08:18:44 INFO - Return code: 0 08:18:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:18:44 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')]} 08:18:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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')]} 08:18:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:44 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:44 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 08:18:44 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 08:18:44 INFO - Using env: {'DISPLAY': ':0', 08:18:44 INFO - 'HOME': '/home/cltbld', 08:18:44 INFO - 'LANG': 'en_US.UTF-8', 08:18:44 INFO - 'LANGUAGE': 'en_US:en', 08:18:44 INFO - 'LOGNAME': 'cltbld', 08:18:44 INFO - 'MAIL': '/var/mail/cltbld', 08:18:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:44 INFO - 'MOZ_NO_REMOTE': '1', 08:18:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:44 INFO - 'NO_EM_RESTART': '1', 08:18:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:44 INFO - 'PWD': '/builds/slave/test', 08:18:44 INFO - 'SHELL': '/bin/bash', 08:18:44 INFO - 'SHLVL': '1', 08:18:44 INFO - 'TERM': 'linux', 08:18:44 INFO - 'TMOUT': '86400', 08:18:44 INFO - 'USER': 'cltbld', 08:18:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:44 INFO - '_': '/tools/buildbot/bin/python'} 08:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:44 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 08:18:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:18:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:18:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 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 08:18:46 INFO - Downloading docopt-0.6.1.tar.gz 08:18:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:18:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:18:47 INFO - Running setup.py install for blobuploader 08:18:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:18:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:18:47 INFO - Running setup.py install for requests 08:18:47 INFO - Running setup.py install for docopt 08:18:47 INFO - Successfully installed blobuploader requests docopt 08:18:47 INFO - Cleaning up... 08:18:47 INFO - Return code: 0 08:18:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:47 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')]} 08:18:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:47 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')]} 08:18:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:47 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:47 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 08:18:47 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 08:18:47 INFO - Using env: {'DISPLAY': ':0', 08:18:47 INFO - 'HOME': '/home/cltbld', 08:18:47 INFO - 'LANG': 'en_US.UTF-8', 08:18:47 INFO - 'LANGUAGE': 'en_US:en', 08:18:47 INFO - 'LOGNAME': 'cltbld', 08:18:47 INFO - 'MAIL': '/var/mail/cltbld', 08:18:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:47 INFO - 'MOZ_NO_REMOTE': '1', 08:18:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:47 INFO - 'NO_EM_RESTART': '1', 08:18:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:47 INFO - 'PWD': '/builds/slave/test', 08:18:47 INFO - 'SHELL': '/bin/bash', 08:18:47 INFO - 'SHLVL': '1', 08:18:47 INFO - 'TERM': 'linux', 08:18:47 INFO - 'TMOUT': '86400', 08:18:47 INFO - 'USER': 'cltbld', 08:18:47 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:47 INFO - '_': '/tools/buildbot/bin/python'} 08:18:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:47 INFO - Running setup.py (path:/tmp/pip-R8g2kM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:47 INFO - Running setup.py (path:/tmp/pip-89EFzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:48 INFO - Running setup.py (path:/tmp/pip-vnqhqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:48 INFO - Running setup.py (path:/tmp/pip-mtCZv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:48 INFO - Running setup.py (path:/tmp/pip-qkmVpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:48 INFO - Running setup.py (path:/tmp/pip-Fr_Nrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:48 INFO - Running setup.py (path:/tmp/pip-Ys8_9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:48 INFO - Running setup.py (path:/tmp/pip-ZiAzBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:48 INFO - Running setup.py (path:/tmp/pip-3OZXOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:48 INFO - Running setup.py (path:/tmp/pip-CBG3kG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:48 INFO - Running setup.py (path:/tmp/pip-cr5qpv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:48 INFO - Running setup.py (path:/tmp/pip-slRODa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:48 INFO - Running setup.py (path:/tmp/pip-Mz_u5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:48 INFO - Running setup.py (path:/tmp/pip-KaiG1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:48 INFO - Running setup.py (path:/tmp/pip-AD6X6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:49 INFO - Running setup.py (path:/tmp/pip-7sgu5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:49 INFO - Running setup.py (path:/tmp/pip-zaEs_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:18:49 INFO - Running setup.py install for manifestparser 08:18:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozcrash 08:18:49 INFO - Running setup.py install for mozdebug 08:18:49 INFO - Running setup.py install for mozdevice 08:18:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozfile 08:18:49 INFO - Running setup.py install for mozhttpd 08:18:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozinfo 08:18:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozInstall 08:18:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:18:49 INFO - Running setup.py install for mozleak 08:18:50 INFO - Running setup.py install for mozlog 08:18:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for moznetwork 08:18:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozprocess 08:18:50 INFO - Running setup.py install for mozprofile 08:18:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozrunner 08:18:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Running setup.py install for mozscreenshot 08:18:50 INFO - Running setup.py install for moztest 08:18:50 INFO - Running setup.py install for mozversion 08:18:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:18:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:18:50 INFO - Cleaning up... 08:18:50 INFO - Return code: 0 08:18:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:50 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')]} 08:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:50 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')]} 08:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:51 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:51 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 08:18:51 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 08:18:51 INFO - Using env: {'DISPLAY': ':0', 08:18:51 INFO - 'HOME': '/home/cltbld', 08:18:51 INFO - 'LANG': 'en_US.UTF-8', 08:18:51 INFO - 'LANGUAGE': 'en_US:en', 08:18:51 INFO - 'LOGNAME': 'cltbld', 08:18:51 INFO - 'MAIL': '/var/mail/cltbld', 08:18:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:51 INFO - 'MOZ_NO_REMOTE': '1', 08:18:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:51 INFO - 'NO_EM_RESTART': '1', 08:18:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:51 INFO - 'PWD': '/builds/slave/test', 08:18:51 INFO - 'SHELL': '/bin/bash', 08:18:51 INFO - 'SHLVL': '1', 08:18:51 INFO - 'TERM': 'linux', 08:18:51 INFO - 'TMOUT': '86400', 08:18:51 INFO - 'USER': 'cltbld', 08:18:51 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:51 INFO - '_': '/tools/buildbot/bin/python'} 08:18:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:18:51 INFO - Running setup.py (path:/tmp/pip-W6srNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:18:51 INFO - Running setup.py (path:/tmp/pip-SKsBaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:18:51 INFO - Running setup.py (path:/tmp/pip-4zB5hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:18:51 INFO - Running setup.py (path:/tmp/pip-JU7bOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:18:51 INFO - Running setup.py (path:/tmp/pip-Th0gYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:18:51 INFO - Running setup.py (path:/tmp/pip-fayuja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:18:51 INFO - Running setup.py (path:/tmp/pip-8zdiC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:18:51 INFO - Running setup.py (path:/tmp/pip-duPxyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:18:51 INFO - Running setup.py (path:/tmp/pip-MaWe9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:18:51 INFO - Running setup.py (path:/tmp/pip-n0f5tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:18:51 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)) 08:18:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:18:51 INFO - Running setup.py (path:/tmp/pip-as4VIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:18:52 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:18:52 INFO - Running setup.py (path:/tmp/pip-bJp_O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:18:52 INFO - Running setup.py (path:/tmp/pip-j0xFKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:18:52 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:18:52 INFO - Running setup.py (path:/tmp/pip-ggkwwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:18:52 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:52 INFO - Running setup.py (path:/tmp/pip-Y7vSxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:18:52 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:18:52 INFO - Running setup.py (path:/tmp/pip-JZOT7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:18:52 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)) 08:18:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:18:52 INFO - Running setup.py (path:/tmp/pip-iTboNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:18:52 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)) 08:18:52 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)) 08:18:52 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)) 08:18:52 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)) 08:18:52 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)) 08:18:52 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)) 08:18:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:18:52 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 08:18:52 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 08:18:52 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 08:18:52 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 08:18:52 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 08:18:52 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 08:18:54 INFO - Downloading blessings-1.6.tar.gz 08:18:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:18:54 INFO - Installing collected packages: blessings 08:18:54 INFO - Running setup.py install for blessings 08:18:54 INFO - Successfully installed blessings 08:18:54 INFO - Cleaning up... 08:18:54 INFO - Return code: 0 08:18:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:18:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:54 INFO - Reading from file tmpfile_stdout 08:18:54 INFO - Current package versions: 08:18:54 INFO - argparse == 1.2.1 08:18:54 INFO - blessings == 1.6 08:18:54 INFO - blobuploader == 1.2.4 08:18:54 INFO - docopt == 0.6.1 08:18:54 INFO - functools32 == 3.2.3-2 08:18:54 INFO - jsonschema == 2.5.1 08:18:54 INFO - manifestparser == 1.1 08:18:54 INFO - mozInstall == 1.12 08:18:54 INFO - mozcrash == 1.0 08:18:54 INFO - mozdebug == 0.1 08:18:54 INFO - mozdevice == 0.49 08:18:54 INFO - mozfile == 1.2 08:18:54 INFO - mozhttpd == 0.7 08:18:54 INFO - mozinfo == 0.9 08:18:54 INFO - mozleak == 0.1 08:18:54 INFO - mozlog == 3.4 08:18:54 INFO - moznetwork == 0.27 08:18:54 INFO - mozprocess == 0.24 08:18:54 INFO - mozprofile == 0.28 08:18:54 INFO - mozrunner == 6.13 08:18:54 INFO - mozscreenshot == 0.1 08:18:54 INFO - mozsystemmonitor == 0.3 08:18:54 INFO - moztest == 0.8 08:18:54 INFO - mozversion == 1.4 08:18:54 INFO - psutil == 3.1.1 08:18:54 INFO - requests == 1.2.3 08:18:54 INFO - wsgiref == 0.1.2 08:18:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:18:54 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')]} 08:18:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 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')]} 08:18:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18:54 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 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18:54 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 08:18:54 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 08:18:54 INFO - Using env: {'DISPLAY': ':0', 08:18:54 INFO - 'HOME': '/home/cltbld', 08:18:54 INFO - 'LANG': 'en_US.UTF-8', 08:18:54 INFO - 'LANGUAGE': 'en_US:en', 08:18:54 INFO - 'LOGNAME': 'cltbld', 08:18:54 INFO - 'MAIL': '/var/mail/cltbld', 08:18:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:54 INFO - 'MOZ_NO_REMOTE': '1', 08:18:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:54 INFO - 'NO_EM_RESTART': '1', 08:18:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:54 INFO - 'PWD': '/builds/slave/test', 08:18:54 INFO - 'SHELL': '/bin/bash', 08:18:54 INFO - 'SHLVL': '1', 08:18:54 INFO - 'TERM': 'linux', 08:18:54 INFO - 'TMOUT': '86400', 08:18:54 INFO - 'USER': 'cltbld', 08:18:54 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:54 INFO - '_': '/tools/buildbot/bin/python'} 08:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 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)) 08:18:55 INFO - Cleaning up... 08:18:55 INFO - Return code: 0 08:18:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:18: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')]} 08:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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')]} 08:18:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:18:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x9d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xae0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd42630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, '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': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', '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 08:18: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', 'jsonschema'] in /builds/slave/test/build 08:18: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 jsonschema 08:18:55 INFO - Using env: {'DISPLAY': ':0', 08:18:55 INFO - 'HOME': '/home/cltbld', 08:18:55 INFO - 'LANG': 'en_US.UTF-8', 08:18:55 INFO - 'LANGUAGE': 'en_US:en', 08:18:55 INFO - 'LOGNAME': 'cltbld', 08:18:55 INFO - 'MAIL': '/var/mail/cltbld', 08:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:18:55 INFO - 'MOZ_NO_REMOTE': '1', 08:18:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:18:55 INFO - 'NO_EM_RESTART': '1', 08:18:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:18:55 INFO - 'PWD': '/builds/slave/test', 08:18:55 INFO - 'SHELL': '/bin/bash', 08:18:55 INFO - 'SHLVL': '1', 08:18:55 INFO - 'TERM': 'linux', 08:18:55 INFO - 'TMOUT': '86400', 08:18:55 INFO - 'USER': 'cltbld', 08:18:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:18:55 INFO - '_': '/tools/buildbot/bin/python'} 08:18:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:18:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:18:55 INFO - Cleaning up... 08:18:55 INFO - Return code: 0 08:18:55 INFO - Running post-action listener: _resource_record_post_action 08:18:55 INFO - Running post-action listener: _start_resource_monitoring 08:18:55 INFO - Starting resource monitoring. 08:18:55 INFO - [mozharness: 2017-01-18 16:18:55.463998Z] Finished create-virtualenv step (success) 08:18:55 INFO - [mozharness: 2017-01-18 16:18:55.464468Z] Running install step. 08:18:55 INFO - Running pre-action listener: _resource_record_pre_action 08:18:55 INFO - Running main action method: install 08:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:18:55 INFO - Reading from file tmpfile_stdout 08:18:55 INFO - Detecting whether we're running mozinstall >=1.0... 08:18:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:18:55 INFO - Reading from file tmpfile_stdout 08:18:55 INFO - Output received: 08:18:55 INFO - Usage: mozinstall [options] installer 08:18:55 INFO - Options: 08:18:55 INFO - -h, --help show this help message and exit 08:18:55 INFO - -d DEST, --destination=DEST 08:18:55 INFO - Directory to install application into. [default: 08:18:55 INFO - "/builds/slave/test"] 08:18:55 INFO - --app=APP Application being installed. [default: firefox] 08:18:55 INFO - mkdir: /builds/slave/test/build/application 08:18:55 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'] 08:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:19:11 INFO - Reading from file tmpfile_stdout 08:19:11 INFO - Output received: 08:19:11 INFO - /builds/slave/test/build/application/firefox/firefox 08:19:11 INFO - Running post-action listener: _resource_record_post_action 08:19:11 INFO - [mozharness: 2017-01-18 16:19:11.917295Z] Finished install step (success) 08:19:11 INFO - [mozharness: 2017-01-18 16:19:11.917576Z] Running run-tests step. 08:19:11 INFO - Running pre-action listener: _resource_record_pre_action 08:19:11 INFO - Running main action method: run_tests 08:19:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:19:11 INFO - Python 2.7.3 08:19:11 INFO - Return code: 0 08:19:11 INFO - grabbing minidump binary from tooltool 08:19: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')]} 08:19:11 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 0xdcb850>, '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 0xd406d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd40b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:19:11 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 08:19:11 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 08:19:11 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 08:19:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:19:11 INFO - Return code: 0 08:19:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:19:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:19:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:19:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:19:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:19:11 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:19:11 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:19:12 INFO - Using env: {'DISPLAY': ':0', 08:19:12 INFO - 'HOME': '/home/cltbld', 08:19:12 INFO - 'LANG': 'en_US.UTF-8', 08:19:12 INFO - 'LANGUAGE': 'en_US:en', 08:19:12 INFO - 'LOGNAME': 'cltbld', 08:19:12 INFO - 'MAIL': '/var/mail/cltbld', 08:19:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:19:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:19:12 INFO - 'MOZ_NO_REMOTE': '1', 08:19:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:19:12 INFO - 'NO_EM_RESTART': '1', 08:19:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:19:12 INFO - 'PWD': '/builds/slave/test', 08:19:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:19:12 INFO - 'SHELL': '/bin/bash', 08:19:12 INFO - 'SHLVL': '1', 08:19:12 INFO - 'TERM': 'linux', 08:19:12 INFO - 'TMOUT': '86400', 08:19:12 INFO - 'USER': 'cltbld', 08:19:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032', 08:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:19:12 INFO - '_': '/tools/buildbot/bin/python'} 08:19:12 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:19:12 INFO - mozversion application_buildid: 20170118154623 08:19:12 INFO - mozversion application_changeset: b3774461acc6bee2216c5f57e167f9e5795fb09d 08:19:12 INFO - mozversion application_display_name: Nightly 08:19:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:19:12 INFO - mozversion application_name: Firefox 08:19:12 INFO - mozversion application_remotingname: firefox 08:19:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:19:12 INFO - mozversion application_vendor: Mozilla 08:19:12 INFO - mozversion application_version: 53.0a1 08:19:12 INFO - mozversion platform_buildid: 20170118154623 08:19:12 INFO - mozversion platform_changeset: b3774461acc6bee2216c5f57e167f9e5795fb09d 08:19:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:19:12 INFO - mozversion platform_version: 53.0a1 08:19:12 INFO - using testdate: 1484756352 08:19:12 INFO - actual date: 1484756352 08:19:12 INFO - starting webserver on 'localhost:53194' 08:19:12 INFO - SUITE-START | Running 2 tests 08:19:12 INFO - TEST-START | dromaeo_css 08:19:12 INFO - operating with platform_type : linux_ 08:19:12 INFO - Initialising browser for dromaeo_css test... 08:19:12 INFO - TEST-INFO | started process 9199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYCQSz/profile http://localhost:53194/getInfo.html) 08:19:16 INFO - PROCESS | 9199 | __metrics Screen width/height:1600/1200 08:19:16 INFO - PROCESS | 9199 | colorDepth:24 08:19:16 INFO - PROCESS | 9199 | Browser inner width/height: 1024/697 08:19:16 INFO - PROCESS | 9199 | __metrics 08:19:17 INFO - PROCESS | 9199 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:19:17 INFO - PROCESS | 9199 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:18 INFO - PROCESS | 9199 | console.error: 08:19:18 INFO - PROCESS | 9199 | Message: Error: Connection closed before committing the transaction. 08:19:18 INFO - PROCESS | 9199 | Stack: 08:19:18 INFO - PROCESS | 9199 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 08:19:18 INFO - PROCESS | 9199 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 08:19:18 INFO - PROCESS | 9199 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 08:19:18 INFO - PROCESS | 9199 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 08:19:18 INFO - PROCESS | 9199 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 08:19:18 INFO - PROCESS | 9199 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 08:19:18 INFO - PROCESS | 9199 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 08:19:18 INFO - PROCESS | 9199 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 08:19:18 INFO - PROCESS | 9199 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 08:19:18 INFO - PROCESS | 9199 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 08:19:18 INFO - PROCESS | 9199 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 08:19:18 INFO - PROCESS | 9199 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 08:19:18 INFO - PROCESS | 9199 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 08:19:18 INFO - PROCESS | 9199 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 08:19:18 INFO - PROCESS | 9199 | 08:19:18 INFO - PROCESS | 9199 | console.error: PushService: 08:19:18 INFO - PROCESS | 9199 | stateChangeProcessEnqueue: Error transitioning state 08:19:18 INFO - PROCESS | 9199 | UnknownError 08:19:19 INFO - TEST-INFO | 9199: exit 0 08:19:19 INFO - Browser initialized. 08:19:19 INFO - Running cycle 1/1 for dromaeo_css test... 08:19:19 INFO - TEST-INFO | started process 9280 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGYCQSz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:31 INFO - PROCESS | 9280 | RSS: Main: 152387584 08:19:31 INFO - PROCESS | 9280 | 08:22:36 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53194/tests/dromaeo/cssquery-ext.html) 08:22:37 INFO - PROCESS | 9280 | RSS: Main: 248291328 08:22:37 INFO - PROCESS | 9280 | 08:24:21 INFO - PROCESS | 9280 | ************************* 08:24:21 INFO - PROCESS | 9280 | A coding exception was thrown and uncaught in a Task. 08:24:21 INFO - PROCESS | 9280 | 08:24:21 ERROR - PROCESS | 9280 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:24:21 INFO - PROCESS | 9280 | Full stack: 08:24:21 INFO - PROCESS | 9280 | ************************* 08:25:40 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-ext.html (next: http://localhost:53194/tests/dromaeo/cssquery-jquery.html) 08:25:40 INFO - PROCESS | 9280 | RSS: Main: 236400640 08:25:40 INFO - PROCESS | 9280 | 08:28:42 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53194/tests/dromaeo/cssquery-mootools.html) 08:28:43 INFO - PROCESS | 9280 | RSS: Main: 186380288 08:28:43 INFO - PROCESS | 9280 | 08:31:45 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53194/tests/dromaeo/cssquery-prototype.html) 08:31:46 INFO - PROCESS | 9280 | RSS: Main: 185520128 08:31:46 INFO - PROCESS | 9280 | 08:34:49 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53194/tests/dromaeo/cssquery-yui.html) 08:34:49 INFO - PROCESS | 9280 | RSS: Main: 184451072 08:34:49 INFO - PROCESS | 9280 | 08:37:52 INFO - PROCESS | 9280 | Cycle 1(1): loaded http://localhost:53194/tests/dromaeo/cssquery-yui.html (next: http://localhost:53194/tests/dromaeo/cssquery-dojo.html) 08:37:53 INFO - PROCESS | 9280 | RSS: Main: 272932864 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | __start_tp_report 08:37:53 INFO - PROCESS | 9280 | _x_x_mozilla_page_load 08:37:53 INFO - PROCESS | 9280 | _x_x_mozilla_page_load_details 08:37:53 INFO - PROCESS | 9280 | |i|pagename|runs| 08:37:53 INFO - PROCESS | 9280 | |0;dojo.html;2582.044643481912;2609.5302845487827;2636.1432534426317;2637.986810065949;2642.3526236072166;4713.293006049086;4753.027042571966;4762.404699412574;4839.346688197093;4899;4785.5214478552125;4816.590589799863;4820.084184005045;4829.299751536034;4883.658143929926;4321.805518751664;4339.19724850902;4372.453443319585;4401.493828209749;4482.260427029536;4118.114342246972;4348.152110338485;4391.5827996340295;4412.205802955466;4472.038511719979;4303.483581970152;4346.1090476452255;4451.354553589744;4453.688241823073;4519.570640789137;4368.410264614268;4432.135733531963;4447.7776111194635;4451.2655411857;4495.707778994355;4400.251957167289;4407.801648925806;4414.889627759299;4428.955710442887;4463.352813841975;4679.087577922306;4831.516848315176;4839.44346400165;4851.393575803025;4881.731504767236;5043.42000669924;5135.537801597874;5188.507091826308;5194.194899790538;5272.393674727417;5232.189010703347;5234.293370394986;5240.4497527759795;5241.895162096775;5247.685138891678;4884.389451318585;4890.2909078184175;4891.290762839369;4892.706437613754;4928.186849169882;5145.588352931756;5151.665141765773;5161.303224064778;5193.558547523503;5197.428282888879;4928.112939670894;4934.9013019739405;4942;4969.552740253394;4992.425871024806;4997.85006449807;5033.395992480926;5066.113430149709;5073.619478539124;5112.590992720573;5046.041252162077;5097.388313402415;5131.871703207375;5136.383633963874;5187.19598462239;5152.20140878157;5167.560757335594;5174.353205849269;5174.741262936838;5176.094183517869;4385.320275357325;4387.956120438818;4395.472543294761;4398.516163222043;4434.645228381722;3726.06848287928;3735.4957080793747;3774.3206222880144;3819.083419979185;3851.768893866377;4503.639708823286;4510.188166130128;4513.232750432434;4540.931886021713;4541.409616749801;5222;5238.7904483820985;5244.580433565306;5247;5295.073362161684;4391.8462853799965;4416.514183439819;4441.045175287264;4472.530384309601;4485.9775701121935;4687.2500399936525;4687.531246875285;4689.320048592935;4718.669693121448;4718.95281047192;4895.04546613407;4901.191303434894;4902.1911384621135;4904.803807847647;4942.332785074041;5037.319961805256;5084.491550844886;5092.0579692756955;5194.636375453682;5257.053730328577;4788.449328327287;4825.9865428260455;4836.927446088382;4855.562999329936;4897.706137631753;5067.569256613229;5068.138416469283;5080.415752188545;5084;5120.743962801919;5039.143345631178;5140.691558506502;5160.741962901915;5161.174212126042;5162.199859021857;4874.6344024197615;5051.646384753032;5055.191169412877;5099.898002040012;5144.4855514449755;5006.048850718352;5037.445880953019;5048.066107770074;5048.167052436307;5093.567046800915;4836.492168322417;4866.270059491105;4876.853694389174;4952.702837829742;5034.09386310453;5079.339685840817;5097.082525145361;5106.795728170831;5141.871453213699;5144.408393034849;4957.355543779286;4979.751012449436;4985.725785081855;4987.027529631687;5026.84919452417 08:37:53 INFO - PROCESS | 9280 | |1;ext.html;533.6984603698908;542.6255883440429;553.8643032457048;569.3225062176012;581.2966310763977;27533.862330688342;32903.67096329036;34265.31469370611;34362.8281858591;36432.08919777007;39355.40966885499;39791.60208397915;39792;39817.20365592687;39933.20133597327;7612.581308028056;7785.805354866117;7789.493682910621;7795.6491957861745;7796.337311328544;7388.445866560002;7599.962000189991;9803.852942205873;10035.548400321966;10050.396976181415;10008.297759604902;10053.447060411674;10064.39613623185;10073.093421592055;10073.44596047217;10067.59053732478;10101.848472272923;10102.141317987944;10135.391876487434;10138.493075346203;9919.355241909252;9989.10098091168;9990.90009099907;9992.350497217658;9993.950635183273;37212;37401.81299093487;37541.436878446846;37566.24867502635;37568.81215593932;3172.397244523533;3226.58054452922;3234.256121092162;3272.640009598942;3280.3603297357026;28305;28563.57154642682;28646.85676571604;29144.854275728696;29334;2723.945521089567;2801.7898657600763;2802.7757779377603;2805.340744924941;2811.5360965440677;226515;226584;227057;227115;228044;45735;45842;45907.770461147484;45914.540854591694;45952;53697.1945420819;53710;53768.19347709788;53922.730386347816;54020.72989635027;14459.566213013626;15087.170205638577;15099.169545675093;15100.471483498024;15110.244487775568;9668.806623867484;11364;11527.94509454995;11550.075993920465;11553.480093395818;13255.403506842214;14912.70174596502;15036.248187590576;15273.236338183046;15835.920820396055;6127.4485296322655;6188.783392581238;6263.71813268404;6275.748970041239;6309.116723658692;810.1574362662883;830.4560512864084;839.7942504086416;856.4604299291531;862.1249431826701;26773.464530709276;27530.862345688143;27701.861490692416;27804.86097569499;27875;888.071964796776;991.4299277915228;997.6059456514636;1010.2927950434726;1012.4532752313668;14892.329845156994;15048.699026019418;15135.091894486366;15311.846881531264;15317.080975141527;313990;315195;316499;316510;316718;49298;49625.75187124041;49650.75174624176;49748.50251497511;49929.251061234114;1059.9788004240027;1110.3892858927557;1115.7991561518843;1118.0720002398152;1185.247367921359;25178.74821251764;26420.20739377822;26789.374231410842;27229.86385068062;27371.45257094807;41473.585264146976;42028.57971420247;42033.159336813704;42051.57948420599;42263.366049509896;259703;262581;262730;262883;263075;28097.859510702314;28293.43413131767;35030.824845875606;35374;35485.11287217737;35490.8225458871;41492.585074148876;41719.58280417157;41870.37194442025;42367;34382.65617343794;34992.65007349894;35329.646703532635;35812.82093589516;36296.81851590725;33767.662323376455;33788.15529611681;34052.489212661334;34815;34988.47517287192;33883;34518.65481345155;34849.12877178091;34854;34953.47569786506;30073.398532029674;30696.232594185323;31416.37167256688;31422.528662070545;31523.684763152076;23579.467334623194;23876.880615596812;23958.161464348665;24094.277171684877;24314.635280470455 08:37:53 INFO - PROCESS | 9280 | |2;jquery.html;356.2785359646717;377.5337458239076;380.4901432081012;381.09489961341814;391.9314120028996;17022;18188;18430.26278948844;18681.252749890005;18803.905980470114;18067.728984065216;18127.637447251047;18325.908370458128;18417;18520.907395463004;4943.728094954767;5136.075506408845;5143.562797162245;5145.562627176694;5147.691138531682;4957.950420495785;5016.623753218523;5100.515451032146;5137.434882162959;5151.330327057477;5120.667156634825;5123.487651234866;5125.871853203663;5131.923021154686;5133.614978876581;4950.6287028472825;5091.134507133777;5096.847094587187;5122.974385128088;5127.9230811537855;4604.6776725629215;4611.976940115312;4614.469336026333;4615.076984603059;4621.491635920046;20975;20991.790082099134;21075;21220.469488262763;21424.250151244632;2218.966715499269;2254.1208928517726;2269.3986093685185;2275.681404603357;2314.780095890888;13456.529021484299;13524.864751352558;13570.660733481644;13662.292213473316;14234.501792437215;1715.8198389169083;1736.496416039347;1745.1187150488922;1774.2370780564352;1819.8362147406797;76615.23384766192;76676;77628;78052.99999999943;78714;10056.497175141214;10138.898611013943;10147.847782283272;10188.745281368025;10204.591816327413;13723.725525489433;13921.095128816594;13934.303284835718;13937.303134843218;13988;7479.551226926402;7508.3993280537425;7601.695932162652;7728.729494467779;7752.883706744404;7134.393576545948;7152.785416437515;7376.557406555624;7395.4083673306;7432.3310902019075;6359.17330747;6422.325655806073;6426.164598602152;6463.15978922737;6661.9000714989315;1745.825417458244;1849.1309084730156;1879.2670858364975;1879.614678990831;1883.5573640194543;963.3882484622316;989.4261328429494;1000.5897581991348;1020.3776890685208;1046.612753281291;18194.45416637503;18263.269469221348;18550.814491855177;18596.25614975386;18838.24647014104;993.6969224386487;1003.7691330993912;1003.8895721470633;1011.5599714124379;1024.933379330341;10043.4476103815;10386;10547.894521054692;10550.89449105499;10609.946950265354;492122;492558;497582;500419;501959;77483.22516774872;79660.60169699231;80561;80606.59696701597;82637;929.8279818233649;937.1144268666181;955.8375076237056;962.956666949989;967.2793768642406;15421.151836649093;15511.146886920877;16202.67594648124;16295.689607814777;16441.753373699165;31477.898273560317;34522.65477345295;35417.468737969466;35520.28959420849;36185.0953726159;45522;45523.54476455193;45721.77139114283;45874;48261.27608085952;5144;5362.490563396471;7104.934259861062;7827.295543401121;8344.165583441607;11727.765444690887;11779.234349767237;12005.579804706793;12046.75906481883;12321.568745093879;10296.639617613648;10389.584416623251;10463.895361046292;10729.356238625707;10793.838092428463;10156.49217539135;10321.432321222404;10715.035646791826;10726.202694193687;10742.73143171427;10844.67465976022;11016.944915275373;11083.612073577386;11172.273802202832;11328.433578321215;6704.329567043256;7103.147622285359;7154.463415243981;7887.132415434183;8082.434229603871;9665.516724163905;10172.542235599563;10329.173666106844;10474.266801323834;10493.160547156056 08:37:53 INFO - PROCESS | 9280 | |3;mootools.html;1014.1227837920192;1313.7438199551086;1316.552372193454;1319.9736005279894;1328.1831673520785;5912.083627037805;6611.4049735523795;6822.044913712084;6826.214985276694;6908.274631163731;6776.2546119926765;6851.828704282396;6853.451723862092;6889.207741109762;6893.965530172342;1792.3995461520406;1849.2325684840775;2056.362527616436;2094.0158125680905;2096.5178009057927;2067.7725450200464;2117.2060477321006;2118.184498967893;2140.422086036769;2144.1637761273114;2044.7341845560056;2050.5591297870956;2065.648839697255;2076.6262072826885;2080.282302605606;2068.937931862039;2088.4883203615213;2091.278508914422;2092.591944570809;2093.811556959881;2028.6348457277684;2039.0926037913134;2088.446561661161;2100.1809294375207;2101.6006958677804;6959.1996920353795;7006.089208402926;7025.332593403618;7028.824279393005;7035.577865328097;4168.312228482297;4289.52815190332;4297.613214810651;4303.139372125587;4307.547707490699;2712.905048323319;2777.652793400825;2796.5106106431494;2832.900848470314;2839.219214715949;1048.1719441641094;1062.102523367753;1121.820508718601;1141.452102990569;1143.5540139345662;8931.73204803857;8949.194572488508;8961.59672814725;8968.148025937526;8971.50656713887;3710.8330125144435;3905.746126501825;3951.6443520082757;3973.6026397360033;3975.7216994810087;7846.215378462108;7846.803829904298;7846.9215307847335;7847.411444141712;7865.724699635485;4414.955850441519;4417.955820441754;4423.60187583119;4426.402435671208;4426.490953540384;3417.7607567470536;3519.859205631746;3839.4240863870086;3961.742486738353;4037.8788636340955;3316.1875340541237;3337.732981361485;3439.2949445364143;3493.9301213975577;3508.491268766015;1061.7080302916759;1084.5661735305941;1092.3664274720802;1100.6422912553453;1100.9834852477059;720.585663243637;726.6148941061246;748.8240263538064;755.8903958925926;764.399946042354;4190.371444283382;4212.283911735012;4318.818996406857;4374.606285434326;4748.667593268438;814.9877751833727;817.3012074676067;821.9013718353835;822.9711960081369;844.7254642241296;3015.1557563882147;3056.3581647853757;3065.1417603071177;3085.7222849943614;3169.2869104451315;7842.137364889858;8154.103048664642;8155.143709910492;8164.306033987177;8171.67313307473;8097.959510202411;8103.351731861437;8132.634031468599;8192.918070819334;8204.794880128045;6345.873082538324;6478.546501744927;6494.837629059217;6498.317676643885;6498.577592456475;4380.233459144701;4488.259437192826;4556.863294101182;4574.794134264032;4608.907821843612;7271.927280727125;7288.854222915406;7426.108866936002;7441;7495.325420712162;7511.248875112445;7587.734429294948;7611.657475413509;7645.541267523967;7736.4584479085925;5570.2201691762375;5595.244641973281;5689.089745640677;5693.3168019837885;5706.115552089433;6400.55196136266;6410.839729006812;6418.486521078209;6436.420722135031;6471.579347342407;5758.539316854725;5791.9131213031;5857.502112320501;5875.529957603296;5926.4666180044005;5776.306843178677;5811.709414529341;5828.154917536848;5858.502027327554;5940.851478713067;5009.198528235464;5071.594272458121;5108.263190515243;5114.053900028507;5117.974410127926;4113.732607380511;4145.17096580679;4243.151369726005;4247.830086796617;4332.6317263033;4115.794210289533;4128.2156390285745;4184.581541845912;4193.098483825992;4316.309390497506 08:37:53 INFO - PROCESS | 9280 | |4;prototype.html;339.7791435566881;342.1275746845543;346.248640450223;352.4308242188864;352.8782570013346;4699.788509517071;4799.66402351835;4816.470188279286;4825;4826.227803551433;4752.382190315263;4762.8571142865685;4767.928481072787;4770.141374552588;4778.331033655282;3639.927201455963;3722.497462842509;3752.774833509998;3794.4118661607495;3812.9618703812885;3804.0870191154063;3807.534099371748;3809.2191100824266;3826.693864490848;3835.5589107252604;3776.9433458498142;3778.376567866299;3797.468354430382;3801.9164538106647;3804.08701911542;3637.6726094651476;3701.68535674468;3740.962590374102;3778.1310298631192;3795.772253664789;3395.303962687643;3412.692857642799;3417.8974630761118;3427.880024199166;3445.707114895237;4674.976625116887;4678.602318802906;4686.390769199982;4694.624430045588;4697.53024697531;4013.518377794654;4157.792110394468;4362.956370436286;4367.951691593995;4385.386045953569;4915.3364295819965;4925.458199598042;4929.112759703252;4934.950650493521;4950.232713929347;3526.876559320437;3532.7880327180196;3535.5403797506415;3576.302620988908;3577.4454959481322;5027.798888044437;5232.816851410183;5245.86885327866;5253.106971814801;5262.578993680497;3584.6953008994005;3599.406097993854;3604.5221459201603;3606.1886075633297;3617.8371973261264;3658.158623516606;3662.688671462902;3666.3217304798163;3666.431703086026;3671.94492082619;4183.477065366829;4200.4959404871615;4200.705950583491;4218.388333691659;4221.598948099987;4878.121938051114;4994.350734404504;4996.7001979881325;5004.949950500449;5013.222950442687;1219.9329036902877;1226.3132645718426;1228.4901765767286;1231.6674497885522;1237.8178839208533;800.9599520023976;805.4844899264475;835.5544907310266;850.2220468271586;859.2996707683218;4146.564610715892;4311.417958575615;4400.9559904401185;4415.558444155558;4420.314851198005;5117.283580298761;5122.436531981479;5133.332666753373;5144.382674079135;5152.278680984665;4373.497047839475;4395.725239680521;4397.845055922575;4407;4407.325216417741;2518.3829961659144;2629.4757033247915;2633.7094823536713;2635.60465930112;2644.933876653099;4655.230138067845;4695.43654761424;4696.178168820443;4702.307169419007;4721.457032441244;4952.851414457572;5034.144195486776;5057.570106540985;5079.74601269935;5100.795968161232;4501.3022981437925;4783.928241076386;4840.603901068994;4844.273358996179;4855.975720121447;5129.947681129722;5145.665531740425;5162.380514338303;5169.250458683395;5172.508611681884;4892.804287828447;5060.114479966065;5075.7969681212335;5076.5431111198695;5110.361204849394;4819.2530157825595;4834.371531700856;4838.975805120952;4845.370101886732;4846.843154796223;3619.1314084618975;3631.618680038558;3640.1263696713127;3642.9089272767333;3668.963310366969;5197.272381866617;5197.92203116946;5198.792048318025;5204.947950520446;5226.163813789775;4859;4937.851864444073;4986.6509344347;4991.201407774739;5003.899922001467;4960.950390496048;4975.50244975514;4980.203167493184;4999.775010124626;5014.874628134326;4928.901421971469;4930.5069493050405;4931.728754918514;4950.4059512858685;4951.628627852998;4792.832250871203;4822.71063736177;4830.227163653799;4939.456659767495;5006.62450316235;4886.926696099633;4922.187839006524;4933.407991041098;4954.950450495449;4955.984023275148 08:37:53 INFO - PROCESS | 9280 | |5;yui.html;575.5280669850722;580.2688612348445;649.535582058828;671.7346648074011;676.6312359763929;11724.237924534898;12058;12197.756044879097;12400;12695.428705708242;12242.938785306062;13139.27733974631;13264.535741249058;13280.269585172835;13339.266340351276;791.3906292155037;800.5316889619551;805.7582725182451;806.8305655812286;807.3702512040618;656.291205498061;674.1741366825623;802.229859335039;820.5035953248289;825.3685930263354;845.5391811462737;845.5476320168711;846.2087947768825;846.2975730143996;846.7798372423183;832.1803024021334;837.2088376484224;839.1608391608391;839.2824135364236;839.937004724642;510.316176323728;520.9479052094798;522.6263221796396;524.960627952905;614.9016157414837;11729.70675733105;11990.640280791591;12105.939470302592;12122.696932576668;12123.696907577292;10730.248882578222;11640.476178571984;11728.88271117295;12048;12257.693557661041;9646.42121472714;9756.658516951873;9781.266405019582;10226.335288206243;10534.36793792375;3284.3431313737346;3293.7200337971303;3307.5534802801553;3335.8832440864453;3365.5961284646;63340;63857.68071159614;63949.360506394805;64182.35817641811;64433.67783161054;9484.525773711286;9534.856977145348;9548.854137503544;9621.807563848684;9794.677718508052;17192.22634981429;17702.114894255235;17742.379016734354;17811.643767124584;17911.283548658168;6415.166028416369;6547.934520654732;6548.083268342436;6635.966820165965;6714.865702686016;3514.4376899695926;3597.244578638463;3610.656987586175;3620.5836328822525;3693.150575367627;2749.408877091435;2824.8022638415523;2825.6891741908375;3034.2566071312226;3145.323755392556;503.13711983946973;515.8065725352992;530.9177077552986;532.1618450939785;532.2229544864541;571.8570357410647;576.9826905192851;583.8336074218827;594.1651978969554;595.6039233909488;8107.22981316774;8174.100848906615;8292.709755158541;8311.922019495127;8437.493750374875;563.2733773432309;567.8268128220932;575.7725698349212;578.3060327606888;588.8527868032992;3977.801109944491;4106.322456794655;4135.234981528427;4139.482564679415;4198.055437526593;51582.48417515777;52212.47787522152;52799;61536.69231653813;64970;57885.421145788;58399;58506.707466463246;58664.413355866745;59333.40666593365;51610;52112.73943630333;52667.47332526703;53976.73011634995;54658.726706366215;7532.435067370079;7728.3430908371165;7782.571958542108;7903.881441778493;7950.522968621901;35095;35119.44931839667;35410.29179416346;35752;36472.452913205794;40162.1967560653;40469.1906161881;41881.25196838473;41929.16141677088;43644;9774.804503910023;9872.901270987199;10090.19278457707;10155.39067655943;10231.795364092824;12026.218295810744;12119.636410907688;12122.878771212529;12808;13121.56893945435;11912.166148369877;12104.394780261127;12117.75764484723;12422.565210217599;12620.936895315464;11387.05140375037;11641.941790291334;12158.693346812272;12170.39148042612;12570.622881313575;11367.976882080322;11418.830422219751;11514;11654.766904662029;11930.343831089373;9591.42451452915;9617.759556010877;9689.370190937849;10164.84752728695;10184.898151018395;8660.696875609323;9032.63869445215;9113.179813816523;10157.441340726331;10391.48042597852 08:37:53 INFO - PROCESS | 9280 | __end_tp_report 08:37:53 INFO - PROCESS | 9280 | __start_cc_report 08:37:53 INFO - PROCESS | 9280 | _x_x_mozilla_cycle_collect,1033 08:37:53 INFO - PROCESS | 9280 | __end_cc_report 08:37:53 INFO - PROCESS | 9280 | __startTimestamp1484757473218__endTimestamp 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | ------- Summary: start ------- 08:37:53 INFO - PROCESS | 9280 | Number of tests: 6 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#0] dojo.html Cycles:165 Average:4761.86 Median:4897.71 stddev:511.34 (10.4%) stddev-sans-first:483.47 08:37:53 INFO - PROCESS | 9280 | Values: 2582.0 2609.5 2636.1 2638.0 2642.4 4713.3 4753.0 4762.4 4839.3 4899.0 4785.5 4816.6 4820.1 4829.3 4883.7 4321.8 4339.2 4372.5 4401.5 4482.3 4118.1 4348.2 4391.6 4412.2 4472.0 4303.5 4346.1 4451.4 4453.7 4519.6 4368.4 4432.1 4447.8 4451.3 4495.7 4400.3 4407.8 4414.9 4429.0 4463.4 4679.1 4831.5 4839.4 4851.4 4881.7 5043.4 5135.5 5188.5 5194.2 5272.4 5232.2 5234.3 5240.4 5241.9 5247.7 4884.4 4890.3 4891.3 4892.7 4928.2 5145.6 5151.7 5161.3 5193.6 5197.4 4928.1 4934.9 4942.0 4969.6 4992.4 4997.9 5033.4 5066.1 5073.6 5112.6 5046.0 5097.4 5131.9 5136.4 5187.2 5152.2 5167.6 5174.4 5174.7 5176.1 4385.3 4388.0 4395.5 4398.5 4434.6 3726.1 3735.5 3774.3 3819.1 3851.8 4503.6 4510.2 4513.2 4540.9 4541.4 5222.0 5238.8 5244.6 5247.0 5295.1 4391.8 4416.5 4441.0 4472.5 4486.0 4687.3 4687.5 4689.3 4718.7 4719.0 4895.0 4901.2 4902.2 4904.8 4942.3 5037.3 5084.5 5092.1 5194.6 5257.1 4788.4 4826.0 4836.9 4855.6 4897.7 5067.6 5068.1 5080.4 5084.0 5120.7 5039.1 5140.7 5160.7 5161.2 5162.2 4874.6 5051.6 5055.2 5099.9 5144.5 5006.0 5037.4 5048.1 5048.2 5093.6 4836.5 4866.3 4876.9 4952.7 5034.1 5079.3 5097.1 5106.8 5141.9 5144.4 4957.4 4979.8 4985.7 4987.0 5026.8 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#1] ext.html Cycles:180 Average:42794.71 Median:18092.02 stddev:70689.40 (390.7%) stddev-sans-first:70816.48 08:37:53 INFO - PROCESS | 9280 | Values: 533.7 542.6 553.9 569.3 581.3 27533.9 32903.7 34265.3 34362.8 36432.1 39355.4 39791.6 39792.0 39817.2 39933.2 7612.6 7785.8 7789.5 7795.6 7796.3 7388.4 7600.0 9803.9 10035.5 10050.4 10008.3 10053.4 10064.4 10073.1 10073.4 10067.6 10101.8 10102.1 10135.4 10138.5 9919.4 9989.1 9990.9 9992.4 9994.0 37212.0 37401.8 37541.4 37566.2 37568.8 3172.4 3226.6 3234.3 3272.6 3280.4 28305.0 28563.6 28646.9 29144.9 29334.0 2723.9 2801.8 2802.8 2805.3 2811.5 226515.0 226584.0 227057.0 227115.0 228044.0 45735.0 45842.0 45907.8 45914.5 45952.0 53697.2 53710.0 53768.2 53922.7 54020.7 14459.6 15087.2 15099.2 15100.5 15110.2 9668.8 11364.0 11527.9 11550.1 11553.5 13255.4 14912.7 15036.2 15273.2 15835.9 6127.4 6188.8 6263.7 6275.7 6309.1 810.2 830.5 839.8 856.5 862.1 26773.5 27530.9 27701.9 27804.9 27875.0 888.1 991.4 997.6 1010.3 1012.5 14892.3 15048.7 15135.1 15311.8 15317.1 313990.0 315195.0 316499.0 316510.0 316718.0 49298.0 49625.8 49650.8 49748.5 49929.3 1060.0 1110.4 1115.8 1118.1 1185.2 25178.7 26420.2 26789.4 27229.9 27371.5 41473.6 42028.6 42033.2 42051.6 42263.4 259703.0 262581.0 262730.0 262883.0 263075.0 28097.9 28293.4 35030.8 35374.0 35485.1 35490.8 41492.6 41719.6 41870.4 42367.0 34382.7 34992.7 35329.6 35812.8 36296.8 33767.7 33788.2 34052.5 34815.0 34988.5 33883.0 34518.7 34849.1 34854.0 34953.5 30073.4 30696.2 31416.4 31422.5 31523.7 23579.5 23876.9 23958.2 24094.3 24314.6 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#2] jquery.html Cycles:180 Average:27773.09 Median:16896.34 stddev:81579.77 (482.8%) stddev-sans-first:81782.65 08:37:53 INFO - PROCESS | 9280 | Values: 356.3 377.5 380.5 381.1 391.9 17022.0 18188.0 18430.3 18681.3 18803.9 18067.7 18127.6 18325.9 18417.0 18520.9 4943.7 5136.1 5143.6 5145.6 5147.7 4958.0 5016.6 5100.5 5137.4 5151.3 5120.7 5123.5 5125.9 5131.9 5133.6 4950.6 5091.1 5096.8 5123.0 5127.9 4604.7 4612.0 4614.5 4615.1 4621.5 20975.0 20991.8 21075.0 21220.5 21424.3 2219.0 2254.1 2269.4 2275.7 2314.8 13456.5 13524.9 13570.7 13662.3 14234.5 1715.8 1736.5 1745.1 1774.2 1819.8 76615.2 76676.0 77628.0 78053.0 78714.0 10056.5 10138.9 10147.8 10188.7 10204.6 13723.7 13921.1 13934.3 13937.3 13988.0 7479.6 7508.4 7601.7 7728.7 7752.9 7134.4 7152.8 7376.6 7395.4 7432.3 6359.2 6422.3 6426.2 6463.2 6661.9 1745.8 1849.1 1879.3 1879.6 1883.6 963.4 989.4 1000.6 1020.4 1046.6 18194.5 18263.3 18550.8 18596.3 18838.2 993.7 1003.8 1003.9 1011.6 1024.9 10043.4 10386.0 10547.9 10550.9 10609.9 492122.0 492558.0 497582.0 500419.0 501959.0 77483.2 79660.6 80561.0 80606.6 82637.0 929.8 937.1 955.8 963.0 967.3 15421.2 15511.1 16202.7 16295.7 16441.8 31477.9 34522.7 35417.5 35520.3 36185.1 45522.0 45523.5 45721.8 45874.0 48261.3 5144.0 5362.5 7104.9 7827.3 8344.2 11727.8 11779.2 12005.6 12046.8 12321.6 10296.6 10389.6 10463.9 10729.4 10793.8 10156.5 10321.4 10715.0 10726.2 10742.7 10844.7 11016.9 11083.6 11172.3 11328.4 6704.3 7103.1 7154.5 7887.1 8082.4 9665.5 10172.5 10329.2 10474.3 10493.2 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#3] mootools.html Cycles:180 Average:4503.28 Median:4522.56 stddev:2382.22 (52.7%) stddev-sans-first:2374.46 08:37:53 INFO - PROCESS | 9280 | Values: 1014.1 1313.7 1316.6 1320.0 1328.2 5912.1 6611.4 6822.0 6826.2 6908.3 6776.3 6851.8 6853.5 6889.2 6894.0 1792.4 1849.2 2056.4 2094.0 2096.5 2067.8 2117.2 2118.2 2140.4 2144.2 2044.7 2050.6 2065.6 2076.6 2080.3 2068.9 2088.5 2091.3 2092.6 2093.8 2028.6 2039.1 2088.4 2100.2 2101.6 6959.2 7006.1 7025.3 7028.8 7035.6 4168.3 4289.5 4297.6 4303.1 4307.5 2712.9 2777.7 2796.5 2832.9 2839.2 1048.2 1062.1 1121.8 1141.5 1143.6 8931.7 8949.2 8961.6 8968.1 8971.5 3710.8 3905.7 3951.6 3973.6 3975.7 7846.2 7846.8 7846.9 7847.4 7865.7 4415.0 4418.0 4423.6 4426.4 4426.5 3417.8 3519.9 3839.4 3961.7 4037.9 3316.2 3337.7 3439.3 3493.9 3508.5 1061.7 1084.6 1092.4 1100.6 1101.0 720.6 726.6 748.8 755.9 764.4 4190.4 4212.3 4318.8 4374.6 4748.7 815.0 817.3 821.9 823.0 844.7 3015.2 3056.4 3065.1 3085.7 3169.3 7842.1 8154.1 8155.1 8164.3 8171.7 8098.0 8103.4 8132.6 8192.9 8204.8 6345.9 6478.5 6494.8 6498.3 6498.6 4380.2 4488.3 4556.9 4574.8 4608.9 7271.9 7288.9 7426.1 7441.0 7495.3 7511.2 7587.7 7611.7 7645.5 7736.5 5570.2 5595.2 5689.1 5693.3 5706.1 6400.6 6410.8 6418.5 6436.4 6471.6 5758.5 5791.9 5857.5 5875.5 5926.5 5776.3 5811.7 5828.2 5858.5 5940.9 5009.2 5071.6 5108.3 5114.1 5118.0 4113.7 4145.2 4243.2 4247.8 4332.6 4115.8 4128.2 4184.6 4193.1 4316.3 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#4] prototype.html Cycles:180 Average:4141.83 Median:4711.88 stddev:1196.96 (25.4%) stddev-sans-first:1165.80 08:37:53 INFO - PROCESS | 9280 | Values: 339.8 342.1 346.2 352.4 352.9 4699.8 4799.7 4816.5 4825.0 4826.2 4752.4 4762.9 4767.9 4770.1 4778.3 3639.9 3722.5 3752.8 3794.4 3813.0 3804.1 3807.5 3809.2 3826.7 3835.6 3776.9 3778.4 3797.5 3801.9 3804.1 3637.7 3701.7 3741.0 3778.1 3795.8 3395.3 3412.7 3417.9 3427.9 3445.7 4675.0 4678.6 4686.4 4694.6 4697.5 4013.5 4157.8 4363.0 4368.0 4385.4 4915.3 4925.5 4929.1 4935.0 4950.2 3526.9 3532.8 3535.5 3576.3 3577.4 5027.8 5232.8 5245.9 5253.1 5262.6 3584.7 3599.4 3604.5 3606.2 3617.8 3658.2 3662.7 3666.3 3666.4 3671.9 4183.5 4200.5 4200.7 4218.4 4221.6 4878.1 4994.4 4996.7 5004.9 5013.2 1219.9 1226.3 1228.5 1231.7 1237.8 801.0 805.5 835.6 850.2 859.3 4146.6 4311.4 4401.0 4415.6 4420.3 5117.3 5122.4 5133.3 5144.4 5152.3 4373.5 4395.7 4397.8 4407.0 4407.3 2518.4 2629.5 2633.7 2635.6 2644.9 4655.2 4695.4 4696.2 4702.3 4721.5 4952.9 5034.1 5057.6 5079.7 5100.8 4501.3 4783.9 4840.6 4844.3 4856.0 5129.9 5145.7 5162.4 5169.3 5172.5 4892.8 5060.1 5075.8 5076.5 5110.4 4819.3 4834.4 4839.0 4845.4 4846.8 3619.1 3631.6 3640.1 3642.9 3669.0 5197.3 5197.9 5198.8 5204.9 5226.2 4859.0 4937.9 4986.7 4991.2 5003.9 4961.0 4975.5 4980.2 4999.8 5014.9 4928.9 4930.5 4931.7 4950.4 4951.6 4792.8 4822.7 4830.2 4939.5 5006.6 4886.9 4922.2 4933.4 4955.0 4956.0 08:37:53 INFO - PROCESS | 9280 | 08:37:53 INFO - PROCESS | 9280 | [#5] yui.html Cycles:180 Average:14327.51 Median:26317.68 stddev:17826.91 (67.7%) stddev-sans-first:17847.01 08:37:53 INFO - PROCESS | 9280 | Values: 575.5 580.3 649.5 671.7 676.6 11724.2 12058.0 12197.8 12400.0 12695.4 12242.9 13139.3 13264.5 13280.3 13339.3 791.4 800.5 805.8 806.8 807.4 656.3 674.2 802.2 820.5 825.4 845.5 845.5 846.2 846.3 846.8 832.2 837.2 839.2 839.3 839.9 510.3 520.9 522.6 525.0 614.9 11729.7 11990.6 12105.9 12122.7 12123.7 10730.2 11640.5 11728.9 12048.0 12257.7 9646.4 9756.7 9781.3 10226.3 10534.4 3284.3 3293.7 3307.6 3335.9 3365.6 63340.0 63857.7 63949.4 64182.4 64433.7 9484.5 9534.9 9548.9 9621.8 9794.7 17192.2 17702.1 17742.4 17811.6 17911.3 6415.2 6547.9 6548.1 6636.0 6714.9 3514.4 3597.2 3610.7 3620.6 3693.2 2749.4 2824.8 2825.7 3034.3 3145.3 503.1 515.8 530.9 532.2 532.2 571.9 577.0 583.8 594.2 595.6 8107.2 8174.1 8292.7 8311.9 8437.5 563.3 567.8 575.8 578.3 588.9 3977.8 4106.3 4135.2 4139.5 4198.1 51582.5 52212.5 52799.0 61536.7 64970.0 57885.4 58399.0 58506.7 58664.4 59333.4 51610.0 52112.7 52667.5 53976.7 54658.7 7532.4 7728.3 7782.6 7903.9 7950.5 35095.0 35119.4 35410.3 35752.0 36472.5 40162.2 40469.2 41881.3 41929.2 43644.0 9774.8 9872.9 10090.2 10155.4 10231.8 12026.2 12119.6 12122.9 12808.0 13121.6 11912.2 12104.4 12117.8 12422.6 12620.9 11387.1 11641.9 12158.7 12170.4 12570.6 11368.0 11418.8 11514.0 11654.8 11930.3 9591.4 9617.8 9689.4 10164.8 10184.9 8660.7 9032.6 9113.2 10157.4 10391.5 08:37:53 INFO - PROCESS | 9280 | -------- Summary: end -------- 08:37:53 INFO - PROCESS | 9280 | 08:37:54 INFO - TEST-INFO | 9280: exit 0 08:37:54 INFO - TEST-OK | dromaeo_css | took 1121872ms 08:37:54 INFO - TEST-START | kraken 08:37:54 INFO - operating with platform_type : linux_ 08:37:54 INFO - Initialising browser for kraken test... 08:37:54 INFO - TEST-INFO | started process 9576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQZAf6/profile http://localhost:53194/getInfo.html) 08:37:58 INFO - PROCESS | 9576 | __metrics Screen width/height:1600/1200 08:37:58 INFO - PROCESS | 9576 | colorDepth:24 08:37:58 INFO - PROCESS | 9576 | Browser inner width/height: 1024/697 08:37:58 INFO - PROCESS | 9576 | __metrics 08:37:59 INFO - PROCESS | 9576 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:37:59 INFO - PROCESS | 9576 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:38:00 INFO - PROCESS | 9576 | console.error: PushService: 08:38:00 INFO - PROCESS | 9576 | stateChangeProcessEnqueue: Error transitioning state 08:38:00 INFO - PROCESS | 9576 | UnknownError 08:38:01 INFO - TEST-INFO | 9576: exit 0 08:38:01 INFO - Browser initialized. 08:38:01 INFO - Running cycle 1/1 for kraken test... 08:38:01 INFO - TEST-INFO | started process 9656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwQZAf6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:38:13 INFO - PROCESS | 9656 | RSS: Main: 152059904 08:38:13 INFO - PROCESS | 9656 | 08:38:15 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53194/tests/kraken/driver.html?testName=audio-beat-detection) 08:38:16 INFO - PROCESS | 9656 | RSS: Main: 207196160 08:38:16 INFO - PROCESS | 9656 | 08:38:19 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53194/tests/kraken/driver.html?testName=audio-dft) 08:38:20 INFO - PROCESS | 9656 | RSS: Main: 185688064 08:38:20 INFO - PROCESS | 9656 | 08:38:23 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53194/tests/kraken/driver.html?testName=audio-fft) 08:38:23 INFO - PROCESS | 9656 | RSS: Main: 268632064 08:38:23 INFO - PROCESS | 9656 | 08:38:26 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53194/tests/kraken/driver.html?testName=audio-oscillator) 08:38:26 INFO - PROCESS | 9656 | RSS: Main: 179380224 08:38:26 INFO - PROCESS | 9656 | 08:38:28 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53194/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:38:29 INFO - PROCESS | 9656 | RSS: Main: 182513664 08:38:29 INFO - PROCESS | 9656 | 08:38:32 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53194/tests/kraken/driver.html?testName=imaging-darkroom) 08:38:33 INFO - PROCESS | 9656 | RSS: Main: 222453760 08:38:33 INFO - PROCESS | 9656 | 08:38:36 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53194/tests/kraken/driver.html?testName=imaging-desaturate) 08:38:37 INFO - PROCESS | 9656 | RSS: Main: 216416256 08:38:37 INFO - PROCESS | 9656 | 08:38:40 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53194/tests/kraken/driver.html?testName=json-parse-financial) 08:38:40 INFO - PROCESS | 9656 | RSS: Main: 217268224 08:38:40 INFO - PROCESS | 9656 | 08:38:42 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53194/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:38:43 INFO - PROCESS | 9656 | RSS: Main: 181686272 08:38:43 INFO - PROCESS | 9656 | 08:38:44 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:38:45 INFO - PROCESS | 9656 | RSS: Main: 188301312 08:38:45 INFO - PROCESS | 9656 | 08:38:47 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:38:48 INFO - PROCESS | 9656 | RSS: Main: 197128192 08:38:48 INFO - PROCESS | 9656 | 08:38:51 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:38:51 INFO - PROCESS | 9656 | RSS: Main: 207192064 08:38:51 INFO - PROCESS | 9656 | 08:38:54 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:38:55 INFO - PROCESS | 9656 | RSS: Main: 203382784 08:38:55 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | Cycle 1(1): loaded http://localhost:53194/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53194/tests/kraken/driver.html?testName=ai-astar) 08:38:57 INFO - PROCESS | 9656 | RSS: Main: 255397888 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | __start_tp_report 08:38:57 INFO - PROCESS | 9656 | _x_x_mozilla_page_load 08:38:57 INFO - PROCESS | 9656 | _x_x_mozilla_page_load_details 08:38:57 INFO - PROCESS | 9656 | |i|pagename|runs| 08:38:57 INFO - PROCESS | 9656 | |0;ai-astar;113;116;114;114;115;115;113;116;115;115 08:38:57 INFO - PROCESS | 9656 | |1;audio-beat-detection;160;130;124;174;129;124;125;130;146;125 08:38:57 INFO - PROCESS | 9656 | |2;audio-dft;161;161;161;161;161;162;162;162;162;162 08:38:57 INFO - PROCESS | 9656 | |3;audio-fft;74;76;75;102;78;76;76;76;94;76 08:38:57 INFO - PROCESS | 9656 | |4;audio-oscillator;83;83;118;84;83;83;99;83;83;107 08:38:57 INFO - PROCESS | 9656 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:38:57 INFO - PROCESS | 9656 | |6;imaging-darkroom;149;149;149;149;150;149;148;149;148;149 08:38:57 INFO - PROCESS | 9656 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;96 08:38:57 INFO - PROCESS | 9656 | |8;json-parse-financial;62;61;60;61;63;62;61;61;62;62 08:38:57 INFO - PROCESS | 9656 | |9;json-stringify-tinderbox;66;68;67;67;68;68;67;67;68;68 08:38:57 INFO - PROCESS | 9656 | |10;stanford-crypto-aes;84;92;85;84;84;84;84;84;84;84 08:38:57 INFO - PROCESS | 9656 | |11;stanford-crypto-ccm;134;133;132;135;132;143;135;140;175;140 08:38:57 INFO - PROCESS | 9656 | |12;stanford-crypto-pbkdf2;173;175;175;175;174;172;174;179;175;173 08:38:57 INFO - PROCESS | 9656 | |13;stanford-crypto-sha256-iterative;71;72;66;67;67;68;67;67;67;66 08:38:57 INFO - PROCESS | 9656 | __end_tp_report 08:38:57 INFO - PROCESS | 9656 | __start_cc_report 08:38:57 INFO - PROCESS | 9656 | _x_x_mozilla_cycle_collect,1814 08:38:57 INFO - PROCESS | 9656 | __end_cc_report 08:38:57 INFO - PROCESS | 9656 | __startTimestamp1484757537516__endTimestamp 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | ------- Summary: start ------- 08:38:57 INFO - PROCESS | 9656 | Number of tests: 14 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:1.07 (0.9%) stddev-sans-first:0.97 08:38:57 INFO - PROCESS | 9656 | Values: 113.0 116.0 114.0 114.0 115.0 115.0 113.0 116.0 115.0 115.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:130.00 stddev:17.53 (13.5%) stddev-sans-first:16.44 08:38:57 INFO - PROCESS | 9656 | Values: 160.0 130.0 124.0 174.0 129.0 124.0 125.0 130.0 146.0 125.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 08:38:57 INFO - PROCESS | 9656 | Values: 161.0 161.0 161.0 161.0 161.0 162.0 162.0 162.0 162.0 162.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:9.57 (12.6%) stddev-sans-first:9.87 08:38:57 INFO - PROCESS | 9656 | Values: 74.0 76.0 75.0 102.0 78.0 76.0 76.0 76.0 94.0 76.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:83.00 stddev:12.83 (15.5%) stddev-sans-first:13.31 08:38:57 INFO - PROCESS | 9656 | Values: 83.0 83.0 118.0 84.0 83.0 83.0 99.0 83.0 83.0 107.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:38:57 INFO - PROCESS | 9656 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:38:57 INFO - PROCESS | 9656 | Values: 149.0 149.0 149.0 149.0 150.0 149.0 148.0 149.0 148.0 149.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:38:57 INFO - PROCESS | 9656 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:62.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 08:38:57 INFO - PROCESS | 9656 | Values: 62.0 61.0 60.0 61.0 63.0 62.0 61.0 61.0 62.0 62.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 08:38:57 INFO - PROCESS | 9656 | Values: 66.0 68.0 67.0 67.0 68.0 68.0 67.0 67.0 68.0 68.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:2.51 (3.0%) stddev-sans-first:2.65 08:38:57 INFO - PROCESS | 9656 | Values: 84.0 92.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:137.50 stddev:12.90 (9.4%) stddev-sans-first:13.50 08:38:57 INFO - PROCESS | 9656 | Values: 134.0 133.0 132.0 135.0 132.0 143.0 135.0 140.0 175.0 140.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:1.90 (1.1%) stddev-sans-first:1.94 08:38:57 INFO - PROCESS | 9656 | Values: 173.0 175.0 175.0 175.0 174.0 172.0 174.0 179.0 175.0 173.0 08:38:57 INFO - PROCESS | 9656 | 08:38:57 INFO - PROCESS | 9656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:2.04 (3.1%) stddev-sans-first:1.81 08:38:57 INFO - PROCESS | 9656 | Values: 71.0 72.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 66.0 08:38:57 INFO - PROCESS | 9656 | -------- Summary: end -------- 08:38:57 INFO - PROCESS | 9656 | 08:38:59 INFO - TEST-INFO | 9656: exit 0 08:38:59 INFO - TEST-OK | kraken | took 65145ms 08:38:59 INFO - SUITE-END | took 1187s 08:38:59 INFO - Completed test suite (00:19:47) 08:38:59 INFO - javascript benchmark 08:38:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.044643481912, 2609.5302845487827, 2636.1432534426317, 2637.986810065949, 2642.3526236072166, 4713.293006049086, 4753.027042571966, 4762.404699412574, 4839.346688197093, 4899.0, 4785.5214478552125, 4816.590589799863, 4820.084184005045, 4829.299751536034, 4883.658143929926, 4321.805518751664, 4339.19724850902, 4372.453443319585, 4401.493828209749, 4482.260427029536, 4118.114342246972, 4348.152110338485, 4391.5827996340295, 4412.205802955466, 4472.038511719979, 4303.483581970152, 4346.1090476452255, 4451.354553589744, 4453.688241823073, 4519.570640789137, 4368.410264614268, 4432.135733531963, 4447.7776111194635, 4451.2655411857, 4495.707778994355, 4400.251957167289, 4407.801648925806, 4414.889627759299, 4428.955710442887, 4463.352813841975, 4679.087577922306, 4831.516848315176, 4839.44346400165, 4851.393575803025, 4881.731504767236, 5043.42000669924, 5135.537801597874, 5188.507091826308, 5194.194899790538, 5272.393674727417, 5232.189010703347, 5234.293370394986, 5240.4497527759795, 5241.895162096775, 5247.685138891678, 4884.389451318585, 4890.2909078184175, 4891.290762839369, 4892.706437613754, 4928.186849169882, 5145.588352931756, 5151.665141765773, 5161.303224064778, 5193.558547523503, 5197.428282888879, 4928.112939670894, 4934.9013019739405, 4942.0, 4969.552740253394, 4992.425871024806, 4997.85006449807, 5033.395992480926, 5066.113430149709, 5073.619478539124, 5112.590992720573, 5046.041252162077, 5097.388313402415, 5131.871703207375, 5136.383633963874, 5187.19598462239, 5152.20140878157, 5167.560757335594, 5174.353205849269, 5174.741262936838, 5176.094183517869, 4385.320275357325, 4387.956120438818, 4395.472543294761, 4398.516163222043, 4434.645228381722, 3726.06848287928, 3735.4957080793747, 3774.3206222880144, 3819.083419979185, 3851.768893866377, 4503.639708823286, 4510.188166130128, 4513.232750432434, 4540.931886021713, 4541.409616749801, 5222.0, 5238.7904483820985, 5244.580433565306, 5247.0, 5295.073362161684, 4391.8462853799965, 4416.514183439819, 4441.045175287264, 4472.530384309601, 4485.9775701121935, 4687.2500399936525, 4687.531246875285, 4689.320048592935, 4718.669693121448, 4718.95281047192, 4895.04546613407, 4901.191303434894, 4902.1911384621135, 4904.803807847647, 4942.332785074041, 5037.319961805256, 5084.491550844886, 5092.0579692756955, 5194.636375453682, 5257.053730328577, 4788.449328327287, 4825.9865428260455, 4836.927446088382, 4855.562999329936, 4897.706137631753, 5067.569256613229, 5068.138416469283, 5080.415752188545, 5084.0, 5120.743962801919, 5039.143345631178, 5140.691558506502, 5160.741962901915, 5161.174212126042, 5162.199859021857, 4874.6344024197615, 5051.646384753032, 5055.191169412877, 5099.898002040012, 5144.4855514449755, 5006.048850718352, 5037.445880953019, 5048.066107770074, 5048.167052436307, 5093.567046800915, 4836.492168322417, 4866.270059491105, 4876.853694389174, 4952.702837829742, 5034.09386310453, 5079.339685840817, 5097.082525145361, 5106.795728170831, 5141.871453213699, 5144.408393034849, 4957.355543779286, 4979.751012449436, 4985.725785081855, 4987.027529631687, 5026.84919452417], "value": 4727.918678729401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.6984603698908, 542.6255883440429, 553.8643032457048, 569.3225062176012, 581.2966310763977, 27533.862330688342, 32903.67096329036, 34265.31469370611, 34362.8281858591, 36432.08919777007, 39355.40966885499, 39791.60208397915, 39792.0, 39817.20365592687, 39933.20133597327, 7612.581308028056, 7785.805354866117, 7789.493682910621, 7795.6491957861745, 7796.337311328544, 7388.445866560002, 7599.962000189991, 9803.852942205873, 10035.548400321966, 10050.396976181415, 10008.297759604902, 10053.447060411674, 10064.39613623185, 10073.093421592055, 10073.44596047217, 10067.59053732478, 10101.848472272923, 10102.141317987944, 10135.391876487434, 10138.493075346203, 9919.355241909252, 9989.10098091168, 9990.90009099907, 9992.350497217658, 9993.950635183273, 37212.0, 37401.81299093487, 37541.436878446846, 37566.24867502635, 37568.81215593932, 3172.397244523533, 3226.58054452922, 3234.256121092162, 3272.640009598942, 3280.3603297357026, 28305.0, 28563.57154642682, 28646.85676571604, 29144.854275728696, 29334.0, 2723.945521089567, 2801.7898657600763, 2802.7757779377603, 2805.340744924941, 2811.5360965440677, 226515.0, 226584.0, 227057.0, 227115.0, 228044.0, 45735.0, 45842.0, 45907.770461147484, 45914.540854591694, 45952.0, 53697.1945420819, 53710.0, 53768.19347709788, 53922.730386347816, 54020.72989635027, 14459.566213013626, 15087.170205638577, 15099.169545675093, 15100.471483498024, 15110.244487775568, 9668.806623867484, 11364.0, 11527.94509454995, 11550.075993920465, 11553.480093395818, 13255.403506842214, 14912.70174596502, 15036.248187590576, 15273.236338183046, 15835.920820396055, 6127.4485296322655, 6188.783392581238, 6263.71813268404, 6275.748970041239, 6309.116723658692, 810.1574362662883, 830.4560512864084, 839.7942504086416, 856.4604299291531, 862.1249431826701, 26773.464530709276, 27530.862345688143, 27701.861490692416, 27804.86097569499, 27875.0, 888.071964796776, 991.4299277915228, 997.6059456514636, 1010.2927950434726, 1012.4532752313668, 14892.329845156994, 15048.699026019418, 15135.091894486366, 15311.846881531264, 15317.080975141527, 313990.0, 315195.0, 316499.0, 316510.0, 316718.0, 49298.0, 49625.75187124041, 49650.75174624176, 49748.50251497511, 49929.251061234114, 1059.9788004240027, 1110.3892858927557, 1115.7991561518843, 1118.0720002398152, 1185.247367921359, 25178.74821251764, 26420.20739377822, 26789.374231410842, 27229.86385068062, 27371.45257094807, 41473.585264146976, 42028.57971420247, 42033.159336813704, 42051.57948420599, 42263.366049509896, 259703.0, 262581.0, 262730.0, 262883.0, 263075.0, 28097.859510702314, 28293.43413131767, 35030.824845875606, 35374.0, 35485.11287217737, 35490.8225458871, 41492.585074148876, 41719.58280417157, 41870.37194442025, 42367.0, 34382.65617343794, 34992.65007349894, 35329.646703532635, 35812.82093589516, 36296.81851590725, 33767.662323376455, 33788.15529611681, 34052.489212661334, 34815.0, 34988.47517287192, 33883.0, 34518.65481345155, 34849.12877178091, 34854.0, 34953.47569786506, 30073.398532029674, 30696.232594185323, 31416.37167256688, 31422.528662070545, 31523.684763152076, 23579.467334623194, 23876.880615596812, 23958.161464348665, 24094.277171684877, 24314.635280470455], "value": 17223.602766425865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2785359646717, 377.5337458239076, 380.4901432081012, 381.09489961341814, 391.9314120028996, 17022.0, 18188.0, 18430.26278948844, 18681.252749890005, 18803.905980470114, 18067.728984065216, 18127.637447251047, 18325.908370458128, 18417.0, 18520.907395463004, 4943.728094954767, 5136.075506408845, 5143.562797162245, 5145.562627176694, 5147.691138531682, 4957.950420495785, 5016.623753218523, 5100.515451032146, 5137.434882162959, 5151.330327057477, 5120.667156634825, 5123.487651234866, 5125.871853203663, 5131.923021154686, 5133.614978876581, 4950.6287028472825, 5091.134507133777, 5096.847094587187, 5122.974385128088, 5127.9230811537855, 4604.6776725629215, 4611.976940115312, 4614.469336026333, 4615.076984603059, 4621.491635920046, 20975.0, 20991.790082099134, 21075.0, 21220.469488262763, 21424.250151244632, 2218.966715499269, 2254.1208928517726, 2269.3986093685185, 2275.681404603357, 2314.780095890888, 13456.529021484299, 13524.864751352558, 13570.660733481644, 13662.292213473316, 14234.501792437215, 1715.8198389169083, 1736.496416039347, 1745.1187150488922, 1774.2370780564352, 1819.8362147406797, 76615.23384766192, 76676.0, 77628.0, 78052.99999999943, 78714.0, 10056.497175141214, 10138.898611013943, 10147.847782283272, 10188.745281368025, 10204.591816327413, 13723.725525489433, 13921.095128816594, 13934.303284835718, 13937.303134843218, 13988.0, 7479.551226926402, 7508.3993280537425, 7601.695932162652, 7728.729494467779, 7752.883706744404, 7134.393576545948, 7152.785416437515, 7376.557406555624, 7395.4083673306, 7432.3310902019075, 6359.17330747, 6422.325655806073, 6426.164598602152, 6463.15978922737, 6661.9000714989315, 1745.825417458244, 1849.1309084730156, 1879.2670858364975, 1879.614678990831, 1883.5573640194543, 963.3882484622316, 989.4261328429494, 1000.5897581991348, 1020.3776890685208, 1046.612753281291, 18194.45416637503, 18263.269469221348, 18550.814491855177, 18596.25614975386, 18838.24647014104, 993.6969224386487, 1003.7691330993912, 1003.8895721470633, 1011.5599714124379, 1024.933379330341, 10043.4476103815, 10386.0, 10547.894521054692, 10550.89449105499, 10609.946950265354, 492122.0, 492558.0, 497582.0, 500419.0, 501959.0, 77483.22516774872, 79660.60169699231, 80561.0, 80606.59696701597, 82637.0, 929.8279818233649, 937.1144268666181, 955.8375076237056, 962.956666949989, 967.2793768642406, 15421.151836649093, 15511.146886920877, 16202.67594648124, 16295.689607814777, 16441.753373699165, 31477.898273560317, 34522.65477345295, 35417.468737969466, 35520.28959420849, 36185.0953726159, 45522.0, 45523.54476455193, 45721.77139114283, 45874.0, 48261.27608085952, 5144.0, 5362.490563396471, 7104.934259861062, 7827.295543401121, 8344.165583441607, 11727.765444690887, 11779.234349767237, 12005.579804706793, 12046.75906481883, 12321.568745093879, 10296.639617613648, 10389.584416623251, 10463.895361046292, 10729.356238625707, 10793.838092428463, 10156.49217539135, 10321.432321222404, 10715.035646791826, 10726.202694193687, 10742.73143171427, 10844.67465976022, 11016.944915275373, 11083.612073577386, 11172.273802202832, 11328.433578321215, 6704.329567043256, 7103.147622285359, 7154.463415243981, 7887.132415434183, 8082.434229603871, 9665.516724163905, 10172.542235599563, 10329.173666106844, 10474.266801323834, 10493.160547156056], "value": 8615.479626013053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1014.1227837920192, 1313.7438199551086, 1316.552372193454, 1319.9736005279894, 1328.1831673520785, 5912.083627037805, 6611.4049735523795, 6822.044913712084, 6826.214985276694, 6908.274631163731, 6776.2546119926765, 6851.828704282396, 6853.451723862092, 6889.207741109762, 6893.965530172342, 1792.3995461520406, 1849.2325684840775, 2056.362527616436, 2094.0158125680905, 2096.5178009057927, 2067.7725450200464, 2117.2060477321006, 2118.184498967893, 2140.422086036769, 2144.1637761273114, 2044.7341845560056, 2050.5591297870956, 2065.648839697255, 2076.6262072826885, 2080.282302605606, 2068.937931862039, 2088.4883203615213, 2091.278508914422, 2092.591944570809, 2093.811556959881, 2028.6348457277684, 2039.0926037913134, 2088.446561661161, 2100.1809294375207, 2101.6006958677804, 6959.1996920353795, 7006.089208402926, 7025.332593403618, 7028.824279393005, 7035.577865328097, 4168.312228482297, 4289.52815190332, 4297.613214810651, 4303.139372125587, 4307.547707490699, 2712.905048323319, 2777.652793400825, 2796.5106106431494, 2832.900848470314, 2839.219214715949, 1048.1719441641094, 1062.102523367753, 1121.820508718601, 1141.452102990569, 1143.5540139345662, 8931.73204803857, 8949.194572488508, 8961.59672814725, 8968.148025937526, 8971.50656713887, 3710.8330125144435, 3905.746126501825, 3951.6443520082757, 3973.6026397360033, 3975.7216994810087, 7846.215378462108, 7846.803829904298, 7846.9215307847335, 7847.411444141712, 7865.724699635485, 4414.955850441519, 4417.955820441754, 4423.60187583119, 4426.402435671208, 4426.490953540384, 3417.7607567470536, 3519.859205631746, 3839.4240863870086, 3961.742486738353, 4037.8788636340955, 3316.1875340541237, 3337.732981361485, 3439.2949445364143, 3493.9301213975577, 3508.491268766015, 1061.7080302916759, 1084.5661735305941, 1092.3664274720802, 1100.6422912553453, 1100.9834852477059, 720.585663243637, 726.6148941061246, 748.8240263538064, 755.8903958925926, 764.399946042354, 4190.371444283382, 4212.283911735012, 4318.818996406857, 4374.606285434326, 4748.667593268438, 814.9877751833727, 817.3012074676067, 821.9013718353835, 822.9711960081369, 844.7254642241296, 3015.1557563882147, 3056.3581647853757, 3065.1417603071177, 3085.7222849943614, 3169.2869104451315, 7842.137364889858, 8154.103048664642, 8155.143709910492, 8164.306033987177, 8171.67313307473, 8097.959510202411, 8103.351731861437, 8132.634031468599, 8192.918070819334, 8204.794880128045, 6345.873082538324, 6478.546501744927, 6494.837629059217, 6498.317676643885, 6498.577592456475, 4380.233459144701, 4488.259437192826, 4556.863294101182, 4574.794134264032, 4608.907821843612, 7271.927280727125, 7288.854222915406, 7426.108866936002, 7441.0, 7495.325420712162, 7511.248875112445, 7587.734429294948, 7611.657475413509, 7645.541267523967, 7736.4584479085925, 5570.2201691762375, 5595.244641973281, 5689.089745640677, 5693.3168019837885, 5706.115552089433, 6400.55196136266, 6410.839729006812, 6418.486521078209, 6436.420722135031, 6471.579347342407, 5758.539316854725, 5791.9131213031, 5857.502112320501, 5875.529957603296, 5926.4666180044005, 5776.306843178677, 5811.709414529341, 5828.154917536848, 5858.502027327554, 5940.851478713067, 5009.198528235464, 5071.594272458121, 5108.263190515243, 5114.053900028507, 5117.974410127926, 4113.732607380511, 4145.17096580679, 4243.151369726005, 4247.830086796617, 4332.6317263033, 4115.794210289533, 4128.2156390285745, 4184.581541845912, 4193.098483825992, 4316.309390497506], "value": 3715.9005647668573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.7791435566881, 342.1275746845543, 346.248640450223, 352.4308242188864, 352.8782570013346, 4699.788509517071, 4799.66402351835, 4816.470188279286, 4825.0, 4826.227803551433, 4752.382190315263, 4762.8571142865685, 4767.928481072787, 4770.141374552588, 4778.331033655282, 3639.927201455963, 3722.497462842509, 3752.774833509998, 3794.4118661607495, 3812.9618703812885, 3804.0870191154063, 3807.534099371748, 3809.2191100824266, 3826.693864490848, 3835.5589107252604, 3776.9433458498142, 3778.376567866299, 3797.468354430382, 3801.9164538106647, 3804.08701911542, 3637.6726094651476, 3701.68535674468, 3740.962590374102, 3778.1310298631192, 3795.772253664789, 3395.303962687643, 3412.692857642799, 3417.8974630761118, 3427.880024199166, 3445.707114895237, 4674.976625116887, 4678.602318802906, 4686.390769199982, 4694.624430045588, 4697.53024697531, 4013.518377794654, 4157.792110394468, 4362.956370436286, 4367.951691593995, 4385.386045953569, 4915.3364295819965, 4925.458199598042, 4929.112759703252, 4934.950650493521, 4950.232713929347, 3526.876559320437, 3532.7880327180196, 3535.5403797506415, 3576.302620988908, 3577.4454959481322, 5027.798888044437, 5232.816851410183, 5245.86885327866, 5253.106971814801, 5262.578993680497, 3584.6953008994005, 3599.406097993854, 3604.5221459201603, 3606.1886075633297, 3617.8371973261264, 3658.158623516606, 3662.688671462902, 3666.3217304798163, 3666.431703086026, 3671.94492082619, 4183.477065366829, 4200.4959404871615, 4200.705950583491, 4218.388333691659, 4221.598948099987, 4878.121938051114, 4994.350734404504, 4996.7001979881325, 5004.949950500449, 5013.222950442687, 1219.9329036902877, 1226.3132645718426, 1228.4901765767286, 1231.6674497885522, 1237.8178839208533, 800.9599520023976, 805.4844899264475, 835.5544907310266, 850.2220468271586, 859.2996707683218, 4146.564610715892, 4311.417958575615, 4400.9559904401185, 4415.558444155558, 4420.314851198005, 5117.283580298761, 5122.436531981479, 5133.332666753373, 5144.382674079135, 5152.278680984665, 4373.497047839475, 4395.725239680521, 4397.845055922575, 4407.0, 4407.325216417741, 2518.3829961659144, 2629.4757033247915, 2633.7094823536713, 2635.60465930112, 2644.933876653099, 4655.230138067845, 4695.43654761424, 4696.178168820443, 4702.307169419007, 4721.457032441244, 4952.851414457572, 5034.144195486776, 5057.570106540985, 5079.74601269935, 5100.795968161232, 4501.3022981437925, 4783.928241076386, 4840.603901068994, 4844.273358996179, 4855.975720121447, 5129.947681129722, 5145.665531740425, 5162.380514338303, 5169.250458683395, 5172.508611681884, 4892.804287828447, 5060.114479966065, 5075.7969681212335, 5076.5431111198695, 5110.361204849394, 4819.2530157825595, 4834.371531700856, 4838.975805120952, 4845.370101886732, 4846.843154796223, 3619.1314084618975, 3631.618680038558, 3640.1263696713127, 3642.9089272767333, 3668.963310366969, 5197.272381866617, 5197.92203116946, 5198.792048318025, 5204.947950520446, 5226.163813789775, 4859.0, 4937.851864444073, 4986.6509344347, 4991.201407774739, 5003.899922001467, 4960.950390496048, 4975.50244975514, 4980.203167493184, 4999.775010124626, 5014.874628134326, 4928.901421971469, 4930.5069493050405, 4931.728754918514, 4950.4059512858685, 4951.628627852998, 4792.832250871203, 4822.71063736177, 4830.227163653799, 4939.456659767495, 5006.62450316235, 4886.926696099633, 4922.187839006524, 4933.407991041098, 4954.950450495449, 4955.984023275148], "value": 3771.574371718005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.5280669850722, 580.2688612348445, 649.535582058828, 671.7346648074011, 676.6312359763929, 11724.237924534898, 12058.0, 12197.756044879097, 12400.0, 12695.428705708242, 12242.938785306062, 13139.27733974631, 13264.535741249058, 13280.269585172835, 13339.266340351276, 791.3906292155037, 800.5316889619551, 805.7582725182451, 806.8305655812286, 807.3702512040618, 656.291205498061, 674.1741366825623, 802.229859335039, 820.5035953248289, 825.3685930263354, 845.5391811462737, 845.5476320168711, 846.2087947768825, 846.2975730143996, 846.7798372423183, 832.1803024021334, 837.2088376484224, 839.1608391608391, 839.2824135364236, 839.937004724642, 510.316176323728, 520.9479052094798, 522.6263221796396, 524.960627952905, 614.9016157414837, 11729.70675733105, 11990.640280791591, 12105.939470302592, 12122.696932576668, 12123.696907577292, 10730.248882578222, 11640.476178571984, 11728.88271117295, 12048.0, 12257.693557661041, 9646.42121472714, 9756.658516951873, 9781.266405019582, 10226.335288206243, 10534.36793792375, 3284.3431313737346, 3293.7200337971303, 3307.5534802801553, 3335.8832440864453, 3365.5961284646, 63340.0, 63857.68071159614, 63949.360506394805, 64182.35817641811, 64433.67783161054, 9484.525773711286, 9534.856977145348, 9548.854137503544, 9621.807563848684, 9794.677718508052, 17192.22634981429, 17702.114894255235, 17742.379016734354, 17811.643767124584, 17911.283548658168, 6415.166028416369, 6547.934520654732, 6548.083268342436, 6635.966820165965, 6714.865702686016, 3514.4376899695926, 3597.244578638463, 3610.656987586175, 3620.5836328822525, 3693.150575367627, 2749.408877091435, 2824.8022638415523, 2825.6891741908375, 3034.2566071312226, 3145.323755392556, 503.13711983946973, 515.8065725352992, 530.9177077552986, 532.1618450939785, 532.2229544864541, 571.8570357410647, 576.9826905192851, 583.8336074218827, 594.1651978969554, 595.6039233909488, 8107.22981316774, 8174.100848906615, 8292.709755158541, 8311.922019495127, 8437.493750374875, 563.2733773432309, 567.8268128220932, 575.7725698349212, 578.3060327606888, 588.8527868032992, 3977.801109944491, 4106.322456794655, 4135.234981528427, 4139.482564679415, 4198.055437526593, 51582.48417515777, 52212.47787522152, 52799.0, 61536.69231653813, 64970.0, 57885.421145788, 58399.0, 58506.707466463246, 58664.413355866745, 59333.40666593365, 51610.0, 52112.73943630333, 52667.47332526703, 53976.73011634995, 54658.726706366215, 7532.435067370079, 7728.3430908371165, 7782.571958542108, 7903.881441778493, 7950.522968621901, 35095.0, 35119.44931839667, 35410.29179416346, 35752.0, 36472.452913205794, 40162.1967560653, 40469.1906161881, 41881.25196838473, 41929.16141677088, 43644.0, 9774.804503910023, 9872.901270987199, 10090.19278457707, 10155.39067655943, 10231.795364092824, 12026.218295810744, 12119.636410907688, 12122.878771212529, 12808.0, 13121.56893945435, 11912.166148369877, 12104.394780261127, 12117.75764484723, 12422.565210217599, 12620.936895315464, 11387.05140375037, 11641.941790291334, 12158.693346812272, 12170.39148042612, 12570.622881313575, 11367.976882080322, 11418.830422219751, 11514.0, 11654.766904662029, 11930.343831089373, 9591.42451452915, 9617.759556010877, 9689.370190937849, 10164.84752728695, 10184.898151018395, 8660.696875609323, 9032.63869445215, 9113.179813816523, 10157.441340726331, 10391.48042597852], "value": 6107.7853917422535, "unit": "score"}], "name": "dromaeo_css", "value": 6257.963581352027, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 114.0, 114.0, 115.0, 115.0, 113.0, 116.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 124.0, 174.0, 129.0, 124.0, 125.0, 130.0, 146.0, 125.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 102.0, 78.0, 76.0, 76.0, 76.0, 94.0, 76.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 118.0, 84.0, 83.0, 83.0, 99.0, 83.0, 83.0, 107.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 150.0, 149.0, 148.0, 149.0, 148.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 63.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 92.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 132.0, 135.0, 132.0, 143.0, 135.0, 140.0, 175.0, 140.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 175.0, 175.0, 174.0, 172.0, 174.0, 179.0, 175.0, 173.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1540.8000000000002, "alertThreshold": 2.0}]} 08:38:59 INFO - Return code: 0 08:38:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:38:59 ERROR - # TBPL SUCCESS # 08:38:59 INFO - Running post-action listener: _resource_record_post_action 08:38:59 INFO - [mozharness: 2017-01-18 16:38:59.805051Z] Finished run-tests step (success) 08:38:59 INFO - Running post-run listener: _resource_record_post_run 08:38:59 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 392802304; Read time: 0; Write time: 1065820 08:38:59 INFO - TinderboxPrint: CPU usage
13.1% 08:38:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:38:59 INFO - TinderboxPrint: I/O write bytes / time
392,802,304 / 1,065,820 08:38:59 INFO - TinderboxPrint: CPU idle
8,346.3 (86.8%) 08:38:59 INFO - TinderboxPrint: CPU user
1,210.9 (12.6%) 08:38:59 INFO - TinderboxPrint: Swap in / out
0 / 0 08:38:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99995648; Read time: 0; Write time: 329876 08:38:59 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292806656; Read time: 0; Write time: 735944 08:39:00 INFO - Running post-run listener: _upload_blobber_files 08:39:00 INFO - Blob upload gear active. 08:39:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:39:00 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 08:39:00 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'] 08:39:00 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 08:39:00 INFO - (blobuploader) - INFO - Open directory for files ... 08:39:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:39:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:39:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:01 INFO - (blobuploader) - INFO - Done attempting. 08:39:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:39:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:05 INFO - (blobuploader) - INFO - Done attempting. 08:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:39:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:05 INFO - (blobuploader) - INFO - Done attempting. 08:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:39:06 INFO - (blobuploader) - INFO - Done attempting. 08:39:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:39:06 INFO - Return code: 0 08:39:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:39:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:39:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacfdbe2dea5601f776c9267e5ff9958494db08374273537b285756a57c4f9c2753fbe26d1b577a287565f73c1f5341a82758a26a836edc39c72e3b84a382ffe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fa009301a003a829269ebed4d5b48b077ce780d3e8953b5b78a9f191c5651e6275db819cdadd7a86eb68d66edb42dd5f14de0fc570b338ea058890014c3cdd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06744890fc6cec06b42348e98f1d4ee135c8c25f635bccb74a257a1a48937883bbe01d6eab7e4de8cfe2c8020d4ec9c3f7f0c3cfb73c5b15a30484c46e618157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d9bf397597ef97060577ad8a9f9ed0a8612b7c82d915344f444f1138bb7fea509baf5027a2e85648d8c8ccebe9be872832c88c21a14138ec1155ecce04af9fd"} 08:39:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:39:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:39:06 INFO - Contents: 08:39:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacfdbe2dea5601f776c9267e5ff9958494db08374273537b285756a57c4f9c2753fbe26d1b577a287565f73c1f5341a82758a26a836edc39c72e3b84a382ffe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fa009301a003a829269ebed4d5b48b077ce780d3e8953b5b78a9f191c5651e6275db819cdadd7a86eb68d66edb42dd5f14de0fc570b338ea058890014c3cdd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06744890fc6cec06b42348e98f1d4ee135c8c25f635bccb74a257a1a48937883bbe01d6eab7e4de8cfe2c8020d4ec9c3f7f0c3cfb73c5b15a30484c46e618157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d9bf397597ef97060577ad8a9f9ed0a8612b7c82d915344f444f1138bb7fea509baf5027a2e85648d8c8ccebe9be872832c88c21a14138ec1155ecce04af9fd"} 08:39:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:39:06 INFO - Copying logs to upload dir... 08:39:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:39:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.571944 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-01-18 08:39:06.511524) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:39:06.515067) ========= 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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacfdbe2dea5601f776c9267e5ff9958494db08374273537b285756a57c4f9c2753fbe26d1b577a287565f73c1f5341a82758a26a836edc39c72e3b84a382ffe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fa009301a003a829269ebed4d5b48b077ce780d3e8953b5b78a9f191c5651e6275db819cdadd7a86eb68d66edb42dd5f14de0fc570b338ea058890014c3cdd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06744890fc6cec06b42348e98f1d4ee135c8c25f635bccb74a257a1a48937883bbe01d6eab7e4de8cfe2c8020d4ec9c3f7f0c3cfb73c5b15a30484c46e618157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d9bf397597ef97060577ad8a9f9ed0a8612b7c82d915344f444f1138bb7fea509baf5027a2e85648d8c8ccebe9be872832c88c21a14138ec1155ecce04af9fd"} build_url:https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/K57oZb2JSyepiuzZMrfybQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cacfdbe2dea5601f776c9267e5ff9958494db08374273537b285756a57c4f9c2753fbe26d1b577a287565f73c1f5341a82758a26a836edc39c72e3b84a382ffe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2fa009301a003a829269ebed4d5b48b077ce780d3e8953b5b78a9f191c5651e6275db819cdadd7a86eb68d66edb42dd5f14de0fc570b338ea058890014c3cdd6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/06744890fc6cec06b42348e98f1d4ee135c8c25f635bccb74a257a1a48937883bbe01d6eab7e4de8cfe2c8020d4ec9c3f7f0c3cfb73c5b15a30484c46e618157", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5d9bf397597ef97060577ad8a9f9ed0a8612b7c82d915344f444f1138bb7fea509baf5027a2e85648d8c8ccebe9be872832c88c21a14138ec1155ecce04af9fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-18 08:39:06.540122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:39:06.540452) ========= 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=8783db0840cc980e80bb0bd400000236-1484756291.322537-801791032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-18 08:39:06.625784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:39:06.626329) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-18 08:39:06.626864) ========= ========= Total master_lag: 0.18 =========