builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1486632930.48 results: success (0) revision: eae7e45deb55defb86c7c30fdfcf20c5d017b98d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.483974) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.484401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.484691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.499106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.499392) ========= 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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 01:35:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-02-09 01:35:31 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.584649) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.585175) ========= 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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015561 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.635376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:30.635783) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eae7e45deb55defb86c7c30fdfcf20c5d017b98d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev eae7e45deb55defb86c7c30fdfcf20c5d017b98d --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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 01:35:31,225 truncating revision to first 12 chars 2017-02-09 01:35:31,225 Setting DEBUG logging. 2017-02-09 01:35:31,225 attempt 1/10 2017-02-09 01:35:31,225 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/eae7e45deb55?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 01:35:31,875 unpacking tar archive at: mozilla-aurora-eae7e45deb55/testing/mozharness/ program finished with exit code 0 elapsedTime=0.942533 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:31.591435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:31.591771) ========= script_repo_revision: eae7e45deb55defb86c7c30fdfcf20c5d017b98d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:31.592135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:31.592399) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 01:35:31.602019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-02-09 01:35:31.602360) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:35:32 INFO - MultiFileLogger online at 20170209 01:35:32 in /builds/slave/test 01:35:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:35:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:35:32 INFO - {'append_to_log': False, 01:35:32 INFO - 'base_work_dir': '/builds/slave/test', 01:35:32 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:35:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:35:32 INFO - 'branch': 'Mozilla-Aurora', 01:35:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:35:32 INFO - 'config_files': ('talos/linux_config.py',), 01:35:32 INFO - 'default_actions': ('clobber', 01:35:32 INFO - 'read-buildbot-config', 01:35:32 INFO - 'download-and-extract', 01:35:32 INFO - 'populate-webroot', 01:35:32 INFO - 'create-virtualenv', 01:35:32 INFO - 'install', 01:35:32 INFO - 'run-tests'), 01:35:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:35:32 INFO - 'download_minidump_stackwalk': True, 01:35:32 INFO - 'download_symbols': 'ondemand', 01:35:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:35:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:35:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:35:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:35:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:35:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:35:32 INFO - 'installer_path': 'installer.exe', 01:35:32 INFO - 'log_level': 'info', 01:35:32 INFO - 'log_name': 'talos', 01:35:32 INFO - 'log_to_console': True, 01:35:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:35:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:35:32 INFO - 'opt_config_files': (), 01:35:32 INFO - 'pip_index': False, 01:35:32 INFO - 'sps_profile': False, 01:35:32 INFO - 'sps_profile_interval': 0, 01:35:32 INFO - 'suite': 'dromaeojs', 01:35:32 INFO - 'system_bits': '32', 01:35:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:35:32 INFO - 'title': 'talos-linux64-ix-007', 01:35:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:35:32 INFO - 'use_talos_json': True, 01:35:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:35:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:35:32 INFO - 'work_dir': 'build'} 01:35:32 INFO - [mozharness: 2017-02-09 09:35:32.296310Z] Running clobber step. 01:35:32 INFO - Running pre-action listener: _resource_record_pre_action 01:35:32 INFO - Running main action method: clobber 01:35:32 INFO - rmtree: /builds/slave/test/build 01:35:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:35:32 INFO - Running post-action listener: _resource_record_post_action 01:35:32 INFO - [mozharness: 2017-02-09 09:35:32.771325Z] Finished clobber step (success) 01:35:32 INFO - [mozharness: 2017-02-09 09:35:32.771426Z] Running read-buildbot-config step. 01:35:32 INFO - Running pre-action listener: _resource_record_pre_action 01:35:32 INFO - Running main action method: read_buildbot_config 01:35:32 INFO - Using buildbot properties: 01:35:32 INFO - { 01:35:32 INFO - "project": "", 01:35:32 INFO - "product": "firefox", 01:35:32 INFO - "who": "cbook@mozilla.com", 01:35:32 INFO - "installer_path": "public/build/target.tar.bz2", 01:35:32 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 01:35:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 01:35:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 01:35:32 INFO - "stage_platform": "linux64-pgo", 01:35:32 INFO - "basedir": "/builds/slave/test", 01:35:32 INFO - "buildnumber": 742, 01:35:32 INFO - "platform": "ubuntu64_hw", 01:35:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:35:32 INFO - "slavebuilddir": "test", 01:35:32 INFO - "taskId": "edprfcPOSNeTpEaikf19CQ", 01:35:32 INFO - "branch": "mozilla-aurora", 01:35:32 INFO - "script_repo_revision": "production", 01:35:32 INFO - "revision": "eae7e45deb55defb86c7c30fdfcf20c5d017b98d", 01:35:32 INFO - "slavename": "talos-linux64-ix-007", 01:35:32 INFO - "repo_path": "releases/mozilla-aurora" 01:35:32 INFO - } 01:35:32 INFO - Finding installer, test and symbols from parent task. 01:35:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edprfcPOSNeTpEaikf19CQ'}, attempt #1 01:35:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/edprfcPOSNeTpEaikf19CQ'}, attempt #1 01:35:33 INFO - Task dependencies: XAEIkxS3T8SCTxkzM8PGTw 01:35:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw'}, attempt #1 01:35:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 01:35:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/test_packages.json 01:35:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.crashreporter-symbols.zip 01:35:34 INFO - Running post-action listener: _resource_record_post_action 01:35:34 INFO - [mozharness: 2017-02-09 09:35:34.167185Z] Finished read-buildbot-config step (success) 01:35:34 INFO - [mozharness: 2017-02-09 09:35:34.167405Z] Running download-and-extract step. 01:35:34 INFO - Running pre-action listener: _resource_record_pre_action 01:35:34 INFO - Running main action method: download_and_extract 01:35:34 INFO - mkdir: /builds/slave/test/build/tests 01:35:34 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')]} 01:35:34 INFO - trying https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.test_packages.json 01:35:34 INFO - Downloading https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 01:35:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 01:35:34 INFO - Downloaded 896 bytes. 01:35:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 01:35:34 INFO - Using the following test package requirements: 01:35:34 INFO - {u'common': [u'target.common.tests.zip'], 01:35:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 01:35:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 01:35:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 01:35:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 01:35:34 INFO - u'mozbase': [u'target.common.tests.zip'], 01:35:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 01:35:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 01:35:34 INFO - u'web-platform': [u'target.common.tests.zip', 01:35:34 INFO - u'target.web-platform.tests.zip'], 01:35:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 01:35:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 01:35:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip 01:35:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:35:34 INFO - Fetch https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip into memory 01:35:35 INFO - Expected file size: 21858829 01:35:35 INFO - Obtained file size: 21858829 01:35:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 01:35:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip 01:35:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 01:35:39 INFO - Fetch https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.common.tests.zip into memory 01:35:40 INFO - Expected file size: 21858829 01:35:40 INFO - Obtained file size: 21858829 01:35:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.talos.tests.zip 01:35:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 01:35:44 INFO - Fetch https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.talos.tests.zip into memory 01:35:45 INFO - Expected file size: 14403485 01:35:45 INFO - Obtained file size: 14403485 01:35:45 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')]} 01:35:45 INFO - trying https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 01:35:45 INFO - Downloading https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 01:35:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 01:35:47 INFO - Downloaded 66117613 bytes. 01:35:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 01:35:47 INFO - mkdir: /builds/slave/test/properties 01:35:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:35:47 INFO - Writing to file /builds/slave/test/properties/build_url 01:35:47 INFO - Contents: 01:35:47 INFO - build_url:https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 01:35:47 INFO - Running post-action listener: _resource_record_post_action 01:35:47 INFO - Running post-action listener: set_extra_try_arguments 01:35:47 INFO - [mozharness: 2017-02-09 09:35:47.116550Z] Finished download-and-extract step (success) 01:35:47 INFO - [mozharness: 2017-02-09 09:35:47.116648Z] Running populate-webroot step. 01:35:47 INFO - Running pre-action listener: _resource_record_pre_action 01:35:47 INFO - Running main action method: populate_webroot 01:35:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:35:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:35:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:35:47 INFO - '--tppagecycles', 01:35:47 INFO - '7'], 01:35:47 INFO - 'tests': ['tsvgm']}}, 01:35:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:35:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:35:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:35:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:35:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:35:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:35:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['damp', 'tps']}, 01:35:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'tests': ['damp', 'tps']}, 01:35:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['dromaeo_dom']}, 01:35:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:35:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['basic_compositor_video']}, 01:35:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:35:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'other-e10s': {'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['a11yr', 01:35:47 INFO - 'ts_paint', 01:35:47 INFO - 'tpaint', 01:35:47 INFO - 'sessionrestore', 01:35:47 INFO - 'sessionrestore_no_auto_restore', 01:35:47 INFO - 'tabpaint']}, 01:35:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['tsvgx', 01:35:47 INFO - 'tsvgr_opacity', 01:35:47 INFO - 'tart', 01:35:47 INFO - 'tscrollx', 01:35:47 INFO - 'cart', 01:35:47 INFO - 'tsvg_static']}, 01:35:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:35:47 INFO - 'tsvgr_opacity', 01:35:47 INFO - 'tart', 01:35:47 INFO - 'tscrollx', 01:35:47 INFO - 'cart', 01:35:47 INFO - 'tsvg_static']}, 01:35:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'talos_options': ['--disable-e10s'], 01:35:47 INFO - 'tests': ['tp5o']}, 01:35:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:35:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'talos_options': ['--disable-e10s', 01:35:47 INFO - '--xperf_path', 01:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:35:47 INFO - 'tests': ['tp5n']}, 01:35:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:35:47 INFO - 'talos_options': ['--xperf_path', 01:35:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:35:47 INFO - 'tests': ['tp5n']}}, 01:35:47 INFO - 'talos.zip': {'path': '', 01:35:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:35:47 INFO - Running post-action listener: _resource_record_post_action 01:35:47 INFO - [mozharness: 2017-02-09 09:35:47.129883Z] Finished populate-webroot step (success) 01:35:47 INFO - [mozharness: 2017-02-09 09:35:47.129975Z] Running create-virtualenv step. 01:35:47 INFO - Running pre-action listener: _resource_record_pre_action 01:35:47 INFO - Running main action method: create_virtualenv 01:35:47 INFO - Creating virtualenv /builds/slave/test/build/venv 01:35:47 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 01:35:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:35:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:35:47 INFO - Using real prefix '/usr' 01:35:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:35:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:35:49 INFO - Installing pip.................done. 01:35:49 INFO - Return code: 0 01:35:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:35:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:35:49 INFO - Reading from file tmpfile_stdout 01:35:49 INFO - Output received: 01:35:49 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) 01:35:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:35:49 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')]} 01:35:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:49 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')]} 01:35:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:49 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35:49 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 01:35:49 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 01:35:49 INFO - Using env: {'DISPLAY': ':0', 01:35:49 INFO - 'HOME': '/home/cltbld', 01:35:49 INFO - 'LANG': 'en_US.UTF-8', 01:35:49 INFO - 'LANGUAGE': 'en_US:en', 01:35:49 INFO - 'LOGNAME': 'cltbld', 01:35:49 INFO - 'MAIL': '/var/mail/cltbld', 01:35:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:49 INFO - 'MOZ_NO_REMOTE': '1', 01:35:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:49 INFO - 'NO_EM_RESTART': '1', 01:35:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:49 INFO - 'PWD': '/builds/slave/test', 01:35:49 INFO - 'SHELL': '/bin/bash', 01:35:49 INFO - 'SHLVL': '1', 01:35:49 INFO - 'TERM': 'linux', 01:35:49 INFO - 'TMOUT': '86400', 01:35:49 INFO - 'USER': 'cltbld', 01:35:49 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:49 INFO - '_': '/tools/buildbot/bin/python'} 01:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:50 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 01:35:50 INFO - Cleaning up... 01:35:50 INFO - Return code: 0 01:35:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:50 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35:50 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 01:35:50 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 01:35:50 INFO - Using env: {'DISPLAY': ':0', 01:35:50 INFO - 'HOME': '/home/cltbld', 01:35:50 INFO - 'LANG': 'en_US.UTF-8', 01:35:50 INFO - 'LANGUAGE': 'en_US:en', 01:35:50 INFO - 'LOGNAME': 'cltbld', 01:35:50 INFO - 'MAIL': '/var/mail/cltbld', 01:35:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:50 INFO - 'MOZ_NO_REMOTE': '1', 01:35:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:50 INFO - 'NO_EM_RESTART': '1', 01:35:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:50 INFO - 'PWD': '/builds/slave/test', 01:35:50 INFO - 'SHELL': '/bin/bash', 01:35:50 INFO - 'SHLVL': '1', 01:35:50 INFO - 'TERM': 'linux', 01:35:50 INFO - 'TMOUT': '86400', 01:35:50 INFO - 'USER': 'cltbld', 01:35:50 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:50 INFO - '_': '/tools/buildbot/bin/python'} 01:35:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:50 INFO - Downloading/unpacking psutil>=3.1.1 01:35:50 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 01:35:50 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 01:35:50 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 01:35:50 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 01:35:50 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 01:35:50 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 01:35:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:52 INFO - Installing collected packages: psutil 01:35:52 INFO - Running setup.py install for psutil 01:35:52 INFO - building 'psutil._psutil_linux' extension 01:35:52 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 01:35:52 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 01:35:52 INFO - building 'psutil._psutil_posix' extension 01:35:52 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 01:35:52 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 01:35:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:35:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:35:52 INFO - Successfully installed psutil 01:35:52 INFO - Cleaning up... 01:35:53 INFO - Return code: 0 01:35:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:35:53 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')]} 01:35:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:53 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')]} 01:35:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:53 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35:53 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 01:35:53 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 01:35:53 INFO - Using env: {'DISPLAY': ':0', 01:35:53 INFO - 'HOME': '/home/cltbld', 01:35:53 INFO - 'LANG': 'en_US.UTF-8', 01:35:53 INFO - 'LANGUAGE': 'en_US:en', 01:35:53 INFO - 'LOGNAME': 'cltbld', 01:35:53 INFO - 'MAIL': '/var/mail/cltbld', 01:35:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:53 INFO - 'MOZ_NO_REMOTE': '1', 01:35:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:53 INFO - 'NO_EM_RESTART': '1', 01:35:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:53 INFO - 'PWD': '/builds/slave/test', 01:35:53 INFO - 'SHELL': '/bin/bash', 01:35:53 INFO - 'SHLVL': '1', 01:35:53 INFO - 'TERM': 'linux', 01:35:53 INFO - 'TMOUT': '86400', 01:35:53 INFO - 'USER': 'cltbld', 01:35:53 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:53 INFO - '_': '/tools/buildbot/bin/python'} 01:35:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:35:53 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 01:35:53 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 01:35:53 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 01:35:53 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 01:35:53 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 01:35:53 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 01:35:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:35:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:35:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:35:55 INFO - Installing collected packages: mozsystemmonitor 01:35:55 INFO - Running setup.py install for mozsystemmonitor 01:35:55 INFO - Successfully installed mozsystemmonitor 01:35:55 INFO - Cleaning up... 01:35:55 INFO - Return code: 0 01:35:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:35: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')]} 01:35:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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')]} 01:35:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35: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==2.5.1'] in /builds/slave/test/build 01:35: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==2.5.1 01:35:55 INFO - Using env: {'DISPLAY': ':0', 01:35:55 INFO - 'HOME': '/home/cltbld', 01:35:55 INFO - 'LANG': 'en_US.UTF-8', 01:35:55 INFO - 'LANGUAGE': 'en_US:en', 01:35:55 INFO - 'LOGNAME': 'cltbld', 01:35:55 INFO - 'MAIL': '/var/mail/cltbld', 01:35:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:55 INFO - 'MOZ_NO_REMOTE': '1', 01:35:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:55 INFO - 'NO_EM_RESTART': '1', 01:35:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:55 INFO - 'PWD': '/builds/slave/test', 01:35:55 INFO - 'SHELL': '/bin/bash', 01:35:55 INFO - 'SHLVL': '1', 01:35:55 INFO - 'TERM': 'linux', 01:35:55 INFO - 'TMOUT': '86400', 01:35:55 INFO - 'USER': 'cltbld', 01:35:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:55 INFO - '_': '/tools/buildbot/bin/python'} 01:35:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:55 INFO - Downloading/unpacking jsonschema==2.5.1 01:35:55 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 01:35:55 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 01:35:55 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 01:35:55 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 01:35:55 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 01:35:55 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 01:35:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:35:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:35:57 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 01:35:57 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 01:35:57 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 01:35:57 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 01:35:57 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 01:35:57 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 01:35:57 INFO - Downloading functools32-3.2.3-2.tar.gz 01:35:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:35:57 INFO - warning: no files found matching '*.txt' 01:35:57 INFO - no previously-included directories found matching 'build' 01:35:57 INFO - no previously-included directories found matching 'dist' 01:35:57 INFO - no previously-included directories found matching '.git*' 01:35:57 INFO - Installing collected packages: jsonschema, functools32 01:35:57 INFO - Running setup.py install for functools32 01:35:58 INFO - warning: no files found matching '*.txt' 01:35:58 INFO - no previously-included directories found matching 'build' 01:35:58 INFO - no previously-included directories found matching 'dist' 01:35:58 INFO - no previously-included directories found matching '.git*' 01:35:58 INFO - Successfully installed jsonschema functools32 01:35:58 INFO - Cleaning up... 01:35:58 INFO - Return code: 0 01:35:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:35:58 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')]} 01:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:58 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')]} 01:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:58 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35:58 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 01:35:58 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 01:35:58 INFO - Using env: {'DISPLAY': ':0', 01:35:58 INFO - 'HOME': '/home/cltbld', 01:35:58 INFO - 'LANG': 'en_US.UTF-8', 01:35:58 INFO - 'LANGUAGE': 'en_US:en', 01:35:58 INFO - 'LOGNAME': 'cltbld', 01:35:58 INFO - 'MAIL': '/var/mail/cltbld', 01:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:58 INFO - 'MOZ_NO_REMOTE': '1', 01:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:58 INFO - 'NO_EM_RESTART': '1', 01:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:58 INFO - 'PWD': '/builds/slave/test', 01:35:58 INFO - 'SHELL': '/bin/bash', 01:35:58 INFO - 'SHLVL': '1', 01:35:58 INFO - 'TERM': 'linux', 01:35:58 INFO - 'TMOUT': '86400', 01:35:58 INFO - 'USER': 'cltbld', 01:35:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:58 INFO - '_': '/tools/buildbot/bin/python'} 01:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:35:58 INFO - Cleaning up... 01:35:58 INFO - Return code: 0 01:35:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:35:58 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')]} 01:35:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:35:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:58 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')]} 01:35:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:35:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:35:58 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:35:58 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 01:35:58 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 01:35:58 INFO - Using env: {'DISPLAY': ':0', 01:35:58 INFO - 'HOME': '/home/cltbld', 01:35:58 INFO - 'LANG': 'en_US.UTF-8', 01:35:58 INFO - 'LANGUAGE': 'en_US:en', 01:35:58 INFO - 'LOGNAME': 'cltbld', 01:35:58 INFO - 'MAIL': '/var/mail/cltbld', 01:35:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:35:58 INFO - 'MOZ_NO_REMOTE': '1', 01:35:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:35:58 INFO - 'NO_EM_RESTART': '1', 01:35:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:35:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:35:58 INFO - 'PWD': '/builds/slave/test', 01:35:58 INFO - 'SHELL': '/bin/bash', 01:35:58 INFO - 'SHLVL': '1', 01:35:58 INFO - 'TERM': 'linux', 01:35:58 INFO - 'TMOUT': '86400', 01:35:58 INFO - 'USER': 'cltbld', 01:35:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:35:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:35:58 INFO - '_': '/tools/buildbot/bin/python'} 01:35:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:35:58 INFO - Downloading/unpacking blobuploader==1.2.4 01:35:58 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 01:35:58 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 01:35:58 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 01:35:58 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 01:35:58 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 01:35:58 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 01:36:00 INFO - Downloading blobuploader-1.2.4.tar.gz 01:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:36:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:36:00 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 01:36:00 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 01:36:00 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 01:36:00 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 01:36:00 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 01:36:00 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 01:36:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:36:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:36:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:36:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:36:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:36:01 INFO - Downloading docopt-0.6.1.tar.gz 01:36:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:36:01 INFO - Installing collected packages: blobuploader, requests, docopt 01:36:01 INFO - Running setup.py install for blobuploader 01:36:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:36:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:36:01 INFO - Running setup.py install for requests 01:36:01 INFO - Running setup.py install for docopt 01:36:01 INFO - Successfully installed blobuploader requests docopt 01:36:01 INFO - Cleaning up... 01:36:01 INFO - Return code: 0 01:36:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:36:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:01 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:36:01 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 01:36:01 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 01:36:01 INFO - Using env: {'DISPLAY': ':0', 01:36:01 INFO - 'HOME': '/home/cltbld', 01:36:01 INFO - 'LANG': 'en_US.UTF-8', 01:36:01 INFO - 'LANGUAGE': 'en_US:en', 01:36:01 INFO - 'LOGNAME': 'cltbld', 01:36:01 INFO - 'MAIL': '/var/mail/cltbld', 01:36:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:01 INFO - 'MOZ_NO_REMOTE': '1', 01:36:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:36:01 INFO - 'NO_EM_RESTART': '1', 01:36:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:36:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:01 INFO - 'PWD': '/builds/slave/test', 01:36:01 INFO - 'SHELL': '/bin/bash', 01:36:01 INFO - 'SHLVL': '1', 01:36:01 INFO - 'TERM': 'linux', 01:36:01 INFO - 'TMOUT': '86400', 01:36:01 INFO - 'USER': 'cltbld', 01:36:01 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:36:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:01 INFO - '_': '/tools/buildbot/bin/python'} 01:36:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:36:02 INFO - Running setup.py (path:/tmp/pip-PnPzmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:36:02 INFO - Running setup.py (path:/tmp/pip-UzQohG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:36:02 INFO - Running setup.py (path:/tmp/pip-Mbobzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:36:02 INFO - Running setup.py (path:/tmp/pip-FZkCNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:36:02 INFO - Running setup.py (path:/tmp/pip-N9BET_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:36:02 INFO - Running setup.py (path:/tmp/pip-8ApQHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:36:02 INFO - Running setup.py (path:/tmp/pip-1Tbhly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:36:02 INFO - Running setup.py (path:/tmp/pip-67xVK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:36:02 INFO - Running setup.py (path:/tmp/pip-SDcgvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:36:02 INFO - Running setup.py (path:/tmp/pip-qDOjg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:36:02 INFO - Running setup.py (path:/tmp/pip-iRu8Sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:36:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:36:02 INFO - Running setup.py (path:/tmp/pip-4JIrzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:36:03 INFO - Running setup.py (path:/tmp/pip-YVGIm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:36:03 INFO - Running setup.py (path:/tmp/pip-tmyeow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:03 INFO - Running setup.py (path:/tmp/pip-3IRlYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:36:03 INFO - Running setup.py (path:/tmp/pip-8aEt88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:36:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:36:03 INFO - Running setup.py (path:/tmp/pip-agqlAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:36:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:36:03 INFO - Running setup.py install for manifestparser 01:36:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:36:03 INFO - Running setup.py install for mozcrash 01:36:03 INFO - Running setup.py install for mozdebug 01:36:03 INFO - Running setup.py install for mozdevice 01:36:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:36:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:36:03 INFO - Running setup.py install for mozfile 01:36:03 INFO - Running setup.py install for mozhttpd 01:36:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozinfo 01:36:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozInstall 01:36:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozleak 01:36:04 INFO - Running setup.py install for mozlog 01:36:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for moznetwork 01:36:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozprocess 01:36:04 INFO - Running setup.py install for mozprofile 01:36:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozrunner 01:36:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:36:04 INFO - Running setup.py install for mozscreenshot 01:36:04 INFO - Running setup.py install for moztest 01:36:05 INFO - Running setup.py install for mozversion 01:36:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:36:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:36:05 INFO - Cleaning up... 01:36:05 INFO - Return code: 0 01:36:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:36:05 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')]} 01:36:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:05 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')]} 01:36:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:05 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:36:05 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 01:36:05 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 01:36:05 INFO - Using env: {'DISPLAY': ':0', 01:36:05 INFO - 'HOME': '/home/cltbld', 01:36:05 INFO - 'LANG': 'en_US.UTF-8', 01:36:05 INFO - 'LANGUAGE': 'en_US:en', 01:36:05 INFO - 'LOGNAME': 'cltbld', 01:36:05 INFO - 'MAIL': '/var/mail/cltbld', 01:36:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:05 INFO - 'MOZ_NO_REMOTE': '1', 01:36:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:36:05 INFO - 'NO_EM_RESTART': '1', 01:36:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:36:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:05 INFO - 'PWD': '/builds/slave/test', 01:36:05 INFO - 'SHELL': '/bin/bash', 01:36:05 INFO - 'SHLVL': '1', 01:36:05 INFO - 'TERM': 'linux', 01:36:05 INFO - 'TMOUT': '86400', 01:36:05 INFO - 'USER': 'cltbld', 01:36:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:36:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:05 INFO - '_': '/tools/buildbot/bin/python'} 01:36:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:36:05 INFO - Running setup.py (path:/tmp/pip-xlaArF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:36:05 INFO - Running setup.py (path:/tmp/pip-02TxOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:36:05 INFO - Running setup.py (path:/tmp/pip-cGGIde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:36:05 INFO - Running setup.py (path:/tmp/pip-doR0GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:36:05 INFO - Running setup.py (path:/tmp/pip-M33gJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:36:05 INFO - Running setup.py (path:/tmp/pip-dI7lsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:36:05 INFO - Running setup.py (path:/tmp/pip-ZtFIVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:36:05 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)) 01:36:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:36:05 INFO - Running setup.py (path:/tmp/pip-lmJfH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:36:06 INFO - Running setup.py (path:/tmp/pip-8hNnct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:36:06 INFO - Running setup.py (path:/tmp/pip-ZN6vpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:36:06 INFO - Running setup.py (path:/tmp/pip-cSlpKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:36:06 INFO - Running setup.py (path:/tmp/pip-mDqkH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:36:06 INFO - Running setup.py (path:/tmp/pip-_gO5qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:36:06 INFO - Running setup.py (path:/tmp/pip-Q6L_EG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:06 INFO - Running setup.py (path:/tmp/pip-Cwvhoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:36:06 INFO - Running setup.py (path:/tmp/pip-kFXpmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:36:06 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)) 01:36:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:36:06 INFO - Running setup.py (path:/tmp/pip-a_Rhtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:36:06 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)) 01:36:06 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)) 01:36:06 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)) 01:36:06 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)) 01:36:06 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)) 01:36:06 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)) 01:36:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:36:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:36:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:36:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:36:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:36:08 INFO - Downloading blessings-1.6.tar.gz 01:36:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:36:08 INFO - Installing collected packages: blessings 01:36:08 INFO - Running setup.py install for blessings 01:36:08 INFO - Successfully installed blessings 01:36:08 INFO - Cleaning up... 01:36:08 INFO - Return code: 0 01:36:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:36:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:36:09 INFO - Reading from file tmpfile_stdout 01:36:09 INFO - Current package versions: 01:36:09 INFO - argparse == 1.2.1 01:36:09 INFO - blessings == 1.6 01:36:09 INFO - blobuploader == 1.2.4 01:36:09 INFO - docopt == 0.6.1 01:36:09 INFO - functools32 == 3.2.3-2 01:36:09 INFO - jsonschema == 2.5.1 01:36:09 INFO - manifestparser == 1.1 01:36:09 INFO - mozInstall == 1.12 01:36:09 INFO - mozcrash == 1.0 01:36:09 INFO - mozdebug == 0.1 01:36:09 INFO - mozdevice == 0.49 01:36:09 INFO - mozfile == 1.2 01:36:09 INFO - mozhttpd == 0.7 01:36:09 INFO - mozinfo == 0.9 01:36:09 INFO - mozleak == 0.1 01:36:09 INFO - mozlog == 3.4 01:36:09 INFO - moznetwork == 0.27 01:36:09 INFO - mozprocess == 0.24 01:36:09 INFO - mozprofile == 0.28 01:36:09 INFO - mozrunner == 6.13 01:36:09 INFO - mozscreenshot == 0.1 01:36:09 INFO - mozsystemmonitor == 0.3 01:36:09 INFO - moztest == 0.8 01:36:09 INFO - mozversion == 1.4 01:36:09 INFO - psutil == 3.1.1 01:36:09 INFO - requests == 1.2.3 01:36:09 INFO - wsgiref == 0.1.2 01:36:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:36:09 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')]} 01:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:09 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')]} 01:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:09 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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:36:09 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 01:36:09 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 01:36:09 INFO - Using env: {'DISPLAY': ':0', 01:36:09 INFO - 'HOME': '/home/cltbld', 01:36:09 INFO - 'LANG': 'en_US.UTF-8', 01:36:09 INFO - 'LANGUAGE': 'en_US:en', 01:36:09 INFO - 'LOGNAME': 'cltbld', 01:36:09 INFO - 'MAIL': '/var/mail/cltbld', 01:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:09 INFO - 'MOZ_NO_REMOTE': '1', 01:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:36:09 INFO - 'NO_EM_RESTART': '1', 01:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:09 INFO - 'PWD': '/builds/slave/test', 01:36:09 INFO - 'SHELL': '/bin/bash', 01:36:09 INFO - 'SHLVL': '1', 01:36:09 INFO - 'TERM': 'linux', 01:36:09 INFO - 'TMOUT': '86400', 01:36:09 INFO - 'USER': 'cltbld', 01:36:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:09 INFO - '_': '/tools/buildbot/bin/python'} 01:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 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)) 01:36:09 INFO - Cleaning up... 01:36:09 INFO - Return code: 0 01:36:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:36:09 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')]} 01:36:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:36:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:09 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')]} 01:36:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:36:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:36:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x28d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c48630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, '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': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', '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 01:36:09 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 01:36:09 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 01:36:09 INFO - Using env: {'DISPLAY': ':0', 01:36:09 INFO - 'HOME': '/home/cltbld', 01:36:09 INFO - 'LANG': 'en_US.UTF-8', 01:36:09 INFO - 'LANGUAGE': 'en_US:en', 01:36:09 INFO - 'LOGNAME': 'cltbld', 01:36:09 INFO - 'MAIL': '/var/mail/cltbld', 01:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:09 INFO - 'MOZ_NO_REMOTE': '1', 01:36:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:36:09 INFO - 'NO_EM_RESTART': '1', 01:36:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:09 INFO - 'PWD': '/builds/slave/test', 01:36:09 INFO - 'SHELL': '/bin/bash', 01:36:09 INFO - 'SHLVL': '1', 01:36:09 INFO - 'TERM': 'linux', 01:36:09 INFO - 'TMOUT': '86400', 01:36:09 INFO - 'USER': 'cltbld', 01:36:09 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:09 INFO - '_': '/tools/buildbot/bin/python'} 01:36:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:36:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:36:09 INFO - Cleaning up... 01:36:09 INFO - Return code: 0 01:36:09 INFO - Running post-action listener: _resource_record_post_action 01:36:09 INFO - Running post-action listener: _start_resource_monitoring 01:36:09 INFO - Starting resource monitoring. 01:36:09 INFO - [mozharness: 2017-02-09 09:36:09.691215Z] Finished create-virtualenv step (success) 01:36:09 INFO - [mozharness: 2017-02-09 09:36:09.691672Z] Running install step. 01:36:09 INFO - Running pre-action listener: _resource_record_pre_action 01:36:09 INFO - Running main action method: install 01:36:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:36:09 INFO - Reading from file tmpfile_stdout 01:36:09 INFO - Detecting whether we're running mozinstall >=1.0... 01:36:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:36:09 INFO - Reading from file tmpfile_stdout 01:36:09 INFO - Output received: 01:36:09 INFO - Usage: mozinstall [options] installer 01:36:09 INFO - Options: 01:36:09 INFO - -h, --help show this help message and exit 01:36:09 INFO - -d DEST, --destination=DEST 01:36:09 INFO - Directory to install application into. [default: 01:36:09 INFO - "/builds/slave/test"] 01:36:09 INFO - --app=APP Application being installed. [default: firefox] 01:36:09 INFO - mkdir: /builds/slave/test/build/application 01:36:09 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'] 01:36:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 01:36:26 INFO - Reading from file tmpfile_stdout 01:36:26 INFO - Output received: 01:36:26 INFO - /builds/slave/test/build/application/firefox/firefox 01:36:26 INFO - Running post-action listener: _resource_record_post_action 01:36:26 INFO - [mozharness: 2017-02-09 09:36:26.427945Z] Finished install step (success) 01:36:26 INFO - [mozharness: 2017-02-09 09:36:26.428199Z] Running run-tests step. 01:36:26 INFO - Running pre-action listener: _resource_record_pre_action 01:36:26 INFO - Running main action method: run_tests 01:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:36:26 INFO - Python 2.7.3 01:36:26 INFO - Return code: 0 01:36:26 INFO - grabbing minidump binary from tooltool 01:36:26 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')]} 01:36:26 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 0x2cd1850>, '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 0x2c466d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c46b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:36:26 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 01:36:26 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 01:36:26 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 01:36:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:36:26 INFO - Return code: 0 01:36:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:36:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:36:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:36:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:36:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:36:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 01:36:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 01:36:26 INFO - Using env: {'DISPLAY': ':0', 01:36:26 INFO - 'HOME': '/home/cltbld', 01:36:26 INFO - 'LANG': 'en_US.UTF-8', 01:36:26 INFO - 'LANGUAGE': 'en_US:en', 01:36:26 INFO - 'LOGNAME': 'cltbld', 01:36:26 INFO - 'MAIL': '/var/mail/cltbld', 01:36:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:36:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:36:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:36:26 INFO - 'MOZ_NO_REMOTE': '1', 01:36:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:36:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:36:26 INFO - 'NO_EM_RESTART': '1', 01:36:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:36:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:36:26 INFO - 'PWD': '/builds/slave/test', 01:36:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:36:26 INFO - 'SHELL': '/bin/bash', 01:36:26 INFO - 'SHLVL': '1', 01:36:26 INFO - 'TERM': 'linux', 01:36:26 INFO - 'TMOUT': '86400', 01:36:26 INFO - 'USER': 'cltbld', 01:36:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495', 01:36:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:36:26 INFO - '_': '/tools/buildbot/bin/python'} 01:36:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 01:36:26 INFO - mozversion application_buildid: 20170209084032 01:36:26 INFO - mozversion application_changeset: eae7e45deb55defb86c7c30fdfcf20c5d017b98d 01:36:26 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:36:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:36:26 INFO - mozversion application_name: Firefox 01:36:26 INFO - mozversion application_remotingname: firefox-dev 01:36:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:36:26 INFO - mozversion application_vendor: Mozilla 01:36:26 INFO - mozversion application_version: 53.0a2 01:36:26 INFO - mozversion platform_buildid: 20170209084032 01:36:26 INFO - mozversion platform_changeset: eae7e45deb55defb86c7c30fdfcf20c5d017b98d 01:36:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:36:26 INFO - mozversion platform_version: 53.0a2 01:36:26 INFO - using testdate: 1486632986 01:36:26 INFO - actual date: 1486632986 01:36:26 INFO - starting webserver on 'localhost:53445' 01:36:26 INFO - SUITE-START | Running 2 tests 01:36:26 INFO - TEST-START | dromaeo_css 01:36:26 INFO - operating with platform_type : linux_ 01:36:26 INFO - Initialising browser for dromaeo_css test... 01:36:26 INFO - TEST-INFO | started process 13588 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNApPKI/profile http://localhost:53445/getInfo.html) 01:36:30 INFO - PROCESS | 13588 | __metrics Screen width/height:1600/1200 01:36:30 INFO - PROCESS | 13588 | colorDepth:24 01:36:30 INFO - PROCESS | 13588 | Browser inner width/height: 1024/697 01:36:30 INFO - PROCESS | 13588 | __metrics 01:36:31 INFO - PROCESS | 13588 | 1486632991020 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 01:36:31 INFO - PROCESS | 13588 | 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" 01:36:31 INFO - PROCESS | 13588 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:36:31 INFO - PROCESS | 13588 | console.error: PushService: 01:36:31 INFO - PROCESS | 13588 | stateChangeProcessEnqueue: Error transitioning state 01:36:31 INFO - PROCESS | 13588 | UnknownError 01:36:32 INFO - TEST-INFO | 13588: exit 0 01:36:32 INFO - Browser initialized. 01:36:32 INFO - Running cycle 1/1 for dromaeo_css test... 01:36:32 INFO - TEST-INFO | started process 13680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNApPKI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:36:44 INFO - PROCESS | 13680 | RSS: Main: 138571776 01:36:44 INFO - PROCESS | 13680 | 01:39:44 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53445/tests/dromaeo/cssquery-ext.html) 01:39:45 INFO - PROCESS | 13680 | RSS: Main: 234119168 01:39:45 INFO - PROCESS | 13680 | 01:41:34 INFO - PROCESS | 13680 | ************************* 01:41:34 INFO - PROCESS | 13680 | A coding exception was thrown and uncaught in a Task. 01:41:34 INFO - PROCESS | 13680 | 01:41:34 ERROR - PROCESS | 13680 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:41:34 INFO - PROCESS | 13680 | Full stack: 01:41:34 INFO - PROCESS | 13680 | ************************* 01:42:47 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-ext.html (next: http://localhost:53445/tests/dromaeo/cssquery-jquery.html) 01:42:48 INFO - PROCESS | 13680 | RSS: Main: 229548032 01:42:48 INFO - PROCESS | 13680 | 01:45:50 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53445/tests/dromaeo/cssquery-mootools.html) 01:45:50 INFO - PROCESS | 13680 | RSS: Main: 218353664 01:45:50 INFO - PROCESS | 13680 | 01:48:52 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53445/tests/dromaeo/cssquery-prototype.html) 01:48:53 INFO - PROCESS | 13680 | RSS: Main: 217878528 01:48:53 INFO - PROCESS | 13680 | 01:51:55 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53445/tests/dromaeo/cssquery-yui.html) 01:51:56 INFO - PROCESS | 13680 | RSS: Main: 185573376 01:51:56 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | Cycle 1(1): loaded http://localhost:53445/tests/dromaeo/cssquery-yui.html (next: http://localhost:53445/tests/dromaeo/cssquery-dojo.html) 01:54:59 INFO - PROCESS | 13680 | RSS: Main: 266248192 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | __start_tp_report 01:54:59 INFO - PROCESS | 13680 | _x_x_mozilla_page_load 01:54:59 INFO - PROCESS | 13680 | _x_x_mozilla_page_load_details 01:54:59 INFO - PROCESS | 13680 | |i|pagename|runs| 01:54:59 INFO - PROCESS | 13680 | |0;dojo.html;3249.75626827988;3250.284937313791;3273.574435323409;3299.7525185611084;3315.8010519368827;5390.9191362129595;5463.207834863947;5468.699221542814;5470.261514695515;5486.204500347442;5485.862853428666;5504.366997795245;5510.669359838413;5513.862153446155;5515.255440515529;4884.267359896008;4893.2170852663585;4909.361782968209;4933.186024306003;4972.154733695281;4825.734584597846;4839.612830973531;4946.183879659852;4984.950150498503;5013.498650134976;4847.1517484440255;4855.514448555134;4911.214205727084;4967.354243948282;4983.601311895058;4981.078500477423;4983.551480366748;4993.850184494471;5005.174146265862;5023;4773.618110551148;4908.337374454439;4938.975305123451;4950.059488697136;4984.252362145708;5298.947010529922;5322.574194064466;5389.299391079174;5393.05621516237;5442.510174084351;5878.970605146989;5879.147523609053;5880.705964701748;5884.70576471179;5907.527397808165;5874.530037596982;5916.4675179233645;5938.703064846741;5938.821835344904;5943.197668314765;5329.866753331159;5360.115580929142;5438.428964958702;5461.836144915659;5505.174223866412;5985.790497332572;5997.970010149921;5999.460048595647;6007.948608993496;6032.306284777219;5721.056025755704;5765.769369225268;5774.191613174159;5776.249087618667;5780.653160810365;5657.32112146545;5756.1653560233535;5805.709714514257;5853.678047707332;5855.326637436664;5700.857478562986;5711.343195532484;5753.021986262345;5790.073588225863;5790.855228619234;5732.283464566929;5735.4551317624755;5736.856578585569;5740.253767010262;5752.482276595043;4410.7353558785935;4449.443819522559;4470.687051906335;4472.485664148599;4502.009557897258;3995.081131339808;4027.859024934113;4029.073313137936;4051.7771522565954;4076.673866090706;5654.40628733977;5665.915011274834;5667.376588575254;5671.943280567141;5700.258966334433;5702.201691763156;5717.800174589308;5818.389069147764;5906.911396329058;5907.763689452374;5607.663540187602;5708.600397972185;5717.714114294268;5721.742521586539;5740.253767010262;5023.0456213320085;5050.368703912011;5060.620453466005;5061.620378471629;5067.847964561069;6168.506519478341;6175.197224360804;6185.84535386619;6185.938140618537;6188.721507532172;5676.120201368794;5725.742341594555;5771.163181338767;5796.652200867961;5833.854153646023;6119.020956646915;6121.081837724377;6122.234720659918;6124.54065945047;6136.723847426787;5740.598158129058;5746.770129194785;5747.109198074305;5747.913781293368;5787.508061814793;5656.321241451053;5714.342850572071;5806.738696758572;5815.534757219328;5821.912671309849;5768;5770.422957704196;5778.682172480554;5785.247917770663;5812.273465816773;5749.108888122348;5756.56825738063;5756.856078597901;5762.394948530344;5763.02028655138;5506.807261745819;5508;5622.5783066271015;5739.512141467855;5746.454086861741;5711.828645140652;5727.341355744143;5781.017227071324;5795.797147099831;5808.273965754281;5676.035074037506;5680.289963754531;5683.090705487268;5683.65898046102;5689.971550142222 01:54:59 INFO - PROCESS | 13680 | |1;ext.html;599.6222379900662;606.5147881694643;634.2642534659793;648.4747354642743;649.2922714241475;43742.56257437425;45854.31218531725;46033.07933841321;50271.994560108775;50368.49631503684;49623;50238.74880625592;50330.49669503304;50330.74834625831;50370;8643.524606146659;9219.308551858603;9366.297527685418;9378.906210937907;9380.108889655472;8777.605007774666;10483.580656773758;10697.572097116106;10712.78574428511;10994.615188468406;11051.668449946514;11097.667069987914;11173.21787474877;11200.159988000893;11200.327980321166;11026.889731102747;11056.11551075916;11116.333020018825;11127.554897804079;11139.554417823318;11149.888501114967;11215.495302711397;11230.382328971904;11233.10135189183;11237.887621123766;46866.76566617179;47396.289055664194;47401.051978960226;47432.28851567229;47443.28835067477;4320.1575692739925;4326.913461730779;4404.823807047715;4482.238019536687;4494.73031618104;34972.300553988774;35032.47451288233;35118.64881351179;35405.46891796599;36807.63192368069;4654.394928659286;4680.485146633868;4728.858134255978;4757.26262429324;4818.108649899745;338125;338499;343021;345287;345372.2731386352;67547;68003;68027.65986170038;68032.3196768026;68144;70386.77679339256;70577.2942270581;70579.6471017652;70599.64700176466;70623.64688176526;17528.474145775646;17645.38241161553;17711.114444277733;17730;17737.113144342733;13702.52041178574;13886.86113138876;14211.928940355232;15458.690826183414;15590.532284031497;17411.73882391765;18245.270189192284;18275;18339.724904126448;18405.26378944854;6025.15647809307;6109.480694141048;6169.9383006170265;6222.222222222223;6277.811665650038;968.8110818390487;972.8686627305365;976.1848856205006;980.7401038724744;1002.0330381182049;33255;33350;33439.3312133756;33994.66005339915;34116.48825267623;1119.4962266979892;1164.6622479480855;1168.2406435816788;1173.495396979307;1192.0463629096687;16854.157292135344;17778.91110544439;17967.64064718698;18057.097145142954;18148.455546333633;154423;154683.2265838686;154685;154809.22595386952;155832;66225.33774662288;66291.66854165794;66354;66448;66543.33456665468;1507.7436835737951;1534.278888922227;1555.3312075807285;1556.743137382342;1579.8104227492545;31549.52675709912;32638.83680581582;33081.33837323288;33285.33429331351;33406.66593334036;53946.460535394144;54844.72577637086;54874.72562637161;54876.72561637166;55105.448945510034;376810;378497;378723;379582;382747;43075;49372.50627493823;49866;49998.750006249735;50751;50105.99788004292;50376.49623503718;50859.2371114441;54380.18429723637;54876;45165.774171128935;45419.318710218715;46358.391252797184;46911.765441172574;47106;44342.556574433846;46216.30675539802;46779.29831052469;47049.76475117602;47798.5220147808;43198.352024719024;43687.56312436835;44181.11637767291;44888.61336639624;45193;38733.80633096817;41202.587974121074;41270.58729412667;41346.1730765389;41688.58311416968;29313.56029659514;30820.845895770377;30979.69020309768;31295.217619559695;31301.8434907824 01:54:59 INFO - PROCESS | 13680 | |2;jquery.html;381.646030589949;438.9209942210403;442.8206576336583;445.8550970934446;459.3293791065043;19800.30698925538;21268.4682882928;22061.66907496387;22080;22279.665805012937;21725.891370543126;21745.891270543627;21870;22060.779392206074;22220.88889555554;5987.820365389045;6009.819705408845;6102.267727872661;6152.107944348067;6239.438450539451;4551.68138230324;4744.857654270378;6078.756849726005;6079.483243924272;6124.050772130305;4762.499937506546;4780.904381912377;6845.965770171142;6846.178458584952;6971.79084627462;6772.390484856362;6844.623545705009;6866.553674011173;6876;6967.965160174192;6038.788642397539;6089.756409743605;6092.08618707193;6094.542909281821;6095.146679464879;24667.38331541708;25080.749192508025;25140.12009579656;25399.492010159694;25589.104381346562;3377;3403.9659603403898;3411.249525104473;3459.567554055743;3472.739544534145;7776.688932442696;7860.213978602152;12855.421506032251;13072.43130824307;15557.455489057942;1961.460598335469;1975.5555000125;1996.2314508914028;2007.6185524750251;2016.667249903764;86705.56647216786;87101;87450.56274718649;88442.55778721065;89362.99999999935;10318.535665895053;11037.39294338803;11801.29192248468;12065.879341206652;12131.454084566216;15315.617109572127;16063.598410039842;16235.350585976665;16724.74912876308;16789.6642067158;8690.695825646071;8696.608652610648;8813.735587932373;8953.283737301;8987.056359082333;8346.374021948379;8400.781886626528;8439.57802109892;8538.615762290712;8568.228859402683;7666.578338191342;7815.765527034198;7819.882701759479;7906.209379062163;8013.2387423194705;2120.204923153817;2182.923597674074;2191.550732099916;2203.4931965647993;2205;958.9664361747306;959.5490119643756;966.0822218892081;977.1254727019278;984.3700031979539;20257.797422025593;21162.153513859583;21344.893275533523;21351.14595416197;21427.571448571252;968.4795767385604;981.8183636027358;984.7390441532856;989.4014121456559;1006.4213077480478;6701.32986701326;11833.408329583486;12263.877361226452;12298.14223381777;12353.814692779615;511319;513912;733339;737119;757169;109317;113774;113790.43104784423;114188.42905785418;114442.42778786052;497.9975100124476;512.5438359859728;513.3557385481197;513.7251570409812;515.487090345109;11905.107116966088;12039.398030098635;12354.691132721395;12361.134720569833;12586.874131258937;43618;45781.08437831292;46302.30546541737;46904;47145.790963832;62346.68826656019;62872;62918.37081629125;63182;64784.35215647972;9053.637854485747;9091.863622045543;9433.386829856037;9490.715278541655;9561.521923903916;13440.260785656492;13610.59168224955;13750.312484375541;13885.930570347487;14132.22272774966;10823.56705731762;11665.766684666089;11716.70708232301;11830.112741544246;12147.696307592381;11817.172797904064;12181.39093045362;12304.569340073054;12366.75266494647;12594.937025315181;12219.572314968933;12458.626241212778;12492.625221243377;12510.437030333474;12751.80872286935;9299.023602521638;9304.627814887599;9304.95347523285;9412;9419.387739796892;10134.679966666787;11568.88431115678;11618.186726929034;11906.940465297617;11957.701057473285 01:54:59 INFO - PROCESS | 13680 | |3;mootools.html;1514.2050423527653;1545.1810540413585;1545.9149746763926;1549.6295557163166;1557.1280083153435;8385.706500272492;8856.955715221431;8885.822283554326;8895;8895.066018068106;7594.316511513963;7869.763907082796;8404.579771011455;8667;8677.652893884237;2497.5379554782335;2527.140772137473;2545.2491515003026;2545.872706364684;2548.019012680113;2449.5468338357373;2477.467344520928;2480.702315722107;2491.352248415407;2534.4677617700304;2331.067572970817;2346.3664810501155;2368.0527788884497;2378.916737914173;2379.274321331993;2410.144398738449;2410.156445244168;2431.7203521595065;2435.391152211947;2438.1710218525786;2414.3360575841607;2421.140495124223;2460.8277420580566;2474.9628755568683;2487.042488641886;8778.253848422892;8840.690575829814;8844.204021638083;8845.69040083594;8849.734507964771;5314.149736042254;5456.181572764078;5458.4541545845495;5460.208269800856;5460.781568737246;3453.4992426098324;3482.2861313430685;3544.4328907374697;3573.160307327776;3585.0858031202138;1345.3811246826472;1348.2136169575351;1373.6703191234033;1397.31531549541;1407.6551244945053;11945.28328300296;11992.280463172237;12007.699807504707;12010.279383237033;12021.579244726392;4780.211265141213;4965.9751701241985;4968.925466118011;5034.345535080416;5037.4458809530925;10400.635977740894;10432.739181520523;10433.582656693647;10439.321444106108;10439.321444106108;5662.094064949671;5701.600887937804;5704.629199102045;5705.2012718219485;5708;4792.137415265216;5096.566791822663;5168.586513078944;5181.093308671043;5187.273781670569;3981.825361518301;4054.9797251013556;4070.6539944105084;4096.795160241976;4124.092699606082;1365.1263191557214;1373.6154670689618;1382.7165431086603;1388.902776805614;1393.0179223647508;1018.2363227579316;1033.9483025848829;1034.332855308322;1040.3913710479455;1044.8223801953686;5852.648841069549;5878.941210587839;5948.67282299469;6068.4538391544975;6119.082137679295;610.3987572241339;614.4469977020627;620.1906512001881;622.757124721359;624.8687775567182;4059.512858457004;4202.474690663667;4213.9578604214175;4322.589354011364;4324.027093903846;9846.556904939294;10184.185265178769;10187.439690816927;10207.693769186937;10253.58985640581;10092;10220.897791021995;10232.948835255926;10245.026722461354;10248.128909042814;7868.488548244461;8076.8384632307025;8185.508869467851;8332.041815191209;8363.540005299645;6095.420935011167;6098.237720284965;6116.449519543263;6273.686315684289;6323.936760632335;9826.75433114178;9828.852567211354;9923.255755818198;9933.453660048477;9935.850962235716;9051.728448146567;9316.767080823034;10093.444860532447;10327.32872363294;10335.689929302132;7558.962205188939;7711.3830893527265;7752.26353496417;7870.09493908185;7942.483738556975;8746.475211487332;8749.256313213447;8752.824943500967;8788.912110879066;8793.824123517621;7505.399568034653;7548.358389536951;7571.356434702891;7575.053118360205;7699.307062364414;7448.366888814511;7536.359409450258;7561.962190189014;7587.203343648837;7719.536827790351;6665.833354166185;6754.425873800782;6754.5609535380045;6755.42578880781;6763.188417389944;5237.738113094406;5251.52736253739;5270.420253772006;5281.735913204401;5452.482014208644;4765.285207218945;4818.325434439252;4820.517948205152;4886.682365646222;4987.576056035277 01:54:59 INFO - PROCESS | 13680 | |4;prototype.html;396.3440505962633;406.52842702465136;408.44247602023245;412.3711340206184;413.2912055824261;5075.416327122382;5240.764165612557;5258.710770907599;5317.282166907471;5328.946710532893;5101.591872650189;5162.303089082972;5185.948140518593;5233.476652334764;5255.527002569768;4190.727602705814;4200.222958752641;4203.264428724976;4218.873433796991;4227.492700875884;4115.938260926088;4229.555896630855;4236.4916210054835;4253.1493701259715;4271.722338048033;4165.6250937415625;4179.853705120321;4197.13227613712;4199.223143718422;4201.1807697499;4174.5616710245295;4184.66522678185;4188.371744238359;4191.11986482839;4194.4337514435465;3830.2148059647707;3838.654521093087;3849.345611246095;3851.8074096295354;3855.9421608675893;4945.802167913279;5096.464871188546;5139.640225184238;5142.974285128588;5169.457206993249;4843.70937743733;4848.878778030577;4879.609631229493;4880.511948805127;4880.657284503458;5398.811041613564;5436.3476382833915;5464.426235245322;5483.835484935458;5490.435225960622;4169;4187.811548480326;4250.936235956463;4262.403263543107;4291.935620965688;5635.549156067505;5640.633358831663;5646.661200327952;5699;5703.17498400512;4321.330193819963;4384.7369157850635;4396.582324679214;4409.647228221735;4412.955870441318;4284;4395.84614538496;4402.8679139625865;4404.66964977628;4418.690691651618;4833.260026390497;4833.782479788418;4834.95165048352;4836.927446088312;4881.438634557;5505.614606977553;5522.282103326542;5524.447555244444;5544.421843842552;5553.6390134641115;1420.9431622734976;1466.7726502392147;1469.9049208339854;1481.4814814814729;1481.518506485375;997.4065431068502;1026.2200727447193;1027.9155490957112;1029.912457441126;1043.139409986764;5206.114960456732;5219.739013049332;5230.660007099526;5232.947670523322;5259.579233661298;5379.54273886724;5388.191771234347;5408.188771684278;5430.701311427831;5441.8095366662765;5064.974675126601;5180.274761533388;5185;5236.554892834076;5241.24002019705;2877.4676684812957;2883.2215301868796;2887.1417296875943;2888.393437378174;2899.3041669999047;5607.551355916164;5609.270794796732;5617.38208797032;5631.774729010794;5650.463205995424;5224.320838290998;5489.670619762827;5529.751161197756;5537.723113844291;5538.307711536058;5614;5635.690037048002;5648.350439699405;5674.347450043216;5706.971465142731;5247.501487358695;5404.864878378072;5414.675119492843;5467.020473841686;5488.69812160335;5388.865278368072;5435.918461223006;5436;5440.1023831069015;5452.318460192476;5698.8290351289525;5735.885282294247;5747.942520574741;5751.4536119068625;5756.884862302814;4092.140650463436;4194.328907374927;4200.768957707355;4200.894977625584;4225.302825033835;5430.456954304538;5461.808836690697;5464.508194262536;5489.835304940858;5495.313085864267;5313.362396512443;5342.332208473941;5347.812826551052;5354.411014788292;5365.678059316453;5151.969335855888;5195.246689230116;5246.26873131858;5264.15773476242;5289.603279754111;5233.947660523346;5244.685318880879;5264.710440925633;5268.997780843255;5285.225256740242;5116.872078198075;5255.421903590525;5283.682979021271;5364.892702146013;5373.35519737634;5146.099432599355;5154.922676159786;5158.690478571298;5168.095583272988;5218.686134304668 01:54:59 INFO - PROCESS | 13680 | |5;yui.html;809.9149589293124;820.5445977482494;821.092692574705;861.5778268648362;865.1435079271521;16006.199690015495;17327.30690772371;17342.739858902125;17367;17373.131343432808;15989.84010159898;15999.600009999756;16157.272922718477;16280.185990700476;16300.26648800804;692.418368570402;720.3300930134973;808.5108509351845;834.1825011488745;838.3042075077701;840.2269911681237;842.7387509871959;843.3969711656165;843.9873401898976;844.7676888855583;876.1238761238761;876.2508055612456;876.4565969099167;876.9386142969995;877.0615441477621;750.4334227658138;772.3628006894306;855.9400841941067;866.8049688820028;868.5743985447117;648.044134901022;649.1496140056494;649.1787888321277;649.2792999770252;650.4048795352247;16162.222155562878;16543.669126617522;16561.25474353645;16572.50282491527;17177;13862.4455021799;14420.711585768331;14471.42114315426;14480.637984050378;14611.342489587887;13479.326033698373;13603.455861765617;13632.454701811916;13856.168629882239;14065;4655.068986202739;4655.837045703418;4685.180093483661;4712.340272361872;4791.616670666338;71831.31372655793;72676;73689.63155184244;76419.61790191014;76778;12441.93779031117;12663.873361266269;12675.985921126288;12717.427715752814;12728.29994350301;23292.417689557897;23592.528149436916;23800.285991420285;23801.880990595284;23824.64263036056;8315.334773218128;8564.057953625097;8833.116688331243;8853.114688531095;8939.73180804577;4763.976180119077;4768.332433459318;4795.6163506919365;4829.203181475087;4897.657163998486;3643.107438677488;3703.092742278105;3746.194568167857;3748.6813620842536;3770.1517158639085;583.0583607473899;587.2952457051555;587.2981786764775;591.659795617513;594.6016169166583;755.1165136789969;768.1320108277611;774.0981756254014;777.8133248020547;794.209761287511;10812.135029197645;10887.510062047228;10900.618478353379;10922.563097476012;11063.170262230366;755.1391413788285;755.9659815308324;767.094828102844;774.0943096577018;828.5070383122032;5022;5258.553022993012;5288.497592728685;5342;5377;69286.30713692798;81548.59225703834;82715;83196;85829.57085214533;68229;68452;68557;68635.65682171658;69333.65333173302;64076.67961660162;64868;65780.6710966442;66682.33317666859;66944.6652766733;10181.541830617492;10349.808327627323;10396.272260941661;10575.471226438493;10577.682669519927;44368;44487.55512444834;45011.32483012692;45472.31791523196;46187.538124618324;49791.25313120378;51460;52049.21926171186;52142.739286303324;55916;13368.131071480322;13374.13068150567;13376.598702038955;13413.731725365633;13464.596062118153;15949.521514354588;16300.184990750653;16362.672746544764;16490.58773530671;16497.587560310607;15108.773368399263;15192.924035379752;15316.540503784905;15326.540203793904;16051.357945682508;15059.77410338824;15448.691026179638;15735.134567598892;16018.256793081373;16549.50351489457;14611.707765844836;15331.463398780988;15480.5355839325;15486.845131548991;16118.355265789238;11304.265222760494;11825.467853946766;12154.331511766584;12165;12228.510859565873;11229.719257018312;11804.639072185426;11964.58123965657;12018.158728888893;12069.155159139127 01:54:59 INFO - PROCESS | 13680 | __end_tp_report 01:54:59 INFO - PROCESS | 13680 | __start_cc_report 01:54:59 INFO - PROCESS | 13680 | _x_x_mozilla_cycle_collect,1082 01:54:59 INFO - PROCESS | 13680 | __end_cc_report 01:54:59 INFO - PROCESS | 13680 | __startTimestamp1486634099376__endTimestamp 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | ------- Summary: start ------- 01:54:59 INFO - PROCESS | 13680 | Number of tests: 6 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#0] dojo.html Cycles:165 Average:5438.44 Median:5700.86 stddev:611.94 (10.7%) stddev-sans-first:589.23 01:54:59 INFO - PROCESS | 13680 | Values: 3249.8 3250.3 3273.6 3299.8 3315.8 5390.9 5463.2 5468.7 5470.3 5486.2 5485.9 5504.4 5510.7 5513.9 5515.3 4884.3 4893.2 4909.4 4933.2 4972.2 4825.7 4839.6 4946.2 4985.0 5013.5 4847.2 4855.5 4911.2 4967.4 4983.6 4981.1 4983.6 4993.9 5005.2 5023.0 4773.6 4908.3 4939.0 4950.1 4984.3 5298.9 5322.6 5389.3 5393.1 5442.5 5879.0 5879.1 5880.7 5884.7 5907.5 5874.5 5916.5 5938.7 5938.8 5943.2 5329.9 5360.1 5438.4 5461.8 5505.2 5985.8 5998.0 5999.5 6007.9 6032.3 5721.1 5765.8 5774.2 5776.2 5780.7 5657.3 5756.2 5805.7 5853.7 5855.3 5700.9 5711.3 5753.0 5790.1 5790.9 5732.3 5735.5 5736.9 5740.3 5752.5 4410.7 4449.4 4470.7 4472.5 4502.0 3995.1 4027.9 4029.1 4051.8 4076.7 5654.4 5665.9 5667.4 5671.9 5700.3 5702.2 5717.8 5818.4 5906.9 5907.8 5607.7 5708.6 5717.7 5721.7 5740.3 5023.0 5050.4 5060.6 5061.6 5067.8 6168.5 6175.2 6185.8 6185.9 6188.7 5676.1 5725.7 5771.2 5796.7 5833.9 6119.0 6121.1 6122.2 6124.5 6136.7 5740.6 5746.8 5747.1 5747.9 5787.5 5656.3 5714.3 5806.7 5815.5 5821.9 5768.0 5770.4 5778.7 5785.2 5812.3 5749.1 5756.6 5756.9 5762.4 5763.0 5506.8 5508.0 5622.6 5739.5 5746.5 5711.8 5727.3 5781.0 5795.8 5808.3 5676.0 5680.3 5683.1 5683.7 5690.0 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#1] ext.html Cycles:180 Average:50899.19 Median:43136.68 stddev:80989.63 (187.8%) stddev-sans-first:81128.77 01:54:59 INFO - PROCESS | 13680 | Values: 599.6 606.5 634.3 648.5 649.3 43742.6 45854.3 46033.1 50272.0 50368.5 49623.0 50238.7 50330.5 50330.7 50370.0 8643.5 9219.3 9366.3 9378.9 9380.1 8777.6 10483.6 10697.6 10712.8 10994.6 11051.7 11097.7 11173.2 11200.2 11200.3 11026.9 11056.1 11116.3 11127.6 11139.6 11149.9 11215.5 11230.4 11233.1 11237.9 46866.8 47396.3 47401.1 47432.3 47443.3 4320.2 4326.9 4404.8 4482.2 4494.7 34972.3 35032.5 35118.6 35405.5 36807.6 4654.4 4680.5 4728.9 4757.3 4818.1 338125.0 338499.0 343021.0 345287.0 345372.3 67547.0 68003.0 68027.7 68032.3 68144.0 70386.8 70577.3 70579.6 70599.6 70623.6 17528.5 17645.4 17711.1 17730.0 17737.1 13702.5 13886.9 14211.9 15458.7 15590.5 17411.7 18245.3 18275.0 18339.7 18405.3 6025.2 6109.5 6169.9 6222.2 6277.8 968.8 972.9 976.2 980.7 1002.0 33255.0 33350.0 33439.3 33994.7 34116.5 1119.5 1164.7 1168.2 1173.5 1192.0 16854.2 17778.9 17967.6 18057.1 18148.5 154423.0 154683.2 154685.0 154809.2 155832.0 66225.3 66291.7 66354.0 66448.0 66543.3 1507.7 1534.3 1555.3 1556.7 1579.8 31549.5 32638.8 33081.3 33285.3 33406.7 53946.5 54844.7 54874.7 54876.7 55105.4 376810.0 378497.0 378723.0 379582.0 382747.0 43075.0 49372.5 49866.0 49998.8 50751.0 50106.0 50376.5 50859.2 54380.2 54876.0 45165.8 45419.3 46358.4 46911.8 47106.0 44342.6 46216.3 46779.3 47049.8 47798.5 43198.4 43687.6 44181.1 44888.6 45193.0 38733.8 41202.6 41270.6 41346.2 41688.6 29313.6 30820.8 30979.7 31295.2 31301.8 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#2] jquery.html Cycles:180 Average:34980.78 Median:440.87 stddev:108669.21 (24648.8%) stddev-sans-first:108943.00 01:54:59 INFO - PROCESS | 13680 | Values: 381.6 438.9 442.8 445.9 459.3 19800.3 21268.5 22061.7 22080.0 22279.7 21725.9 21745.9 21870.0 22060.8 22220.9 5987.8 6009.8 6102.3 6152.1 6239.4 4551.7 4744.9 6078.8 6079.5 6124.1 4762.5 4780.9 6846.0 6846.2 6971.8 6772.4 6844.6 6866.6 6876.0 6968.0 6038.8 6089.8 6092.1 6094.5 6095.1 24667.4 25080.7 25140.1 25399.5 25589.1 3377.0 3404.0 3411.2 3459.6 3472.7 7776.7 7860.2 12855.4 13072.4 15557.5 1961.5 1975.6 1996.2 2007.6 2016.7 86705.6 87101.0 87450.6 88442.6 89363.0 10318.5 11037.4 11801.3 12065.9 12131.5 15315.6 16063.6 16235.4 16724.7 16789.7 8690.7 8696.6 8813.7 8953.3 8987.1 8346.4 8400.8 8439.6 8538.6 8568.2 7666.6 7815.8 7819.9 7906.2 8013.2 2120.2 2182.9 2191.6 2203.5 2205.0 959.0 959.5 966.1 977.1 984.4 20257.8 21162.2 21344.9 21351.1 21427.6 968.5 981.8 984.7 989.4 1006.4 6701.3 11833.4 12263.9 12298.1 12353.8 511319.0 513912.0 733339.0 737119.0 757169.0 109317.0 113774.0 113790.4 114188.4 114442.4 498.0 512.5 513.4 513.7 515.5 11905.1 12039.4 12354.7 12361.1 12586.9 43618.0 45781.1 46302.3 46904.0 47145.8 62346.7 62872.0 62918.4 63182.0 64784.4 9053.6 9091.9 9433.4 9490.7 9561.5 13440.3 13610.6 13750.3 13885.9 14132.2 10823.6 11665.8 11716.7 11830.1 12147.7 11817.2 12181.4 12304.6 12366.8 12594.9 12219.6 12458.6 12492.6 12510.4 12751.8 9299.0 9304.6 9305.0 9412.0 9419.4 10134.7 11568.9 11618.2 11906.9 11957.7 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#3] mootools.html Cycles:180 Average:5789.79 Median:5010.96 stddev:3159.60 (63.1%) stddev-sans-first:3152.12 01:54:59 INFO - PROCESS | 13680 | Values: 1514.2 1545.2 1545.9 1549.6 1557.1 8385.7 8857.0 8885.8 8895.0 8895.1 7594.3 7869.8 8404.6 8667.0 8677.7 2497.5 2527.1 2545.2 2545.9 2548.0 2449.5 2477.5 2480.7 2491.4 2534.5 2331.1 2346.4 2368.1 2378.9 2379.3 2410.1 2410.2 2431.7 2435.4 2438.2 2414.3 2421.1 2460.8 2475.0 2487.0 8778.3 8840.7 8844.2 8845.7 8849.7 5314.1 5456.2 5458.5 5460.2 5460.8 3453.5 3482.3 3544.4 3573.2 3585.1 1345.4 1348.2 1373.7 1397.3 1407.7 11945.3 11992.3 12007.7 12010.3 12021.6 4780.2 4966.0 4968.9 5034.3 5037.4 10400.6 10432.7 10433.6 10439.3 10439.3 5662.1 5701.6 5704.6 5705.2 5708.0 4792.1 5096.6 5168.6 5181.1 5187.3 3981.8 4055.0 4070.7 4096.8 4124.1 1365.1 1373.6 1382.7 1388.9 1393.0 1018.2 1033.9 1034.3 1040.4 1044.8 5852.6 5878.9 5948.7 6068.5 6119.1 610.4 614.4 620.2 622.8 624.9 4059.5 4202.5 4214.0 4322.6 4324.0 9846.6 10184.2 10187.4 10207.7 10253.6 10092.0 10220.9 10232.9 10245.0 10248.1 7868.5 8076.8 8185.5 8332.0 8363.5 6095.4 6098.2 6116.4 6273.7 6323.9 9826.8 9828.9 9923.3 9933.5 9935.9 9051.7 9316.8 10093.4 10327.3 10335.7 7559.0 7711.4 7752.3 7870.1 7942.5 8746.5 8749.3 8752.8 8788.9 8793.8 7505.4 7548.4 7571.4 7575.1 7699.3 7448.4 7536.4 7562.0 7587.2 7719.5 6665.8 6754.4 6754.6 6755.4 6763.2 5237.7 5251.5 5270.4 5281.7 5452.5 4765.3 4818.3 4820.5 4886.7 4987.6 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#4] prototype.html Cycles:180 Average:4622.06 Median:5185.47 stddev:1278.53 (24.7%) stddev-sans-first:1242.16 01:54:59 INFO - PROCESS | 13680 | Values: 396.3 406.5 408.4 412.4 413.3 5075.4 5240.8 5258.7 5317.3 5328.9 5101.6 5162.3 5185.9 5233.5 5255.5 4190.7 4200.2 4203.3 4218.9 4227.5 4115.9 4229.6 4236.5 4253.1 4271.7 4165.6 4179.9 4197.1 4199.2 4201.2 4174.6 4184.7 4188.4 4191.1 4194.4 3830.2 3838.7 3849.3 3851.8 3855.9 4945.8 5096.5 5139.6 5143.0 5169.5 4843.7 4848.9 4879.6 4880.5 4880.7 5398.8 5436.3 5464.4 5483.8 5490.4 4169.0 4187.8 4250.9 4262.4 4291.9 5635.5 5640.6 5646.7 5699.0 5703.2 4321.3 4384.7 4396.6 4409.6 4413.0 4284.0 4395.8 4402.9 4404.7 4418.7 4833.3 4833.8 4835.0 4836.9 4881.4 5505.6 5522.3 5524.4 5544.4 5553.6 1420.9 1466.8 1469.9 1481.5 1481.5 997.4 1026.2 1027.9 1029.9 1043.1 5206.1 5219.7 5230.7 5232.9 5259.6 5379.5 5388.2 5408.2 5430.7 5441.8 5065.0 5180.3 5185.0 5236.6 5241.2 2877.5 2883.2 2887.1 2888.4 2899.3 5607.6 5609.3 5617.4 5631.8 5650.5 5224.3 5489.7 5529.8 5537.7 5538.3 5614.0 5635.7 5648.4 5674.3 5707.0 5247.5 5404.9 5414.7 5467.0 5488.7 5388.9 5435.9 5436.0 5440.1 5452.3 5698.8 5735.9 5747.9 5751.5 5756.9 4092.1 4194.3 4200.8 4200.9 4225.3 5430.5 5461.8 5464.5 5489.8 5495.3 5313.4 5342.3 5347.8 5354.4 5365.7 5152.0 5195.2 5246.3 5264.2 5289.6 5233.9 5244.7 5264.7 5269.0 5285.2 5116.9 5255.4 5283.7 5364.9 5373.4 5146.1 5154.9 5158.7 5168.1 5218.7 01:54:59 INFO - PROCESS | 13680 | 01:54:59 INFO - PROCESS | 13680 | [#5] yui.html Cycles:180 Average:18228.59 Median:4655.45 stddev:22212.25 (477.1%) stddev-sans-first:22236.05 01:54:59 INFO - PROCESS | 13680 | Values: 809.9 820.5 821.1 861.6 865.1 16006.2 17327.3 17342.7 17367.0 17373.1 15989.8 15999.6 16157.3 16280.2 16300.3 692.4 720.3 808.5 834.2 838.3 840.2 842.7 843.4 844.0 844.8 876.1 876.3 876.5 876.9 877.1 750.4 772.4 855.9 866.8 868.6 648.0 649.1 649.2 649.3 650.4 16162.2 16543.7 16561.3 16572.5 17177.0 13862.4 14420.7 14471.4 14480.6 14611.3 13479.3 13603.5 13632.5 13856.2 14065.0 4655.1 4655.8 4685.2 4712.3 4791.6 71831.3 72676.0 73689.6 76419.6 76778.0 12441.9 12663.9 12676.0 12717.4 12728.3 23292.4 23592.5 23800.3 23801.9 23824.6 8315.3 8564.1 8833.1 8853.1 8939.7 4764.0 4768.3 4795.6 4829.2 4897.7 3643.1 3703.1 3746.2 3748.7 3770.2 583.1 587.3 587.3 591.7 594.6 755.1 768.1 774.1 777.8 794.2 10812.1 10887.5 10900.6 10922.6 11063.2 755.1 756.0 767.1 774.1 828.5 5022.0 5258.6 5288.5 5342.0 5377.0 69286.3 81548.6 82715.0 83196.0 85829.6 68229.0 68452.0 68557.0 68635.7 69333.7 64076.7 64868.0 65780.7 66682.3 66944.7 10181.5 10349.8 10396.3 10575.5 10577.7 44368.0 44487.6 45011.3 45472.3 46187.5 49791.3 51460.0 52049.2 52142.7 55916.0 13368.1 13374.1 13376.6 13413.7 13464.6 15949.5 16300.2 16362.7 16490.6 16497.6 15108.8 15192.9 15316.5 15326.5 16051.4 15059.8 15448.7 15735.1 16018.3 16549.5 14611.7 15331.5 15480.5 15486.8 16118.4 11304.3 11825.5 12154.3 12165.0 12228.5 11229.7 11804.6 11964.6 12018.2 12069.2 01:54:59 INFO - PROCESS | 13680 | -------- Summary: end -------- 01:54:59 INFO - PROCESS | 13680 | 01:55:00 INFO - TEST-INFO | 13680: exit 0 01:55:00 INFO - TEST-OK | dromaeo_css | took 1113449ms 01:55:00 INFO - TEST-START | kraken 01:55:00 INFO - operating with platform_type : linux_ 01:55:00 INFO - Initialising browser for kraken test... 01:55:00 INFO - TEST-INFO | started process 13997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZlsyGr/profile http://localhost:53445/getInfo.html) 01:55:04 INFO - PROCESS | 13997 | __metrics Screen width/height:1600/1200 01:55:04 INFO - PROCESS | 13997 | colorDepth:24 01:55:04 INFO - PROCESS | 13997 | Browser inner width/height: 1024/697 01:55:04 INFO - PROCESS | 13997 | __metrics 01:55:04 INFO - PROCESS | 13997 | 1486634104388 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 01:55:04 INFO - PROCESS | 13997 | 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" 01:55:04 INFO - PROCESS | 13997 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:55:04 INFO - PROCESS | 13997 | console.error: PushService: 01:55:04 INFO - PROCESS | 13997 | stateChangeProcessEnqueue: Error transitioning state 01:55:04 INFO - PROCESS | 13997 | UnknownError 01:55:05 INFO - TEST-INFO | 13997: exit 0 01:55:05 INFO - Browser initialized. 01:55:05 INFO - Running cycle 1/1 for kraken test... 01:55:05 INFO - TEST-INFO | started process 14087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZlsyGr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:55:17 INFO - PROCESS | 14087 | RSS: Main: 138551296 01:55:17 INFO - PROCESS | 14087 | 01:55:20 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53445/tests/kraken/driver.html?testName=audio-beat-detection) 01:55:20 INFO - PROCESS | 14087 | RSS: Main: 182317056 01:55:20 INFO - PROCESS | 14087 | 01:55:23 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53445/tests/kraken/driver.html?testName=audio-dft) 01:55:23 INFO - PROCESS | 14087 | RSS: Main: 172969984 01:55:23 INFO - PROCESS | 14087 | 01:55:26 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53445/tests/kraken/driver.html?testName=audio-fft) 01:55:27 INFO - PROCESS | 14087 | RSS: Main: 264118272 01:55:27 INFO - PROCESS | 14087 | 01:55:29 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53445/tests/kraken/driver.html?testName=audio-oscillator) 01:55:30 INFO - PROCESS | 14087 | RSS: Main: 170708992 01:55:30 INFO - PROCESS | 14087 | 01:55:32 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53445/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:55:32 INFO - PROCESS | 14087 | RSS: Main: 173096960 01:55:32 INFO - PROCESS | 14087 | 01:55:35 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53445/tests/kraken/driver.html?testName=imaging-darkroom) 01:55:36 INFO - PROCESS | 14087 | RSS: Main: 211468288 01:55:36 INFO - PROCESS | 14087 | 01:55:39 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53445/tests/kraken/driver.html?testName=imaging-desaturate) 01:55:40 INFO - PROCESS | 14087 | RSS: Main: 210206720 01:55:40 INFO - PROCESS | 14087 | 01:55:42 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53445/tests/kraken/driver.html?testName=json-parse-financial) 01:55:43 INFO - PROCESS | 14087 | RSS: Main: 208379904 01:55:43 INFO - PROCESS | 14087 | 01:55:45 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53445/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:55:45 INFO - PROCESS | 14087 | RSS: Main: 171016192 01:55:45 INFO - PROCESS | 14087 | 01:55:47 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:55:48 INFO - PROCESS | 14087 | RSS: Main: 177467392 01:55:48 INFO - PROCESS | 14087 | 01:55:49 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:55:50 INFO - PROCESS | 14087 | RSS: Main: 187150336 01:55:50 INFO - PROCESS | 14087 | 01:55:53 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:55:53 INFO - PROCESS | 14087 | RSS: Main: 197632000 01:55:53 INFO - PROCESS | 14087 | 01:55:56 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:55:57 INFO - PROCESS | 14087 | RSS: Main: 192741376 01:55:57 INFO - PROCESS | 14087 | 01:55:58 INFO - PROCESS | 14087 | Cycle 1(1): loaded http://localhost:53445/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53445/tests/kraken/driver.html?testName=ai-astar) 01:55:58 INFO - PROCESS | 14087 | RSS: Main: 245862400 01:55:58 INFO - PROCESS | 14087 | 01:55:58 INFO - PROCESS | 14087 | __start_tp_report 01:55:58 INFO - PROCESS | 14087 | _x_x_mozilla_page_load 01:55:58 INFO - PROCESS | 14087 | _x_x_mozilla_page_load_details 01:55:58 INFO - PROCESS | 14087 | |i|pagename|runs| 01:55:58 INFO - PROCESS | 14087 | |0;ai-astar;111;113;113;112;112;112;112;112;113;113 01:55:58 INFO - PROCESS | 14087 | |1;audio-beat-detection;146;119;120;154;124;118;119;117;144;117 01:55:58 INFO - PROCESS | 14087 | |2;audio-dft;161;160;160;159;162;160;161;160;160;161 01:55:58 INFO - PROCESS | 14087 | |3;audio-fft;75;76;76;103;76;76;79;83;88;75 01:55:58 INFO - PROCESS | 14087 | |4;audio-oscillator;82;82;107;83;84;82;93;82;83;100 01:55:58 INFO - PROCESS | 14087 | |5;imaging-gaussian-blur;118;117;118;117;117;118;117;117;117;117 01:55:58 INFO - PROCESS | 14087 | |6;imaging-darkroom;147;147;146;146;147;147;147;147;146;147 01:55:58 INFO - PROCESS | 14087 | |7;imaging-desaturate;95;96;96;95;96;96;96;95;95;95 01:55:58 INFO - PROCESS | 14087 | |8;json-parse-financial;50;48;49;48;48;49;48;49;49;48 01:55:58 INFO - PROCESS | 14087 | |9;json-stringify-tinderbox;63;64;63;63;62;62;63;66;63;63 01:55:58 INFO - PROCESS | 14087 | |10;stanford-crypto-aes;76;76;76;77;75;75;84;79;76;79 01:55:58 INFO - PROCESS | 14087 | |11;stanford-crypto-ccm;133;133;124;131;128;130;125;122;158;133 01:55:58 INFO - PROCESS | 14087 | |12;stanford-crypto-pbkdf2;157;158;157;159;160;159;155;160;156;156 01:55:58 INFO - PROCESS | 14087 | |13;stanford-crypto-sha256-iterative;60;61;61;60;60;59;61;61;62;58 01:55:58 INFO - PROCESS | 14087 | __end_tp_report 01:55:58 INFO - PROCESS | 14087 | __start_cc_report 01:55:58 INFO - PROCESS | 14087 | _x_x_mozilla_cycle_collect,1546 01:55:58 INFO - PROCESS | 14087 | __end_cc_report 01:55:58 INFO - PROCESS | 14087 | __startTimestamp1486634158991__endTimestamp 01:55:58 INFO - PROCESS | 14087 | 01:55:58 INFO - PROCESS | 14087 | ------- Summary: start ------- 01:55:58 INFO - PROCESS | 14087 | Number of tests: 14 01:55:58 INFO - PROCESS | 14087 | 01:55:58 INFO - PROCESS | 14087 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:0.67 (0.6%) stddev-sans-first:0.53 01:55:58 INFO - PROCESS | 14087 | Values: 111.0 113.0 113.0 112.0 112.0 112.0 112.0 112.0 113.0 113.0 01:55:58 INFO - PROCESS | 14087 | 01:55:58 INFO - PROCESS | 14087 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:122.00 stddev:14.30 (11.7%) stddev-sans-first:13.56 01:55:59 INFO - PROCESS | 14087 | Values: 146.0 119.0 120.0 154.0 124.0 118.0 119.0 117.0 144.0 117.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 01:55:59 INFO - PROCESS | 14087 | Values: 161.0 160.0 160.0 159.0 162.0 160.0 161.0 160.0 160.0 161.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#3] audio-fft Cycles:10 Average:80.70 Median:76.00 stddev:8.90 (11.7%) stddev-sans-first:9.19 01:55:59 INFO - PROCESS | 14087 | Values: 75.0 76.0 76.0 103.0 76.0 76.0 79.0 83.0 88.0 75.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:82.50 stddev:9.07 (11.0%) stddev-sans-first:9.37 01:55:59 INFO - PROCESS | 14087 | Values: 82.0 82.0 107.0 83.0 84.0 82.0 93.0 82.0 83.0 100.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 01:55:59 INFO - PROCESS | 14087 | Values: 118.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 01:55:59 INFO - PROCESS | 14087 | Values: 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 01:55:59 INFO - PROCESS | 14087 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#8] json-parse-financial Cycles:10 Average:48.60 Median:49.00 stddev:0.70 (1.4%) stddev-sans-first:0.53 01:55:59 INFO - PROCESS | 14087 | Values: 50.0 48.0 49.0 48.0 48.0 49.0 48.0 49.0 49.0 48.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 01:55:59 INFO - PROCESS | 14087 | Values: 63.0 64.0 63.0 63.0 62.0 62.0 63.0 66.0 63.0 63.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:76.50 stddev:2.75 (3.6%) stddev-sans-first:2.88 01:55:59 INFO - PROCESS | 14087 | Values: 76.0 76.0 76.0 77.0 75.0 75.0 84.0 79.0 76.0 79.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:132.00 stddev:10.07 (7.6%) stddev-sans-first:10.67 01:55:59 INFO - PROCESS | 14087 | Values: 133.0 133.0 124.0 131.0 128.0 130.0 125.0 122.0 158.0 133.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.50 stddev:1.77 (1.1%) stddev-sans-first:1.86 01:55:59 INFO - PROCESS | 14087 | Values: 157.0 158.0 157.0 159.0 160.0 159.0 155.0 160.0 156.0 156.0 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - PROCESS | 14087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.30 Median:61.00 stddev:1.16 (1.9%) stddev-sans-first:1.22 01:55:59 INFO - PROCESS | 14087 | Values: 60.0 61.0 61.0 60.0 60.0 59.0 61.0 61.0 62.0 58.0 01:55:59 INFO - PROCESS | 14087 | -------- Summary: end -------- 01:55:59 INFO - PROCESS | 14087 | 01:55:59 INFO - TEST-INFO | 14087: exit 0 01:56:00 INFO - TEST-OK | kraken | took 59859ms 01:56:00 INFO - SUITE-END | took 1173s 01:56:00 INFO - Completed test suite (00:19:33) 01:56:00 INFO - javascript benchmark 01:56:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.75626827988, 3250.284937313791, 3273.574435323409, 3299.7525185611084, 3315.8010519368827, 5390.9191362129595, 5463.207834863947, 5468.699221542814, 5470.261514695515, 5486.204500347442, 5485.862853428666, 5504.366997795245, 5510.669359838413, 5513.862153446155, 5515.255440515529, 4884.267359896008, 4893.2170852663585, 4909.361782968209, 4933.186024306003, 4972.154733695281, 4825.734584597846, 4839.612830973531, 4946.183879659852, 4984.950150498503, 5013.498650134976, 4847.1517484440255, 4855.514448555134, 4911.214205727084, 4967.354243948282, 4983.601311895058, 4981.078500477423, 4983.551480366748, 4993.850184494471, 5005.174146265862, 5023.0, 4773.618110551148, 4908.337374454439, 4938.975305123451, 4950.059488697136, 4984.252362145708, 5298.947010529922, 5322.574194064466, 5389.299391079174, 5393.05621516237, 5442.510174084351, 5878.970605146989, 5879.147523609053, 5880.705964701748, 5884.70576471179, 5907.527397808165, 5874.530037596982, 5916.4675179233645, 5938.703064846741, 5938.821835344904, 5943.197668314765, 5329.866753331159, 5360.115580929142, 5438.428964958702, 5461.836144915659, 5505.174223866412, 5985.790497332572, 5997.970010149921, 5999.460048595647, 6007.948608993496, 6032.306284777219, 5721.056025755704, 5765.769369225268, 5774.191613174159, 5776.249087618667, 5780.653160810365, 5657.32112146545, 5756.1653560233535, 5805.709714514257, 5853.678047707332, 5855.326637436664, 5700.857478562986, 5711.343195532484, 5753.021986262345, 5790.073588225863, 5790.855228619234, 5732.283464566929, 5735.4551317624755, 5736.856578585569, 5740.253767010262, 5752.482276595043, 4410.7353558785935, 4449.443819522559, 4470.687051906335, 4472.485664148599, 4502.009557897258, 3995.081131339808, 4027.859024934113, 4029.073313137936, 4051.7771522565954, 4076.673866090706, 5654.40628733977, 5665.915011274834, 5667.376588575254, 5671.943280567141, 5700.258966334433, 5702.201691763156, 5717.800174589308, 5818.389069147764, 5906.911396329058, 5907.763689452374, 5607.663540187602, 5708.600397972185, 5717.714114294268, 5721.742521586539, 5740.253767010262, 5023.0456213320085, 5050.368703912011, 5060.620453466005, 5061.620378471629, 5067.847964561069, 6168.506519478341, 6175.197224360804, 6185.84535386619, 6185.938140618537, 6188.721507532172, 5676.120201368794, 5725.742341594555, 5771.163181338767, 5796.652200867961, 5833.854153646023, 6119.020956646915, 6121.081837724377, 6122.234720659918, 6124.54065945047, 6136.723847426787, 5740.598158129058, 5746.770129194785, 5747.109198074305, 5747.913781293368, 5787.508061814793, 5656.321241451053, 5714.342850572071, 5806.738696758572, 5815.534757219328, 5821.912671309849, 5768.0, 5770.422957704196, 5778.682172480554, 5785.247917770663, 5812.273465816773, 5749.108888122348, 5756.56825738063, 5756.856078597901, 5762.394948530344, 5763.02028655138, 5506.807261745819, 5508.0, 5622.5783066271015, 5739.512141467855, 5746.454086861741, 5711.828645140652, 5727.341355744143, 5781.017227071324, 5795.797147099831, 5808.273965754281, 5676.035074037506, 5680.289963754531, 5683.090705487268, 5683.65898046102, 5689.971550142222], "value": 5398.292688154947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.6222379900662, 606.5147881694643, 634.2642534659793, 648.4747354642743, 649.2922714241475, 43742.56257437425, 45854.31218531725, 46033.07933841321, 50271.994560108775, 50368.49631503684, 49623.0, 50238.74880625592, 50330.49669503304, 50330.74834625831, 50370.0, 8643.524606146659, 9219.308551858603, 9366.297527685418, 9378.906210937907, 9380.108889655472, 8777.605007774666, 10483.580656773758, 10697.572097116106, 10712.78574428511, 10994.615188468406, 11051.668449946514, 11097.667069987914, 11173.21787474877, 11200.159988000893, 11200.327980321166, 11026.889731102747, 11056.11551075916, 11116.333020018825, 11127.554897804079, 11139.554417823318, 11149.888501114967, 11215.495302711397, 11230.382328971904, 11233.10135189183, 11237.887621123766, 46866.76566617179, 47396.289055664194, 47401.051978960226, 47432.28851567229, 47443.28835067477, 4320.1575692739925, 4326.913461730779, 4404.823807047715, 4482.238019536687, 4494.73031618104, 34972.300553988774, 35032.47451288233, 35118.64881351179, 35405.46891796599, 36807.63192368069, 4654.394928659286, 4680.485146633868, 4728.858134255978, 4757.26262429324, 4818.108649899745, 338125.0, 338499.0, 343021.0, 345287.0, 345372.2731386352, 67547.0, 68003.0, 68027.65986170038, 68032.3196768026, 68144.0, 70386.77679339256, 70577.2942270581, 70579.6471017652, 70599.64700176466, 70623.64688176526, 17528.474145775646, 17645.38241161553, 17711.114444277733, 17730.0, 17737.113144342733, 13702.52041178574, 13886.86113138876, 14211.928940355232, 15458.690826183414, 15590.532284031497, 17411.73882391765, 18245.270189192284, 18275.0, 18339.724904126448, 18405.26378944854, 6025.15647809307, 6109.480694141048, 6169.9383006170265, 6222.222222222223, 6277.811665650038, 968.8110818390487, 972.8686627305365, 976.1848856205006, 980.7401038724744, 1002.0330381182049, 33255.0, 33350.0, 33439.3312133756, 33994.66005339915, 34116.48825267623, 1119.4962266979892, 1164.6622479480855, 1168.2406435816788, 1173.495396979307, 1192.0463629096687, 16854.157292135344, 17778.91110544439, 17967.64064718698, 18057.097145142954, 18148.455546333633, 154423.0, 154683.2265838686, 154685.0, 154809.22595386952, 155832.0, 66225.33774662288, 66291.66854165794, 66354.0, 66448.0, 66543.33456665468, 1507.7436835737951, 1534.278888922227, 1555.3312075807285, 1556.743137382342, 1579.8104227492545, 31549.52675709912, 32638.83680581582, 33081.33837323288, 33285.33429331351, 33406.66593334036, 53946.460535394144, 54844.72577637086, 54874.72562637161, 54876.72561637166, 55105.448945510034, 376810.0, 378497.0, 378723.0, 379582.0, 382747.0, 43075.0, 49372.50627493823, 49866.0, 49998.750006249735, 50751.0, 50105.99788004292, 50376.49623503718, 50859.2371114441, 54380.18429723637, 54876.0, 45165.774171128935, 45419.318710218715, 46358.391252797184, 46911.765441172574, 47106.0, 44342.556574433846, 46216.30675539802, 46779.29831052469, 47049.76475117602, 47798.5220147808, 43198.352024719024, 43687.56312436835, 44181.11637767291, 44888.61336639624, 45193.0, 38733.80633096817, 41202.587974121074, 41270.58729412667, 41346.1730765389, 41688.58311416968, 29313.56029659514, 30820.845895770377, 30979.69020309768, 31295.217619559695, 31301.8434907824], "value": 21350.72826548271, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.646030589949, 438.9209942210403, 442.8206576336583, 445.8550970934446, 459.3293791065043, 19800.30698925538, 21268.4682882928, 22061.66907496387, 22080.0, 22279.665805012937, 21725.891370543126, 21745.891270543627, 21870.0, 22060.779392206074, 22220.88889555554, 5987.820365389045, 6009.819705408845, 6102.267727872661, 6152.107944348067, 6239.438450539451, 4551.68138230324, 4744.857654270378, 6078.756849726005, 6079.483243924272, 6124.050772130305, 4762.499937506546, 4780.904381912377, 6845.965770171142, 6846.178458584952, 6971.79084627462, 6772.390484856362, 6844.623545705009, 6866.553674011173, 6876.0, 6967.965160174192, 6038.788642397539, 6089.756409743605, 6092.08618707193, 6094.542909281821, 6095.146679464879, 24667.38331541708, 25080.749192508025, 25140.12009579656, 25399.492010159694, 25589.104381346562, 3377.0, 3403.9659603403898, 3411.249525104473, 3459.567554055743, 3472.739544534145, 7776.688932442696, 7860.213978602152, 12855.421506032251, 13072.43130824307, 15557.455489057942, 1961.460598335469, 1975.5555000125, 1996.2314508914028, 2007.6185524750251, 2016.667249903764, 86705.56647216786, 87101.0, 87450.56274718649, 88442.55778721065, 89362.99999999935, 10318.535665895053, 11037.39294338803, 11801.29192248468, 12065.879341206652, 12131.454084566216, 15315.617109572127, 16063.598410039842, 16235.350585976665, 16724.74912876308, 16789.6642067158, 8690.695825646071, 8696.608652610648, 8813.735587932373, 8953.283737301, 8987.056359082333, 8346.374021948379, 8400.781886626528, 8439.57802109892, 8538.615762290712, 8568.228859402683, 7666.578338191342, 7815.765527034198, 7819.882701759479, 7906.209379062163, 8013.2387423194705, 2120.204923153817, 2182.923597674074, 2191.550732099916, 2203.4931965647993, 2205.0, 958.9664361747306, 959.5490119643756, 966.0822218892081, 977.1254727019278, 984.3700031979539, 20257.797422025593, 21162.153513859583, 21344.893275533523, 21351.14595416197, 21427.571448571252, 968.4795767385604, 981.8183636027358, 984.7390441532856, 989.4014121456559, 1006.4213077480478, 6701.32986701326, 11833.408329583486, 12263.877361226452, 12298.14223381777, 12353.814692779615, 511319.0, 513912.0, 733339.0, 737119.0, 757169.0, 109317.0, 113774.0, 113790.43104784423, 114188.42905785418, 114442.42778786052, 497.9975100124476, 512.5438359859728, 513.3557385481197, 513.7251570409812, 515.487090345109, 11905.107116966088, 12039.398030098635, 12354.691132721395, 12361.134720569833, 12586.874131258937, 43618.0, 45781.08437831292, 46302.30546541737, 46904.0, 47145.790963832, 62346.68826656019, 62872.0, 62918.37081629125, 63182.0, 64784.35215647972, 9053.637854485747, 9091.863622045543, 9433.386829856037, 9490.715278541655, 9561.521923903916, 13440.260785656492, 13610.59168224955, 13750.312484375541, 13885.930570347487, 14132.22272774966, 10823.56705731762, 11665.766684666089, 11716.70708232301, 11830.112741544246, 12147.696307592381, 11817.172797904064, 12181.39093045362, 12304.569340073054, 12366.75266494647, 12594.937025315181, 12219.572314968933, 12458.626241212778, 12492.625221243377, 12510.437030333474, 12751.80872286935, 9299.023602521638, 9304.627814887599, 9304.95347523285, 9412.0, 9419.387739796892, 10134.679966666787, 11568.88431115678, 11618.186726929034, 11906.940465297617, 11957.701057473285], "value": 9821.372032581245, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.2050423527653, 1545.1810540413585, 1545.9149746763926, 1549.6295557163166, 1557.1280083153435, 8385.706500272492, 8856.955715221431, 8885.822283554326, 8895.0, 8895.066018068106, 7594.316511513963, 7869.763907082796, 8404.579771011455, 8667.0, 8677.652893884237, 2497.5379554782335, 2527.140772137473, 2545.2491515003026, 2545.872706364684, 2548.019012680113, 2449.5468338357373, 2477.467344520928, 2480.702315722107, 2491.352248415407, 2534.4677617700304, 2331.067572970817, 2346.3664810501155, 2368.0527788884497, 2378.916737914173, 2379.274321331993, 2410.144398738449, 2410.156445244168, 2431.7203521595065, 2435.391152211947, 2438.1710218525786, 2414.3360575841607, 2421.140495124223, 2460.8277420580566, 2474.9628755568683, 2487.042488641886, 8778.253848422892, 8840.690575829814, 8844.204021638083, 8845.69040083594, 8849.734507964771, 5314.149736042254, 5456.181572764078, 5458.4541545845495, 5460.208269800856, 5460.781568737246, 3453.4992426098324, 3482.2861313430685, 3544.4328907374697, 3573.160307327776, 3585.0858031202138, 1345.3811246826472, 1348.2136169575351, 1373.6703191234033, 1397.31531549541, 1407.6551244945053, 11945.28328300296, 11992.280463172237, 12007.699807504707, 12010.279383237033, 12021.579244726392, 4780.211265141213, 4965.9751701241985, 4968.925466118011, 5034.345535080416, 5037.4458809530925, 10400.635977740894, 10432.739181520523, 10433.582656693647, 10439.321444106108, 10439.321444106108, 5662.094064949671, 5701.600887937804, 5704.629199102045, 5705.2012718219485, 5708.0, 4792.137415265216, 5096.566791822663, 5168.586513078944, 5181.093308671043, 5187.273781670569, 3981.825361518301, 4054.9797251013556, 4070.6539944105084, 4096.795160241976, 4124.092699606082, 1365.1263191557214, 1373.6154670689618, 1382.7165431086603, 1388.902776805614, 1393.0179223647508, 1018.2363227579316, 1033.9483025848829, 1034.332855308322, 1040.3913710479455, 1044.8223801953686, 5852.648841069549, 5878.941210587839, 5948.67282299469, 6068.4538391544975, 6119.082137679295, 610.3987572241339, 614.4469977020627, 620.1906512001881, 622.757124721359, 624.8687775567182, 4059.512858457004, 4202.474690663667, 4213.9578604214175, 4322.589354011364, 4324.027093903846, 9846.556904939294, 10184.185265178769, 10187.439690816927, 10207.693769186937, 10253.58985640581, 10092.0, 10220.897791021995, 10232.948835255926, 10245.026722461354, 10248.128909042814, 7868.488548244461, 8076.8384632307025, 8185.508869467851, 8332.041815191209, 8363.540005299645, 6095.420935011167, 6098.237720284965, 6116.449519543263, 6273.686315684289, 6323.936760632335, 9826.75433114178, 9828.852567211354, 9923.255755818198, 9933.453660048477, 9935.850962235716, 9051.728448146567, 9316.767080823034, 10093.444860532447, 10327.32872363294, 10335.689929302132, 7558.962205188939, 7711.3830893527265, 7752.26353496417, 7870.09493908185, 7942.483738556975, 8746.475211487332, 8749.256313213447, 8752.824943500967, 8788.912110879066, 8793.824123517621, 7505.399568034653, 7548.358389536951, 7571.356434702891, 7575.053118360205, 7699.307062364414, 7448.366888814511, 7536.359409450258, 7561.962190189014, 7587.203343648837, 7719.536827790351, 6665.833354166185, 6754.425873800782, 6754.5609535380045, 6755.42578880781, 6763.188417389944, 5237.738113094406, 5251.52736253739, 5270.420253772006, 5281.735913204401, 5452.482014208644, 4765.285207218945, 4818.325434439252, 4820.517948205152, 4886.682365646222, 4987.576056035277], "value": 4674.382923554233, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.3440505962633, 406.52842702465136, 408.44247602023245, 412.3711340206184, 413.2912055824261, 5075.416327122382, 5240.764165612557, 5258.710770907599, 5317.282166907471, 5328.946710532893, 5101.591872650189, 5162.303089082972, 5185.948140518593, 5233.476652334764, 5255.527002569768, 4190.727602705814, 4200.222958752641, 4203.264428724976, 4218.873433796991, 4227.492700875884, 4115.938260926088, 4229.555896630855, 4236.4916210054835, 4253.1493701259715, 4271.722338048033, 4165.6250937415625, 4179.853705120321, 4197.13227613712, 4199.223143718422, 4201.1807697499, 4174.5616710245295, 4184.66522678185, 4188.371744238359, 4191.11986482839, 4194.4337514435465, 3830.2148059647707, 3838.654521093087, 3849.345611246095, 3851.8074096295354, 3855.9421608675893, 4945.802167913279, 5096.464871188546, 5139.640225184238, 5142.974285128588, 5169.457206993249, 4843.70937743733, 4848.878778030577, 4879.609631229493, 4880.511948805127, 4880.657284503458, 5398.811041613564, 5436.3476382833915, 5464.426235245322, 5483.835484935458, 5490.435225960622, 4169.0, 4187.811548480326, 4250.936235956463, 4262.403263543107, 4291.935620965688, 5635.549156067505, 5640.633358831663, 5646.661200327952, 5699.0, 5703.17498400512, 4321.330193819963, 4384.7369157850635, 4396.582324679214, 4409.647228221735, 4412.955870441318, 4284.0, 4395.84614538496, 4402.8679139625865, 4404.66964977628, 4418.690691651618, 4833.260026390497, 4833.782479788418, 4834.95165048352, 4836.927446088312, 4881.438634557, 5505.614606977553, 5522.282103326542, 5524.447555244444, 5544.421843842552, 5553.6390134641115, 1420.9431622734976, 1466.7726502392147, 1469.9049208339854, 1481.4814814814729, 1481.518506485375, 997.4065431068502, 1026.2200727447193, 1027.9155490957112, 1029.912457441126, 1043.139409986764, 5206.114960456732, 5219.739013049332, 5230.660007099526, 5232.947670523322, 5259.579233661298, 5379.54273886724, 5388.191771234347, 5408.188771684278, 5430.701311427831, 5441.8095366662765, 5064.974675126601, 5180.274761533388, 5185.0, 5236.554892834076, 5241.24002019705, 2877.4676684812957, 2883.2215301868796, 2887.1417296875943, 2888.393437378174, 2899.3041669999047, 5607.551355916164, 5609.270794796732, 5617.38208797032, 5631.774729010794, 5650.463205995424, 5224.320838290998, 5489.670619762827, 5529.751161197756, 5537.723113844291, 5538.307711536058, 5614.0, 5635.690037048002, 5648.350439699405, 5674.347450043216, 5706.971465142731, 5247.501487358695, 5404.864878378072, 5414.675119492843, 5467.020473841686, 5488.69812160335, 5388.865278368072, 5435.918461223006, 5436.0, 5440.1023831069015, 5452.318460192476, 5698.8290351289525, 5735.885282294247, 5747.942520574741, 5751.4536119068625, 5756.884862302814, 4092.140650463436, 4194.328907374927, 4200.768957707355, 4200.894977625584, 4225.302825033835, 5430.456954304538, 5461.808836690697, 5464.508194262536, 5489.835304940858, 5495.313085864267, 5313.362396512443, 5342.332208473941, 5347.812826551052, 5354.411014788292, 5365.678059316453, 5151.969335855888, 5195.246689230116, 5246.26873131858, 5264.15773476242, 5289.603279754111, 5233.947660523346, 5244.685318880879, 5264.710440925633, 5268.997780843255, 5285.225256740242, 5116.872078198075, 5255.421903590525, 5283.682979021271, 5364.892702146013, 5373.35519737634, 5146.099432599355, 5154.922676159786, 5158.690478571298, 5168.095583272988, 5218.686134304668], "value": 4238.259938865909, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [809.9149589293124, 820.5445977482494, 821.092692574705, 861.5778268648362, 865.1435079271521, 16006.199690015495, 17327.30690772371, 17342.739858902125, 17367.0, 17373.131343432808, 15989.84010159898, 15999.600009999756, 16157.272922718477, 16280.185990700476, 16300.26648800804, 692.418368570402, 720.3300930134973, 808.5108509351845, 834.1825011488745, 838.3042075077701, 840.2269911681237, 842.7387509871959, 843.3969711656165, 843.9873401898976, 844.7676888855583, 876.1238761238761, 876.2508055612456, 876.4565969099167, 876.9386142969995, 877.0615441477621, 750.4334227658138, 772.3628006894306, 855.9400841941067, 866.8049688820028, 868.5743985447117, 648.044134901022, 649.1496140056494, 649.1787888321277, 649.2792999770252, 650.4048795352247, 16162.222155562878, 16543.669126617522, 16561.25474353645, 16572.50282491527, 17177.0, 13862.4455021799, 14420.711585768331, 14471.42114315426, 14480.637984050378, 14611.342489587887, 13479.326033698373, 13603.455861765617, 13632.454701811916, 13856.168629882239, 14065.0, 4655.068986202739, 4655.837045703418, 4685.180093483661, 4712.340272361872, 4791.616670666338, 71831.31372655793, 72676.0, 73689.63155184244, 76419.61790191014, 76778.0, 12441.93779031117, 12663.873361266269, 12675.985921126288, 12717.427715752814, 12728.29994350301, 23292.417689557897, 23592.528149436916, 23800.285991420285, 23801.880990595284, 23824.64263036056, 8315.334773218128, 8564.057953625097, 8833.116688331243, 8853.114688531095, 8939.73180804577, 4763.976180119077, 4768.332433459318, 4795.6163506919365, 4829.203181475087, 4897.657163998486, 3643.107438677488, 3703.092742278105, 3746.194568167857, 3748.6813620842536, 3770.1517158639085, 583.0583607473899, 587.2952457051555, 587.2981786764775, 591.659795617513, 594.6016169166583, 755.1165136789969, 768.1320108277611, 774.0981756254014, 777.8133248020547, 794.209761287511, 10812.135029197645, 10887.510062047228, 10900.618478353379, 10922.563097476012, 11063.170262230366, 755.1391413788285, 755.9659815308324, 767.094828102844, 774.0943096577018, 828.5070383122032, 5022.0, 5258.553022993012, 5288.497592728685, 5342.0, 5377.0, 69286.30713692798, 81548.59225703834, 82715.0, 83196.0, 85829.57085214533, 68229.0, 68452.0, 68557.0, 68635.65682171658, 69333.65333173302, 64076.67961660162, 64868.0, 65780.6710966442, 66682.33317666859, 66944.6652766733, 10181.541830617492, 10349.808327627323, 10396.272260941661, 10575.471226438493, 10577.682669519927, 44368.0, 44487.55512444834, 45011.32483012692, 45472.31791523196, 46187.538124618324, 49791.25313120378, 51460.0, 52049.21926171186, 52142.739286303324, 55916.0, 13368.131071480322, 13374.13068150567, 13376.598702038955, 13413.731725365633, 13464.596062118153, 15949.521514354588, 16300.184990750653, 16362.672746544764, 16490.58773530671, 16497.587560310607, 15108.773368399263, 15192.924035379752, 15316.540503784905, 15326.540203793904, 16051.357945682508, 15059.77410338824, 15448.691026179638, 15735.134567598892, 16018.256793081373, 16549.50351489457, 14611.707765844836, 15331.463398780988, 15480.5355839325, 15486.845131548991, 16118.355265789238, 11304.265222760494, 11825.467853946766, 12154.331511766584, 12165.0, 12228.510859565873, 11229.719257018312, 11804.639072185426, 11964.58123965657, 12018.158728888893, 12069.155159139127], "value": 7693.616882630133, "unit": "score"}], "name": "dromaeo_css", "value": 7461.426838827394, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 119.0, 120.0, 154.0, 124.0, 118.0, 119.0, 117.0, 144.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 159.0, 162.0, 160.0, 161.0, 160.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 103.0, 76.0, 76.0, 79.0, 83.0, 88.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 107.0, 83.0, 84.0, 82.0, 93.0, 82.0, 83.0, 100.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 49.0, 48.0, 48.0, 49.0, 48.0, 49.0, 49.0, 48.0], "value": 48.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 62.0, 62.0, 63.0, 66.0, 63.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 77.0, 75.0, 75.0, 84.0, 79.0, 76.0, 79.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 133.0, 124.0, 131.0, 128.0, 130.0, 125.0, 122.0, 158.0, 133.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 158.0, 157.0, 159.0, 160.0, 159.0, 155.0, 160.0, 156.0, 156.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 60.0, 59.0, 61.0, 61.0, 62.0, 58.0], "value": 60.3, "unit": "score"}], "name": "kraken", "value": 1467.3, "alertThreshold": 2.0}]} 01:56:00 INFO - Return code: 0 01:56:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:56:00 ERROR - # TBPL SUCCESS # 01:56:00 INFO - Running post-action listener: _resource_record_post_action 01:56:00 INFO - [mozharness: 2017-02-09 09:56:00.319801Z] Finished run-tests step (success) 01:56:00 INFO - Running post-run listener: _resource_record_post_run 01:56:00 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 364814336; Read time: 16; Write time: 268876 01:56:00 INFO - TinderboxPrint: CPU usage
13.1% 01:56:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 01:56:00 INFO - TinderboxPrint: I/O write bytes / time
364,814,336 / 268,876 01:56:00 INFO - TinderboxPrint: CPU idle
8,257.2 (86.9%) 01:56:00 INFO - TinderboxPrint: CPU user
1,196.9 (12.6%) 01:56:00 INFO - TinderboxPrint: Swap in / out
0 / 0 01:56:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109494272; Read time: 0; Write time: 104084 01:56:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 254398464; Read time: 16; Write time: 164772 01:56:00 INFO - Running post-run listener: _upload_blobber_files 01:56:00 INFO - Blob upload gear active. 01:56:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:56: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 01:56: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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:56: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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:56:01 INFO - (blobuploader) - INFO - Open directory for files ... 01:56:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:56:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:56:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:56:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:56:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:56:03 INFO - (blobuploader) - INFO - Done attempting. 01:56:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:56:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:56:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:56:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:56:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:56:07 INFO - (blobuploader) - INFO - Done attempting. 01:56:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:56:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:56:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:56:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:56:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:56:10 INFO - (blobuploader) - INFO - Done attempting. 01:56:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:56:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:56:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:56:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:56:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:56:13 INFO - (blobuploader) - INFO - Done attempting. 01:56:13 INFO - (blobuploader) - INFO - Iteration through files over. 01:56:13 INFO - Return code: 0 01:56:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:56:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:56:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e251c1f1428a7811c33e99ccf4aa3d4f029298769cf29f1ae588fe084a67e83c20a738bf89c1bcf1596bb6e52bc5567e846a1cf7b38d916b7022e12d51f59bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66e5901a47a4d04f1b56aa9888117c0417c4339920055680d03243d5eda173d0c00feafa167afe7fa1ba6b83ad550a7c243e2ce75ef88b121e972918e061c28a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45fd5017377b561af116077e7bc7ed6af6dcc5e4feeff62c56b442a4749586c1b2365cdac4ea9d578b5be3da2502bf681b65c90e9cd93bc360f5eb73408042da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f368ee97102b4fe0256c6449a9dd43621fc4b72d2f484cc5a764e815316beac6f86fa813a130261a7dd2e48daf98c641cdc452b49beeeddd902cb74a0b088a"} 01:56:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:56:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:56:13 INFO - Contents: 01:56:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e251c1f1428a7811c33e99ccf4aa3d4f029298769cf29f1ae588fe084a67e83c20a738bf89c1bcf1596bb6e52bc5567e846a1cf7b38d916b7022e12d51f59bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66e5901a47a4d04f1b56aa9888117c0417c4339920055680d03243d5eda173d0c00feafa167afe7fa1ba6b83ad550a7c243e2ce75ef88b121e972918e061c28a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45fd5017377b561af116077e7bc7ed6af6dcc5e4feeff62c56b442a4749586c1b2365cdac4ea9d578b5be3da2502bf681b65c90e9cd93bc360f5eb73408042da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f368ee97102b4fe0256c6449a9dd43621fc4b72d2f484cc5a764e815316beac6f86fa813a130261a7dd2e48daf98c641cdc452b49beeeddd902cb74a0b088a"} 01:56:13 INFO - Running post-run listener: copy_logs_to_upload_dir 01:56:13 INFO - Copying logs to upload dir... 01:56:13 INFO - mkdir: /builds/slave/test/build/upload/logs 01:56:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.907181 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2017-02-09 01:56:12.533064) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 01:56:12.537232) ========= 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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e251c1f1428a7811c33e99ccf4aa3d4f029298769cf29f1ae588fe084a67e83c20a738bf89c1bcf1596bb6e52bc5567e846a1cf7b38d916b7022e12d51f59bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66e5901a47a4d04f1b56aa9888117c0417c4339920055680d03243d5eda173d0c00feafa167afe7fa1ba6b83ad550a7c243e2ce75ef88b121e972918e061c28a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45fd5017377b561af116077e7bc7ed6af6dcc5e4feeff62c56b442a4749586c1b2365cdac4ea9d578b5be3da2502bf681b65c90e9cd93bc360f5eb73408042da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f368ee97102b4fe0256c6449a9dd43621fc4b72d2f484cc5a764e815316beac6f86fa813a130261a7dd2e48daf98c641cdc452b49beeeddd902cb74a0b088a"} build_url:https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011248 build_url: 'https://queue.taskcluster.net/v1/task/XAEIkxS3T8SCTxkzM8PGTw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e251c1f1428a7811c33e99ccf4aa3d4f029298769cf29f1ae588fe084a67e83c20a738bf89c1bcf1596bb6e52bc5567e846a1cf7b38d916b7022e12d51f59bce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/66e5901a47a4d04f1b56aa9888117c0417c4339920055680d03243d5eda173d0c00feafa167afe7fa1ba6b83ad550a7c243e2ce75ef88b121e972918e061c28a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45fd5017377b561af116077e7bc7ed6af6dcc5e4feeff62c56b442a4749586c1b2365cdac4ea9d578b5be3da2502bf681b65c90e9cd93bc360f5eb73408042da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16f368ee97102b4fe0256c6449a9dd43621fc4b72d2f484cc5a764e815316beac6f86fa813a130261a7dd2e48daf98c641cdc452b49beeeddd902cb74a0b088a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 01:56:12.566243) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:56:12.566848) ========= 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=923d835db2ba3686ebe126b700000192-1486632928.725595-1641956495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 01:56:12.647633) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 01:56:12.647966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 01:56:12.648271) ========= ========= Total master_lag: 0.18 =========