builder: graphics_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1484626001.41 results: success (0) revision: b85cf10fae3d94b835f21bf27db7091e010572ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.407962) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.408460) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.408815) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.423692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.424076) ========= 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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-16 20:06:41-- 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% 220M=0s 2017-01-16 20:06:41 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137079 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.575294) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.575674) ========= 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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017896 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:41.625879) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 20:06:41.626281) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev b85cf10fae3d94b835f21bf27db7091e010572ec --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/graphics --rev b85cf10fae3d94b835f21bf27db7091e010572ec --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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-16 20:06:41,828 truncating revision to first 12 chars 2017-01-16 20:06:41,829 Setting DEBUG logging. 2017-01-16 20:06:41,829 attempt 1/10 2017-01-16 20:06:41,829 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/b85cf10fae3d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-16 20:06:43,038 unpacking tar archive at: graphics-b85cf10fae3d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.514295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-16 20:06:43.154397) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:43.154791) ========= script_repo_revision: b85cf10fae3d94b835f21bf27db7091e010572ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:43.155242) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:43.155589) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-16 20:06:43.165311) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-16 20:06:43.165667) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:43 INFO - MultiFileLogger online at 20170116 20:06:43 in /builds/slave/test 20:06:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 20:06:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:43 INFO - {'append_to_log': False, 20:06:43 INFO - 'base_work_dir': '/builds/slave/test', 20:06:43 INFO - 'blob_upload_branch': 'Graphics', 20:06:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:43 INFO - 'branch': 'Graphics', 20:06:43 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:43 INFO - 'config_files': ('talos/linux_config.py',), 20:06:43 INFO - 'default_actions': ('clobber', 20:06:43 INFO - 'read-buildbot-config', 20:06:43 INFO - 'download-and-extract', 20:06:43 INFO - 'populate-webroot', 20:06:43 INFO - 'create-virtualenv', 20:06:43 INFO - 'install', 20:06:43 INFO - 'run-tests'), 20:06:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:43 INFO - 'download_minidump_stackwalk': True, 20:06:43 INFO - 'download_symbols': 'ondemand', 20:06:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:43 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:43 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:43 INFO - 'installer_path': 'installer.exe', 20:06:43 INFO - 'log_level': 'info', 20:06:43 INFO - 'log_name': 'talos', 20:06:43 INFO - 'log_to_console': True, 20:06:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:43 INFO - 'opt_config_files': (), 20:06:43 INFO - 'pip_index': False, 20:06:43 INFO - 'sps_profile': False, 20:06:43 INFO - 'sps_profile_interval': 0, 20:06:43 INFO - 'suite': 'dromaeojs', 20:06:43 INFO - 'system_bits': '32', 20:06:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:43 INFO - 'title': 'talos-linux64-ix-036', 20:06:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:43 INFO - 'use_talos_json': True, 20:06:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:43 INFO - 'work_dir': 'build'} 20:06:43 INFO - [mozharness: 2017-01-17 04:06:43.464368Z] Running clobber step. 20:06:43 INFO - Running pre-action listener: _resource_record_pre_action 20:06:43 INFO - Running main action method: clobber 20:06:43 INFO - rmtree: /builds/slave/test/build 20:06:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:44 INFO - Running post-action listener: _resource_record_post_action 20:06:44 INFO - [mozharness: 2017-01-17 04:06:44.429814Z] Finished clobber step (success) 20:06:44 INFO - [mozharness: 2017-01-17 04:06:44.429913Z] Running read-buildbot-config step. 20:06:44 INFO - Running pre-action listener: _resource_record_pre_action 20:06:44 INFO - Running main action method: read_buildbot_config 20:06:44 INFO - Using buildbot properties: 20:06:44 INFO - { 20:06:44 INFO - "project": "", 20:06:44 INFO - "product": "firefox", 20:06:44 INFO - "who": "sikeda@mozilla.com", 20:06:44 INFO - "installer_path": "public/build/target.tar.bz2", 20:06:44 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs", 20:06:44 INFO - "repository": "https://hg.mozilla.org/projects/graphics/", 20:06:44 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs", 20:06:44 INFO - "stage_platform": "linux64", 20:06:44 INFO - "basedir": "/builds/slave/test", 20:06:44 INFO - "buildnumber": 27, 20:06:44 INFO - "platform": "ubuntu64_hw", 20:06:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:06:44 INFO - "slavebuilddir": "test", 20:06:44 INFO - "taskId": "cV6JqbXcQhOdli2zvTChdA", 20:06:44 INFO - "branch": "graphics", 20:06:44 INFO - "script_repo_revision": "default", 20:06:44 INFO - "revision": "b85cf10fae3d94b835f21bf27db7091e010572ec", 20:06:44 INFO - "slavename": "talos-linux64-ix-036", 20:06:44 INFO - "repo_path": "projects/graphics" 20:06:44 INFO - } 20:06:44 INFO - Finding installer, test and symbols from parent task. 20:06:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cV6JqbXcQhOdli2zvTChdA'}, attempt #1 20:06:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cV6JqbXcQhOdli2zvTChdA'}, attempt #1 20:06:45 INFO - Task dependencies: eAQFLDFTRdWzqPkZ-vCB5w 20:06:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w'}, attempt #1 20:06:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 20:06:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/test_packages.json 20:06:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.crashreporter-symbols.zip 20:06:45 INFO - Running post-action listener: _resource_record_post_action 20:06:45 INFO - [mozharness: 2017-01-17 04:06:45.803189Z] Finished read-buildbot-config step (success) 20:06:45 INFO - [mozharness: 2017-01-17 04:06:45.803407Z] Running download-and-extract step. 20:06:45 INFO - Running pre-action listener: _resource_record_pre_action 20:06:45 INFO - Running main action method: download_and_extract 20:06:45 INFO - mkdir: /builds/slave/test/build/tests 20:06: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')]} 20:06:45 INFO - trying https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.test_packages.json 20:06:45 INFO - Downloading https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 20:06:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 20:06:46 INFO - Downloaded 896 bytes. 20:06:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 20:06:46 INFO - Using the following test package requirements: 20:06:46 INFO - {u'common': [u'target.common.tests.zip'], 20:06:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 20:06:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 20:06:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 20:06:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 20:06:46 INFO - u'mozbase': [u'target.common.tests.zip'], 20:06:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 20:06:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 20:06:46 INFO - u'web-platform': [u'target.common.tests.zip', 20:06:46 INFO - u'target.web-platform.tests.zip'], 20:06:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 20:06:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 20:06:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip 20:06:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:06:46 INFO - Fetch https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip into memory 20:06:47 INFO - Expected file size: 20270927 20:06:47 INFO - Obtained file size: 20270927 20:06:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 20:06:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip 20:06:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip'}, attempt #1 20:06:51 INFO - Fetch https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.common.tests.zip into memory 20:06:52 INFO - Expected file size: 20270927 20:06:52 INFO - Obtained file size: 20270927 20:06:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.talos.tests.zip 20:06:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 20:06:56 INFO - Fetch https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.talos.tests.zip into memory 20:06:57 INFO - Expected file size: 14403463 20:06:57 INFO - Obtained file size: 14403463 20:06:57 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')]} 20:06:57 INFO - trying https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 20:06:57 INFO - Downloading https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 20:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 20:06:59 INFO - Downloaded 56087173 bytes. 20:06:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 20:06:59 INFO - mkdir: /builds/slave/test/properties 20:06:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:59 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:59 INFO - Contents: 20:06:59 INFO - build_url:https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 20:06:59 INFO - Running post-action listener: _resource_record_post_action 20:06:59 INFO - Running post-action listener: set_extra_try_arguments 20:06:59 INFO - [mozharness: 2017-01-17 04:06:59.520813Z] Finished download-and-extract step (success) 20:06:59 INFO - [mozharness: 2017-01-17 04:06:59.520931Z] Running populate-webroot step. 20:06:59 INFO - Running pre-action listener: _resource_record_pre_action 20:06:59 INFO - Running main action method: populate_webroot 20:06:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:59 INFO - '--tppagecycles', 20:06:59 INFO - '7'], 20:06:59 INFO - 'tests': ['tsvgm']}}, 20:06:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['damp', 'tps']}, 20:06:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'tests': ['damp', 'tps']}, 20:06:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['dromaeo_dom']}, 20:06:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['basic_compositor_video']}, 20:06:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['a11yr', 20:06:59 INFO - 'ts_paint', 20:06:59 INFO - 'tpaint', 20:06:59 INFO - 'sessionrestore', 20:06:59 INFO - 'sessionrestore_no_auto_restore', 20:06:59 INFO - 'tabpaint']}, 20:06:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['tsvgx', 20:06:59 INFO - 'tsvgr_opacity', 20:06:59 INFO - 'tart', 20:06:59 INFO - 'tscrollx', 20:06:59 INFO - 'cart', 20:06:59 INFO - 'tsvg_static']}, 20:06:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:59 INFO - 'tsvgr_opacity', 20:06:59 INFO - 'tart', 20:06:59 INFO - 'tscrollx', 20:06:59 INFO - 'cart', 20:06:59 INFO - 'tsvg_static']}, 20:06:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'talos_options': ['--disable-e10s'], 20:06:59 INFO - 'tests': ['tp5o']}, 20:06:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:06:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'talos_options': ['--disable-e10s', 20:06:59 INFO - '--xperf_path', 20:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:59 INFO - 'tests': ['tp5n']}, 20:06:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:06:59 INFO - 'talos_options': ['--xperf_path', 20:06:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:59 INFO - 'tests': ['tp5n']}}, 20:06:59 INFO - 'talos.zip': {'path': '', 20:06:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:59 INFO - Running post-action listener: _resource_record_post_action 20:06:59 INFO - [mozharness: 2017-01-17 04:06:59.533930Z] Finished populate-webroot step (success) 20:06:59 INFO - [mozharness: 2017-01-17 04:06:59.534022Z] Running create-virtualenv step. 20:06:59 INFO - Running pre-action listener: _resource_record_pre_action 20:06:59 INFO - Running main action method: create_virtualenv 20:06:59 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:59 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 20:06:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:59 INFO - Using real prefix '/usr' 20:06:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:07:00 INFO - Installing distribute.............................................................................................................................................................................................done. 20:07:02 INFO - Installing pip.................done. 20:07:02 INFO - Return code: 0 20:07:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:07:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:07:02 INFO - Reading from file tmpfile_stdout 20:07:02 INFO - Output received: 20:07:02 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) 20:07:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:07:02 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')]} 20:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:02 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')]} 20:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:02 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:02 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 20:07:02 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 20:07:02 INFO - Using env: {'DISPLAY': ':0', 20:07:02 INFO - 'HOME': '/home/cltbld', 20:07:02 INFO - 'LANG': 'en_US.UTF-8', 20:07:02 INFO - 'LANGUAGE': 'en_US:en', 20:07:02 INFO - 'LOGNAME': 'cltbld', 20:07:02 INFO - 'MAIL': '/var/mail/cltbld', 20:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:02 INFO - 'MOZ_NO_REMOTE': '1', 20:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:02 INFO - 'NO_EM_RESTART': '1', 20:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:02 INFO - 'PWD': '/builds/slave/test', 20:07:02 INFO - 'SHELL': '/bin/bash', 20:07:02 INFO - 'SHLVL': '1', 20:07:02 INFO - 'TERM': 'linux', 20:07:02 INFO - 'TMOUT': '86400', 20:07:02 INFO - 'USER': 'cltbld', 20:07:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:02 INFO - '_': '/tools/buildbot/bin/python'} 20:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:02 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 20:07:02 INFO - Cleaning up... 20:07:02 INFO - Return code: 0 20:07:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:07:02 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')]} 20:07:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:02 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')]} 20:07:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:02 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:02 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 20:07:02 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 20:07:02 INFO - Using env: {'DISPLAY': ':0', 20:07:02 INFO - 'HOME': '/home/cltbld', 20:07:02 INFO - 'LANG': 'en_US.UTF-8', 20:07:02 INFO - 'LANGUAGE': 'en_US:en', 20:07:02 INFO - 'LOGNAME': 'cltbld', 20:07:02 INFO - 'MAIL': '/var/mail/cltbld', 20:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:02 INFO - 'MOZ_NO_REMOTE': '1', 20:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:02 INFO - 'NO_EM_RESTART': '1', 20:07:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:02 INFO - 'PWD': '/builds/slave/test', 20:07:02 INFO - 'SHELL': '/bin/bash', 20:07:02 INFO - 'SHLVL': '1', 20:07:02 INFO - 'TERM': 'linux', 20:07:02 INFO - 'TMOUT': '86400', 20:07:02 INFO - 'USER': 'cltbld', 20:07:02 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:02 INFO - '_': '/tools/buildbot/bin/python'} 20:07:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:02 INFO - Downloading/unpacking psutil>=3.1.1 20:07:02 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 20:07:02 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 20:07:02 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 20:07:02 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 20:07:02 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 20:07:02 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 20:07:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:07:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:04 INFO - Installing collected packages: psutil 20:07:04 INFO - Running setup.py install for psutil 20:07:04 INFO - building 'psutil._psutil_linux' extension 20:07:04 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 20:07:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:07:05 INFO - building 'psutil._psutil_posix' extension 20:07:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:07:05 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:07:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:07:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:07:05 INFO - Successfully installed psutil 20:07:05 INFO - Cleaning up... 20:07:05 INFO - Return code: 0 20:07:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:07: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')]} 20:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07: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')]} 20:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:05 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:05 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 20:07:05 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 20:07:05 INFO - Using env: {'DISPLAY': ':0', 20:07:05 INFO - 'HOME': '/home/cltbld', 20:07:05 INFO - 'LANG': 'en_US.UTF-8', 20:07:05 INFO - 'LANGUAGE': 'en_US:en', 20:07:05 INFO - 'LOGNAME': 'cltbld', 20:07:05 INFO - 'MAIL': '/var/mail/cltbld', 20:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:05 INFO - 'MOZ_NO_REMOTE': '1', 20:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:05 INFO - 'NO_EM_RESTART': '1', 20:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:05 INFO - 'PWD': '/builds/slave/test', 20:07:05 INFO - 'SHELL': '/bin/bash', 20:07:05 INFO - 'SHLVL': '1', 20:07:05 INFO - 'TERM': 'linux', 20:07:05 INFO - 'TMOUT': '86400', 20:07:05 INFO - 'USER': 'cltbld', 20:07:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:05 INFO - '_': '/tools/buildbot/bin/python'} 20:07:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:05 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 20:07:05 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 20:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:07:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:07:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:07:07 INFO - Installing collected packages: mozsystemmonitor 20:07:07 INFO - Running setup.py install for mozsystemmonitor 20:07:07 INFO - Successfully installed mozsystemmonitor 20:07:07 INFO - Cleaning up... 20:07:07 INFO - Return code: 0 20:07:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:07:07 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')]} 20:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:07 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')]} 20:07:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:07 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 20:07:07 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 20:07:07 INFO - Using env: {'DISPLAY': ':0', 20:07:07 INFO - 'HOME': '/home/cltbld', 20:07:07 INFO - 'LANG': 'en_US.UTF-8', 20:07:07 INFO - 'LANGUAGE': 'en_US:en', 20:07:07 INFO - 'LOGNAME': 'cltbld', 20:07:07 INFO - 'MAIL': '/var/mail/cltbld', 20:07:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:07 INFO - 'MOZ_NO_REMOTE': '1', 20:07:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:07 INFO - 'NO_EM_RESTART': '1', 20:07:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:07 INFO - 'PWD': '/builds/slave/test', 20:07:07 INFO - 'SHELL': '/bin/bash', 20:07:07 INFO - 'SHLVL': '1', 20:07:07 INFO - 'TERM': 'linux', 20:07:07 INFO - 'TMOUT': '86400', 20:07:07 INFO - 'USER': 'cltbld', 20:07:07 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:07 INFO - '_': '/tools/buildbot/bin/python'} 20:07:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:08 INFO - Downloading/unpacking jsonschema==2.5.1 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:08 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 20:07:08 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 20:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:07:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:10 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 20:07:10 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 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:10 INFO - Downloading functools32-3.2.3-2.tar.gz 20:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:07:10 INFO - warning: no files found matching '*.txt' 20:07:10 INFO - no previously-included directories found matching 'build' 20:07:10 INFO - no previously-included directories found matching 'dist' 20:07:10 INFO - no previously-included directories found matching '.git*' 20:07:10 INFO - Installing collected packages: jsonschema, functools32 20:07:10 INFO - Running setup.py install for functools32 20:07:10 INFO - warning: no files found matching '*.txt' 20:07:10 INFO - no previously-included directories found matching 'build' 20:07:10 INFO - no previously-included directories found matching 'dist' 20:07:10 INFO - no previously-included directories found matching '.git*' 20:07:10 INFO - Successfully installed jsonschema functools32 20:07:10 INFO - Cleaning up... 20:07:10 INFO - Return code: 0 20:07:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:07:10 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')]} 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:10 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')]} 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:10 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 20:07:10 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 20:07:10 INFO - Using env: {'DISPLAY': ':0', 20:07:10 INFO - 'HOME': '/home/cltbld', 20:07:10 INFO - 'LANG': 'en_US.UTF-8', 20:07:10 INFO - 'LANGUAGE': 'en_US:en', 20:07:10 INFO - 'LOGNAME': 'cltbld', 20:07:10 INFO - 'MAIL': '/var/mail/cltbld', 20:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:10 INFO - 'MOZ_NO_REMOTE': '1', 20:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:10 INFO - 'NO_EM_RESTART': '1', 20:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:10 INFO - 'PWD': '/builds/slave/test', 20:07:10 INFO - 'SHELL': '/bin/bash', 20:07:10 INFO - 'SHLVL': '1', 20:07:10 INFO - 'TERM': 'linux', 20:07:10 INFO - 'TMOUT': '86400', 20:07:10 INFO - 'USER': 'cltbld', 20:07:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:10 INFO - '_': '/tools/buildbot/bin/python'} 20:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:07:10 INFO - Cleaning up... 20:07:10 INFO - Return code: 0 20:07:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:07:10 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')]} 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:10 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')]} 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:10 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 20:07:10 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 20:07:10 INFO - Using env: {'DISPLAY': ':0', 20:07:10 INFO - 'HOME': '/home/cltbld', 20:07:10 INFO - 'LANG': 'en_US.UTF-8', 20:07:10 INFO - 'LANGUAGE': 'en_US:en', 20:07:10 INFO - 'LOGNAME': 'cltbld', 20:07:10 INFO - 'MAIL': '/var/mail/cltbld', 20:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:10 INFO - 'MOZ_NO_REMOTE': '1', 20:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:10 INFO - 'NO_EM_RESTART': '1', 20:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:10 INFO - 'PWD': '/builds/slave/test', 20:07:10 INFO - 'SHELL': '/bin/bash', 20:07:10 INFO - 'SHLVL': '1', 20:07:10 INFO - 'TERM': 'linux', 20:07:10 INFO - 'TMOUT': '86400', 20:07:10 INFO - 'USER': 'cltbld', 20:07:10 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:10 INFO - '_': '/tools/buildbot/bin/python'} 20:07:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:10 INFO - Downloading/unpacking blobuploader==1.2.4 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:10 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 20:07:10 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 20:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:12 INFO - Downloading blobuploader-1.2.4.tar.gz 20:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:07:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:07:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 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 20:07:13 INFO - Downloading docopt-0.6.1.tar.gz 20:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:07:13 INFO - Installing collected packages: blobuploader, requests, docopt 20:07:13 INFO - Running setup.py install for blobuploader 20:07:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:07:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:07:13 INFO - Running setup.py install for requests 20:07:14 INFO - Running setup.py install for docopt 20:07:14 INFO - Successfully installed blobuploader requests docopt 20:07:14 INFO - Cleaning up... 20:07:14 INFO - Return code: 0 20:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:14 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')]} 20:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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')]} 20:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:14 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:14 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 20:07:14 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 20:07:14 INFO - Using env: {'DISPLAY': ':0', 20:07:14 INFO - 'HOME': '/home/cltbld', 20:07:14 INFO - 'LANG': 'en_US.UTF-8', 20:07:14 INFO - 'LANGUAGE': 'en_US:en', 20:07:14 INFO - 'LOGNAME': 'cltbld', 20:07:14 INFO - 'MAIL': '/var/mail/cltbld', 20:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:14 INFO - 'MOZ_NO_REMOTE': '1', 20:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:14 INFO - 'NO_EM_RESTART': '1', 20:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:14 INFO - 'PWD': '/builds/slave/test', 20:07:14 INFO - 'SHELL': '/bin/bash', 20:07:14 INFO - 'SHLVL': '1', 20:07:14 INFO - 'TERM': 'linux', 20:07:14 INFO - 'TMOUT': '86400', 20:07:14 INFO - 'USER': 'cltbld', 20:07:14 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:14 INFO - '_': '/tools/buildbot/bin/python'} 20:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:14 INFO - Running setup.py (path:/tmp/pip-YFyp41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:14 INFO - Running setup.py (path:/tmp/pip-dqzDbK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:14 INFO - Running setup.py (path:/tmp/pip-1f2XS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:14 INFO - Running setup.py (path:/tmp/pip-kP7S2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:14 INFO - Running setup.py (path:/tmp/pip-Hb7hL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:14 INFO - Running setup.py (path:/tmp/pip-4kgsd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:15 INFO - Running setup.py (path:/tmp/pip-ZKd3TO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:15 INFO - Running setup.py (path:/tmp/pip-5zihuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:15 INFO - Running setup.py (path:/tmp/pip-PWYhoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:15 INFO - Running setup.py (path:/tmp/pip-v0SW3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:15 INFO - Running setup.py (path:/tmp/pip-EPAXnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:15 INFO - Running setup.py (path:/tmp/pip-N27Upt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:15 INFO - Running setup.py (path:/tmp/pip-PH_DdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:15 INFO - Running setup.py (path:/tmp/pip-bpGQW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:15 INFO - Running setup.py (path:/tmp/pip-6OQ1dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:15 INFO - Running setup.py (path:/tmp/pip-CPD_2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:15 INFO - Running setup.py (path:/tmp/pip-_HyVR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:07:15 INFO - Running setup.py install for manifestparser 20:07:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:07:15 INFO - Running setup.py install for mozcrash 20:07:16 INFO - Running setup.py install for mozdebug 20:07:16 INFO - Running setup.py install for mozdevice 20:07:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for mozfile 20:07:16 INFO - Running setup.py install for mozhttpd 20:07:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for mozinfo 20:07:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for mozInstall 20:07:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for mozleak 20:07:16 INFO - Running setup.py install for mozlog 20:07:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for moznetwork 20:07:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:07:16 INFO - Running setup.py install for mozprocess 20:07:17 INFO - Running setup.py install for mozprofile 20:07:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Running setup.py install for mozrunner 20:07:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Running setup.py install for mozscreenshot 20:07:17 INFO - Running setup.py install for moztest 20:07:17 INFO - Running setup.py install for mozversion 20:07:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:07:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:07:17 INFO - Cleaning up... 20:07:17 INFO - Return code: 0 20:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:17 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')]} 20:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:17 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')]} 20:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:17 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:17 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 20:07:17 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 20:07:17 INFO - Using env: {'DISPLAY': ':0', 20:07:17 INFO - 'HOME': '/home/cltbld', 20:07:17 INFO - 'LANG': 'en_US.UTF-8', 20:07:17 INFO - 'LANGUAGE': 'en_US:en', 20:07:17 INFO - 'LOGNAME': 'cltbld', 20:07:17 INFO - 'MAIL': '/var/mail/cltbld', 20:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:17 INFO - 'MOZ_NO_REMOTE': '1', 20:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:17 INFO - 'NO_EM_RESTART': '1', 20:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:17 INFO - 'PWD': '/builds/slave/test', 20:07:17 INFO - 'SHELL': '/bin/bash', 20:07:17 INFO - 'SHLVL': '1', 20:07:17 INFO - 'TERM': 'linux', 20:07:17 INFO - 'TMOUT': '86400', 20:07:17 INFO - 'USER': 'cltbld', 20:07:17 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:17 INFO - '_': '/tools/buildbot/bin/python'} 20:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:07:17 INFO - Running setup.py (path:/tmp/pip-RU7tME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:07:17 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)) 20:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:07:17 INFO - Running setup.py (path:/tmp/pip-bvYdCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:07:18 INFO - Running setup.py (path:/tmp/pip-ll3p3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:07:18 INFO - Running setup.py (path:/tmp/pip-I9pKhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:07:18 INFO - Running setup.py (path:/tmp/pip-sDxmJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:07:18 INFO - Running setup.py (path:/tmp/pip-qpO16T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:07:18 INFO - Running setup.py (path:/tmp/pip-LMDQ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:07:18 INFO - Running setup.py (path:/tmp/pip-PSBgV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:07:18 INFO - Running setup.py (path:/tmp/pip-hSkHqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:07:18 INFO - Running setup.py (path:/tmp/pip-hnVzDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:07:18 INFO - Running setup.py (path:/tmp/pip-DReVoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:07:18 INFO - Running setup.py (path:/tmp/pip-ewf3QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:07:18 INFO - Running setup.py (path:/tmp/pip-Lh72xr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:07:18 INFO - Running setup.py (path:/tmp/pip-_zAm6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:18 INFO - Running setup.py (path:/tmp/pip-ENR49R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:07:18 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)) 20:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:07:18 INFO - Running setup.py (path:/tmp/pip-pJJBnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:07:19 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)) 20:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:07:19 INFO - Running setup.py (path:/tmp/pip-Bt0CTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:07:19 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)) 20:07:19 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)) 20:07:19 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)) 20:07:19 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)) 20:07:19 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)) 20:07:19 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)) 20:07:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:19 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 20:07:19 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 20:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:07:21 INFO - Downloading blessings-1.6.tar.gz 20:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:07:21 INFO - Installing collected packages: blessings 20:07:21 INFO - Running setup.py install for blessings 20:07:21 INFO - Successfully installed blessings 20:07:21 INFO - Cleaning up... 20:07:21 INFO - Return code: 0 20:07:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:07:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:21 INFO - Reading from file tmpfile_stdout 20:07:21 INFO - Current package versions: 20:07:21 INFO - argparse == 1.2.1 20:07:21 INFO - blessings == 1.6 20:07:21 INFO - blobuploader == 1.2.4 20:07:21 INFO - docopt == 0.6.1 20:07:21 INFO - functools32 == 3.2.3-2 20:07:21 INFO - jsonschema == 2.5.1 20:07:21 INFO - manifestparser == 1.1 20:07:21 INFO - mozInstall == 1.12 20:07:21 INFO - mozcrash == 1.0 20:07:21 INFO - mozdebug == 0.1 20:07:21 INFO - mozdevice == 0.49 20:07:21 INFO - mozfile == 1.2 20:07:21 INFO - mozhttpd == 0.7 20:07:21 INFO - mozinfo == 0.9 20:07:21 INFO - mozleak == 0.1 20:07:21 INFO - mozlog == 3.4 20:07:21 INFO - moznetwork == 0.27 20:07:21 INFO - mozprocess == 0.24 20:07:21 INFO - mozprofile == 0.28 20:07:21 INFO - mozrunner == 6.13 20:07:21 INFO - mozscreenshot == 0.1 20:07:21 INFO - mozsystemmonitor == 0.3 20:07:21 INFO - moztest == 0.8 20:07:21 INFO - mozversion == 1.4 20:07:21 INFO - psutil == 3.1.1 20:07:21 INFO - requests == 1.2.3 20:07:21 INFO - wsgiref == 0.1.2 20:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:07:21 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')]} 20:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 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')]} 20:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:21 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 20:07:21 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 20:07:21 INFO - Using env: {'DISPLAY': ':0', 20:07:21 INFO - 'HOME': '/home/cltbld', 20:07:21 INFO - 'LANG': 'en_US.UTF-8', 20:07:21 INFO - 'LANGUAGE': 'en_US:en', 20:07:21 INFO - 'LOGNAME': 'cltbld', 20:07:21 INFO - 'MAIL': '/var/mail/cltbld', 20:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:21 INFO - 'MOZ_NO_REMOTE': '1', 20:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:21 INFO - 'NO_EM_RESTART': '1', 20:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:21 INFO - 'PWD': '/builds/slave/test', 20:07:21 INFO - 'SHELL': '/bin/bash', 20:07:21 INFO - 'SHLVL': '1', 20:07:21 INFO - 'TERM': 'linux', 20:07:21 INFO - 'TMOUT': '86400', 20:07:21 INFO - 'USER': 'cltbld', 20:07:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:21 INFO - '_': '/tools/buildbot/bin/python'} 20:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 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)) 20:07:21 INFO - Cleaning up... 20:07:21 INFO - Return code: 0 20:07:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:07:21 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')]} 20:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 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')]} 20:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x23451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2511a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26b6c70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, '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': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', '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 20:07:21 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 20:07:21 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 20:07:21 INFO - Using env: {'DISPLAY': ':0', 20:07:21 INFO - 'HOME': '/home/cltbld', 20:07:21 INFO - 'LANG': 'en_US.UTF-8', 20:07:21 INFO - 'LANGUAGE': 'en_US:en', 20:07:21 INFO - 'LOGNAME': 'cltbld', 20:07:21 INFO - 'MAIL': '/var/mail/cltbld', 20:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:21 INFO - 'MOZ_NO_REMOTE': '1', 20:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:21 INFO - 'NO_EM_RESTART': '1', 20:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:21 INFO - 'PWD': '/builds/slave/test', 20:07:21 INFO - 'SHELL': '/bin/bash', 20:07:21 INFO - 'SHLVL': '1', 20:07:21 INFO - 'TERM': 'linux', 20:07:21 INFO - 'TMOUT': '86400', 20:07:21 INFO - 'USER': 'cltbld', 20:07:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:21 INFO - '_': '/tools/buildbot/bin/python'} 20:07:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:07:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:07:22 INFO - Cleaning up... 20:07:22 INFO - Return code: 0 20:07:22 INFO - Running post-action listener: _resource_record_post_action 20:07:22 INFO - Running post-action listener: _start_resource_monitoring 20:07:22 INFO - Starting resource monitoring. 20:07:22 INFO - [mozharness: 2017-01-17 04:07:22.148120Z] Finished create-virtualenv step (success) 20:07:22 INFO - [mozharness: 2017-01-17 04:07:22.148578Z] Running install step. 20:07:22 INFO - Running pre-action listener: _resource_record_pre_action 20:07:22 INFO - Running main action method: install 20:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:07:22 INFO - Reading from file tmpfile_stdout 20:07:22 INFO - Detecting whether we're running mozinstall >=1.0... 20:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:07:22 INFO - Reading from file tmpfile_stdout 20:07:22 INFO - Output received: 20:07:22 INFO - Usage: mozinstall [options] installer 20:07:22 INFO - Options: 20:07:22 INFO - -h, --help show this help message and exit 20:07:22 INFO - -d DEST, --destination=DEST 20:07:22 INFO - Directory to install application into. [default: 20:07:22 INFO - "/builds/slave/test"] 20:07:22 INFO - --app=APP Application being installed. [default: firefox] 20:07:22 INFO - mkdir: /builds/slave/test/build/application 20:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 20:07:38 INFO - Reading from file tmpfile_stdout 20:07:38 INFO - Output received: 20:07:38 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:38 INFO - Running post-action listener: _resource_record_post_action 20:07:38 INFO - [mozharness: 2017-01-17 04:07:38.802931Z] Finished install step (success) 20:07:38 INFO - [mozharness: 2017-01-17 04:07:38.803214Z] Running run-tests step. 20:07:38 INFO - Running pre-action listener: _resource_record_pre_action 20:07:38 INFO - Running main action method: run_tests 20:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:38 INFO - Python 2.7.3 20:07:38 INFO - Return code: 0 20:07:38 INFO - grabbing minidump binary from tooltool 20:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:38 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 0x26b43f0>, '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 0x26b4cf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b51a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:38 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 20:07:38 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 20:07:38 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 20:07:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:38 INFO - Return code: 0 20:07:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 20:07:38 INFO - Using env: {'DISPLAY': ':0', 20:07:38 INFO - 'HOME': '/home/cltbld', 20:07:38 INFO - 'LANG': 'en_US.UTF-8', 20:07:38 INFO - 'LANGUAGE': 'en_US:en', 20:07:38 INFO - 'LOGNAME': 'cltbld', 20:07:38 INFO - 'MAIL': '/var/mail/cltbld', 20:07:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:38 INFO - 'MOZ_NO_REMOTE': '1', 20:07:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:38 INFO - 'NO_EM_RESTART': '1', 20:07:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:38 INFO - 'PWD': '/builds/slave/test', 20:07:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:38 INFO - 'SHELL': '/bin/bash', 20:07:38 INFO - 'SHLVL': '1', 20:07:38 INFO - 'TERM': 'linux', 20:07:38 INFO - 'TMOUT': '86400', 20:07:38 INFO - 'USER': 'cltbld', 20:07:38 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576', 20:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:38 INFO - '_': '/tools/buildbot/bin/python'} 20:07:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 20:07:39 INFO - mozversion application_buildid: 20170117033108 20:07:39 INFO - mozversion application_changeset: b85cf10fae3d94b835f21bf27db7091e010572ec 20:07:39 INFO - mozversion application_display_name: Nightly 20:07:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:39 INFO - mozversion application_name: Firefox 20:07:39 INFO - mozversion application_remotingname: firefox 20:07:39 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 20:07:39 INFO - mozversion application_vendor: Mozilla 20:07:39 INFO - mozversion application_version: 53.0a1 20:07:39 INFO - mozversion platform_buildid: 20170117033108 20:07:39 INFO - mozversion platform_changeset: b85cf10fae3d94b835f21bf27db7091e010572ec 20:07:39 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 20:07:39 INFO - mozversion platform_version: 53.0a1 20:07:39 INFO - using testdate: 1484626059 20:07:39 INFO - actual date: 1484626059 20:07:39 INFO - starting webserver on 'localhost:47049' 20:07:39 INFO - SUITE-START | Running 2 tests 20:07:39 INFO - TEST-START | dromaeo_css 20:07:39 INFO - operating with platform_type : linux_ 20:07:39 INFO - Initialising browser for dromaeo_css test... 20:07:39 INFO - TEST-INFO | started process 16873 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKTkUFv/profile http://localhost:47049/getInfo.html) 20:07:43 INFO - PROCESS | 16873 | __metrics Screen width/height:1600/1200 20:07:43 INFO - PROCESS | 16873 | colorDepth:24 20:07:43 INFO - PROCESS | 16873 | Browser inner width/height: 1024/697 20:07:43 INFO - PROCESS | 16873 | __metrics 20:07:43 INFO - PROCESS | 16873 | 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" 20:07:43 INFO - PROCESS | 16873 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:44 INFO - PROCESS | 16873 | console.error: 20:07:44 INFO - PROCESS | 16873 | Message: Error: Connection closed before committing the transaction. 20:07:44 INFO - PROCESS | 16873 | Stack: 20:07:44 INFO - PROCESS | 16873 | executeTransaction/promise resource://gre/modules/Promise-backend.js:917:23 20:07:44 INFO - PROCESS | 16873 | walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:801:7 20:07:44 INFO - PROCESS | 16873 | Promise*scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:734:11 20:07:44 INFO - PROCESS | 16873 | schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:765:7 20:07:44 INFO - PROCESS | 16873 | completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:702:7 20:07:44 INFO - PROCESS | 16873 | TaskImpl_run@resource://gre/modules/Task.jsm:324:15 20:07:44 INFO - PROCESS | 16873 | observe@resource://gre/modules/AsyncShutdown.jsm:550:9 20:07:44 INFO - PROCESS | 16873 | addBlocker/moduleBlocker/<@resource://gre/components/nsAsyncShutdown.js:157:15 20:07:44 INFO - PROCESS | 16873 | Promise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:385:5 20:07:44 INFO - PROCESS | 16873 | moduleBlocker@resource://gre/components/nsAsyncShutdown.js:153:29 20:07:44 INFO - PROCESS | 16873 | trigger@resource://gre/modules/AsyncShutdown.jsm:719:23 20:07:44 INFO - PROCESS | 16873 | _wait@resource://gre/modules/AsyncShutdown.jsm:866:7 20:07:44 INFO - PROCESS | 16873 | wait@resource://gre/modules/AsyncShutdown.jsm:850:28 20:07:44 INFO - PROCESS | 16873 | observe@resource://gre/modules/AsyncShutdown.jsm:533:17 20:07:44 INFO - PROCESS | 16873 | 20:07:44 INFO - PROCESS | 16873 | console.error: PushService: 20:07:44 INFO - PROCESS | 16873 | stateChangeProcessEnqueue: Error transitioning state 20:07:44 INFO - PROCESS | 16873 | UnknownError 20:07:45 INFO - TEST-INFO | 16873: exit 0 20:07:45 INFO - Browser initialized. 20:07:45 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:45 INFO - TEST-INFO | started process 16953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKTkUFv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:57 INFO - PROCESS | 16953 | RSS: Main: 152424448 20:07:57 INFO - PROCESS | 16953 | 20:11:02 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47049/tests/dromaeo/cssquery-ext.html) 20:11:03 INFO - PROCESS | 16953 | RSS: Main: 267452416 20:11:03 INFO - PROCESS | 16953 | 20:12:46 INFO - PROCESS | 16953 | ************************* 20:12:46 INFO - PROCESS | 16953 | A coding exception was thrown and uncaught in a Task. 20:12:46 INFO - PROCESS | 16953 | 20:12:46 ERROR - PROCESS | 16953 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:12:46 INFO - PROCESS | 16953 | Full stack: 20:12:46 INFO - PROCESS | 16953 | ************************* 20:14:05 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-ext.html (next: http://localhost:47049/tests/dromaeo/cssquery-jquery.html) 20:14:06 INFO - PROCESS | 16953 | RSS: Main: 237109248 20:14:06 INFO - PROCESS | 16953 | 20:17:08 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47049/tests/dromaeo/cssquery-mootools.html) 20:17:09 INFO - PROCESS | 16953 | RSS: Main: 224399360 20:17:09 INFO - PROCESS | 16953 | 20:20:11 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47049/tests/dromaeo/cssquery-prototype.html) 20:20:11 INFO - PROCESS | 16953 | RSS: Main: 219230208 20:20:11 INFO - PROCESS | 16953 | 20:23:15 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47049/tests/dromaeo/cssquery-yui.html) 20:23:15 INFO - PROCESS | 16953 | RSS: Main: 185049088 20:23:15 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | Cycle 1(1): loaded http://localhost:47049/tests/dromaeo/cssquery-yui.html (next: http://localhost:47049/tests/dromaeo/cssquery-dojo.html) 20:26:19 INFO - PROCESS | 16953 | RSS: Main: 277807104 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | __start_tp_report 20:26:19 INFO - PROCESS | 16953 | _x_x_mozilla_page_load 20:26:19 INFO - PROCESS | 16953 | _x_x_mozilla_page_load_details 20:26:19 INFO - PROCESS | 16953 | |i|pagename|runs| 20:26:19 INFO - PROCESS | 16953 | |0;dojo.html;2532.898684052638;2547.528707189169;2581.277242372136;2585.741425857413;2590.8704564771756;4617.030423611046;4681.4382274127065;4777.06847164803;4807.326974223607;4819.421669399672;4740.4548476925165;4802.807887684488;4812.831550895719;4855.126077306083;4856.878578035551;4284.550122237167;4306.310990241562;4338.197433474801;4416.006398560315;4435.534268901767;4153.916921661565;4416.492103408117;4442.267025940732;4464.754438505897;4496.707713998596;4296.162248361571;4449.443819522559;4450.799714012877;4493.797779099932;4558.156741002908;4337.414449049369;4383.276759334706;4410.977945110254;4423.447069116361;4497.9325310120375;4403.537628548988;4421.46942366918;4425.601695847389;4427.092446048552;4449.599536041739;4766.571008609207;4773.737444440554;4795.544423279783;4797.736124513151;4812.807487700487;4982.950170498321;5007.54932056113;5069.163588008011;5122.795088196468;5138.100832354323;5165.096108181091;5186.377634683862;5189.948100518985;5213.035588416155;5221.269022336875;4831.661783675144;4842.5157484251995;4847.345608342899;4847.394075740533;4879.268109783561;5199.168133098686;5215.739213039333;5229.294045303911;5273.1299335609965;5291.206319052096;5037.4458809530925;5048.646594738407;5049.84850454487;5094.541491265803;5107.157319042316;5008.549230569266;5032.974835125801;5138.537531622172;5149.201873709506;5202.193659982633;5034.723090229999;5067.721275329818;5136.794528218829;5139.229115632685;5207.583393328525;4916.434610019894;4936.531029552187;5093.363329583802;5141.38303403594;5143.12566863634;4308.870733877989;4324.329728892027;4326.307790753464;4340.717853339523;4386.210482113186;3738.140227747633;3741.85032598693;3744.8314825832904;3781.621837816251;3787.394016957274;4294.420253265832;4398;4406.294992801137;4409.272470042407;4444.577765112309;5056.696598204119;5087.414947281036;5124.282600435942;5124.615653825978;5215.765290561933;4364.60718535327;4384.802683879233;4388.648908087345;4392.033752574429;4431.313146462304;4599.425071866017;4607.378003969488;4608.700434471749;4615.930761038587;4643.512431194676;4690.882727931829;4693.601043911306;4724.598409135125;4726.338312636302;4731.905361892812;5116.976604679005;5118.872028199325;5119.718415487184;5126.4360920297995;5159.716215608028;4735.8870665392915;4736.052789442057;4738.8341408050555;4739.928901066418;4767.070421267819;4901.6323775716255;4930.778114984762;5043.4956504349275;5049.596032317332;5068.239764035424;5161.122609156528;5167.302414174038;5169.353830771153;5199.584033277404;5220.791168353223;4761.738104404291;4979.228219625964;5019.247112933089;5021.171506701354;5067.771950262173;4783.425988881357;4838.637102217277;4921.532454416824;4921.63087768426;4962;4911.656184067081;4915.434725006527;4970.080535101018;4972.900541989212;4976.601871850316;4971.577415919687;4994.9500504994485;5008.123578373843;5014.297998280171;5047.974760126176;4802.639802014793;4846.418429788448;4898.804047838046;4910.189818679878;4950.331705219749 20:26:19 INFO - PROCESS | 16953 | |1;ext.html;544.7902557515356;554.4261689151729;566.7704579645242;566.897958367494;578.6759414727755;29709.702902970963;40028;41228;41319.17361652765;45497.31754023684;42346.788266058706;42753.35869961953;42804.35793463101;43130.35304470435;43135.137297254034;7452.6273686315735;7595.392368610498;7748.380129589619;7764.107127680304;7766.301032907038;7488.213737557559;9886.653967111153;10131.341462804894;10134.493275336241;10426.165906727443;10108.292419530635;10144.49277536124;10178.6946391608;10187.59249630014;10191.235657325693;10096.495175241245;10111.797764044677;10115.595376184943;10148.1374083203;10160.08559229673;9960.850587241197;10025.348352357147;10044.698659040241;10049.145822605087;10063.345882517613;39783.40324895129;40064.59935400638;40092.79953600242;40104;40142.397864032064;3733.2533493301175;3766.5291838520184;3804.1630841214887;3842.1163132479405;3855.9228815423817;28070.43859122806;28407.857960710066;29113.249194066662;29938.251543711365;30282.394352113053;3421.9657803421896;3493.7030352420074;3545.2200515886466;3552.0942159749357;3583.426651735736;246318;251342;251693;252284;252392;61644.38355616386;62521.8739063045;62579.6871015642;62685;62753.372466275665;65233.34766652273;65317.34682653208;65657.16656751678;65860.34139658637;65929.67035164793;15166.393344266326;15702.607434813992;15730.449434269745;15740.291686874118;15742.449014284673;8798.38411311202;9031.683891063782;11123.332600044023;11548.133889958119;11676.182667213383;19383.612327753366;19771.39604212548;20088.497787555134;20090.799092008892;20134.395968120978;7590.8102297443;7663.846723065508;7817.80455488606;7822.765317040498;7870.803229919184;826.2935190412231;835.6364981233183;848.6520526584071;866.5234121233296;877.4515927545284;26636.733632663814;27983.860080699465;28598.85700571484;28665.42669146647;28824.279393014924;939.6100618243489;981.6367943860818;990.7919336939179;996.5415908682088;1129.5594718059963;12904.741905161844;13394.531191408449;13427.287133844275;13561.932190339183;13608.523701670592;379098;380369;380911;381105;382323;44021.77989110034;44342;44447.555524444986;44462.33306500405;44535;1220.408102070495;1257.7044394567085;1267.5056727876135;1273.923564586128;1280.5262053040435;23530.294091177293;24068.27795166148;24959.625605616293;25033.249002529952;25047.749522504542;37741.4338784924;38394.80802595969;38468.6153138465;38472.230555389295;38535.42196866993;321673;322398;323329;323573;323676;20479.468122807215;21244.36266911995;21865.453363666034;21916.23293184731;24043.278701638978;33789.66210337963;34015.65984340125;34163.316733665684;34251.65748342584;34568.308633827684;32036.67963320337;32231.677683222868;33585.66414335923;36057.68990426717;36821.26357472889;32035.359292813548;33101.503477448336;33256.83371583223;33590;34014.938655521124;32676.019719408458;33330.33339333248;33445.16387090245;33702.49446258357;33748.49377259392;25872.870635647454;26230.721159855017;29906.252343691584;30197.547036794025;31378.372432551678;23458.296251112493;23743.762562374155;23864.03918259758;23983.52032959366;24117.638235426133 20:26:19 INFO - PROCESS | 16953 | |2;jquery.html;375.4743359296984;383.8407061069656;395.7309029859695;397.5031210986267;419.8152812762384;13109;13578.185308881473;17226.48320550384;17718.64562708745;17722;14342.569722908303;17062.744058839096;17392.47822565322;18106.728399074025;18274.17766200524;5160.432352441228;5361.812336568221;5367.946320536803;5370;5372.382176049765;5106.183010718286;5196.714180720059;5277.12927366984;5314.681119132845;5317.282166907476;5282.7622756976025;5292.285541451913;5293.338332708411;5296.232046353276;5300;5100.617453690969;5191.740412979374;5207.062728708831;5220.791168353261;5279.973600132013;4690.366800481959;4694.929576056362;4708.905821883577;4710.764461776897;4714.57568818808;20935;21920.89039554792;21962;22083.33749987503;22256.221032263955;2579.496998085374;2616.5813469844925;2652.9867350663317;2674.3848914749524;2682.919512414631;13223.73552528944;13406.597802065953;13563.728725425535;13624.863751362458;14178.929105354511;1759.41141135178;1791.408835084419;1812.420025591811;1816.7729033870767;1823.9908800456046;70116.29883701149;71517;71520.2847971524;73122.63438682826;73229.26770732278;10292.948535257276;10357;10434.530446129942;10661.68014959537;10700.732481688021;14468.493602723855;14484.637884052983;14493.130412175304;14496.565103046925;14505.492307769178;7559.697612095454;7695.422843286776;7707.113681926538;7961.641726122339;7968.243016913384;7289.744858929912;7292.781216563511;7382.9630851845395;7510.061242344707;7539.962300188574;6687.398134167948;6758.864822703518;6804.693788779517;6813.625250611165;6887.173539175331;1780.97328540072;1792.4801807475685;1798.5323815807983;1818;1818.4999125240665;790.4585359029084;804.8511025460308;809.1746418652941;810.3679130278274;819.5861090149436;17253.913730431268;18351;18700.906495467436;18806;18957.247028765352;793.6825269892089;808.9514629122272;813.6867306087199;822.6668199379261;832.8958880139983;9863.950680246553;10166.186705063577;10511.474426278808;10514.737131571772;10566.947165264279;471139;492755;494041;500172;504705;73525.2647473529;75930;76177.61911190409;76473.6176319126;76531.23468765241;934.458014351688;946.3517490519016;964.6864768950119;966.5505539923969;967.849983252597;15390.769138462709;15532.30104645271;16096.919515402347;16387.918060409622;16405.507834764976;33617;34104.34119203187;34497.482537761454;35008.649913500536;35222.11944701403;45416.318755219356;45575.544244558456;45712;47793.28310075421;48021;7800.414968877243;7894.21057894206;8076.71731489395;8162.265396114378;8172.346212302882;12062.276263424223;12474.75050499003;12678.809817852924;12812.295323757282;12907.419166137734;9935.801283974424;10054.798904022025;10143.7464063399;10666.46667666629;11025.61410350634;10580.20648451354;10742.516586753458;10858.185636077167;10975.50610222526;11280;9942.652007180004;9945.353552019096;10045.095941365313;10522.053015228666;10974.451277435937;7985.800354991172;8082.83834323322;8143.063547692092;8183.304419124203;8315.376346773895;9760.853587196056;10014.39913605186;10368.051366670332;10600.681979540626;10610.249308863951 20:26:19 INFO - PROCESS | 16953 | |3;mootools.html;1353.6345186799565;1377.8071070050191;1394.142602299586;1394.5955672854873;1398.2938615998933;7116;7467.514611550259;7469.962650186755;7479.887801682972;7484.476086673928;6268.467180289681;6523.771667991621;7041.894371584431;7232.7830165095;7313.085864266966;2190.857594256376;2232.9330120096424;2237.3511681612313;2237.4182712494785;2238.854474459163;2104.547522282709;2203.790639889208;2208.2712704807377;2209.3482422685347;2221.3002904085242;1844.1332573690345;1908.4179325305777;2094.110003248621;2162.145952348821;2172.0225898345807;2116.7354080739906;2122.129926730041;2136.316378758798;2142.2609199826034;2144.9892750536305;2170.848040637156;2202.1631779923528;2205.283282933053;2208.7570367259586;2210.9226177083888;7380.261973802631;7464.1416237132335;7494.5128566643;7506.699732010713;7527.134379546367;4283.1433713257475;4368.257396242647;4381.452318460192;4381.9561804381865;4385.451818522684;2791.595218693278;2952.7637788977045;2978.6425628924453;2982.8508574571183;2996.8951086712077;1098.6154845803985;1157.0552942760694;1177.43483128099;1189.5360809284387;1213.3811756004413;9644.083812037845;9657.46883921384;9706.70879873605;9755.756106097333;9756.853647195298;4002.4996875390575;4206.705530612889;4210.59999300066;4321.827126914951;4340.045190058182;8599;8600.096989816104;8601.526916019679;8605.612747426381;8618.827623447496;4631.814727410933;4632.3977882875015;4635.374224479652;4636.165490211727;4639.211334073216;4080.4491393661474;4103.199876024147;4131.772752498641;4198.118395136994;4208.6633069354375;3559.430491121408;3590.868876303956;3614.403623402109;3667.504886840296;3759.0978165240144;1212.6240865331774;1221.8961388282096;1222.9816552751715;1232.6610182199788;1240.64021433785;711.5161690050712;746.8058304840672;749;749.2432643030578;756.6859753202359;4585.587297143273;4769.189237829577;4782.187028205213;4783.210770222874;4897.877553061131;893.7095443980733;922.7739203895088;932.8693982842408;933.8459154239611;938.9248860091176;3239.5950506186728;3364.327134573095;3392.3215356928713;3417.162795115163;3604.2971620534267;8333.083360830304;8786.472811631322;8795.604197811113;8799.47203167812;8811.030786613468;8784.824303513893;8786.253168480624;8787.91212087871;8789.560521973875;8790.384673072951;6849.315068493111;6863;6976.790696279119;6984.476164287597;6985.79042628722;4846.006568653488;4897.9020419592125;4902.460729319843;4912.214045752662;4991.326170967018;7921.564313962787;7959.164287749934;7985.6007199638625;8043.075046369742;8061.314788243065;8113.716019939274;8244.54654993957;8268.503889766633;8302.086770455366;8312.916870831456;6176.567640265138;6287.339829317856;6306.337834527309;6307.369263073656;6312.053192021233;6645.401913827779;6960.234374218933;7007.544509607063;7018.789436316919;7036;6269.68651567429;6507;6555.4427873629365;6665.833354166185;6791.2190098139345;6541.70562324706;6657.40083392497;6710.429613482908;6731.024001519851;6891.3797758202;5560.165975103767;5632.098864181711;5681.971590142023;5687.9431205687415;5695.715214239189;4276.337167739005;4318.892027699333;4352.934705979476;4529.569690879362;4613.446386433515;4435.379046933367;4491.955080449285;4581.1753884299815;4625.213713668617;4742.620590352694 20:26:19 INFO - PROCESS | 16953 | |4;prototype.html;351.82584620612784;363.11581299535646;364.0661702732491;367.77014366021234;368.3222869919348;4882.389701287339;4934;4953.157963146265;4954.975225123874;4964.702117872921;4608.400907881979;4733.5739783419485;4766.070616229837;4821.710697358161;4825.420949486067;3956.663683586884;3958.8812335629977;3966.2067586482676;3985.2029594081155;3994.380870964998;3946.3685810270363;3965.1252841689834;3977.4431579578736;3984.740991835536;3997.460342853721;3796.2976849282973;3827.349350610403;3927.725059245854;3954.3673012318036;3984.402339649047;3929.135590170158;3930.21395720857;3932.980335098306;3943.8225279862477;3944.8224829882724;3581.5673730507747;3593.6406359364114;3597.5862775780856;3600.873969411084;3613.7109031277437;4662.184117779409;4680.836170734042;4742.264948932921;4757.690750101232;4764.927891224482;4485.304777759453;4494.438195225597;4502.797374118172;4519.593236608721;4527.750973696446;5084.898302033976;5088.516590923857;5094.821681241138;5105.7191854448365;5138.974305128488;3858.7298889077774;3909.648131668135;3924.47019652349;3933.9016524586827;3943.1719338938856;5098.337216161875;5252.264682944353;5267.236250743621;5273;5286.5770738341225;3975.662068724133;3994.5206575210577;3994.6005399459823;3996.720229583901;3997.700172487075;4040.6363427291685;4049.4735684360844;4057.9797101014306;4080.9387859182134;4089.8773036808943;4086.5504794472586;4259.997801033509;4307.461567304087;4506.59440650343;4519.209138400766;5060;5068.493150684976;5092.516210959953;5097.362829646294;5104.974475127675;1266.5377137344988;1272.7327261275236;1273.2996851731696;1273.57335292678;1280;827.71443851871;839.6641343462663;862.5169904853177;875.7810547363159;883.6465413834518;4285.507166675872;4285.914281714348;4292.763897985641;4293.742375457483;4304.655627549789;5046.082488654361;5047.9495205048215;5059;5064.620153488503;5075.949240507622;4157.605027522381;4204.810783514749;4262.978685106555;4305.084237514338;4308.246056940023;2652.8938842446473;2663.187727743057;2664.8401095934305;2682.316009417586;2692.2192564156567;4635.6523260755575;4684.2271025281125;4687.718736875799;4690.273007683814;4713.528647135259;4981.252812078217;5103.566196873233;5149.407818100892;5168.328117344797;5195.246689230041;4669.836555720533;4675.259792166254;4691.7888695008805;4693.55411235932;4712.905741885212;5013.598912086952;5037.92443113361;5044.495550444926;5071.6163403200435;5101.311322971352;4667;4914.066327397783;4924.704517728947;4961.8511444656715;4981.626378021735;4678.929816052694;4686.906261874811;4700.45944716362;4705.576498115186;4715.510522213606;3609.6283412303155;3619.1314084618975;3627.5900653385734;3636.3272794533095;3639.7088232941833;4932.63005274613;5043.5460808527405;5069.923951140662;5072.442031376472;5074.3657042869645;5043.319151914445;5065;5072;5074.137396642506;5090.974545127251;5068.493150684902;5068.82259120929;5089.312942752829;5123.308353372247;5123.541609413705;4838.588719958702;4985.775640096132;4997.375328083989;5002.099622068063;5024.42219144803;4849.418069831643;4913.606911447004;5008.974955125347;5078.339815823919;5089.3638295213095;4939.407271127488;4965.4041515018425;4996.350474438445;4999.10016197088;4999.475055119306 20:26:19 INFO - PROCESS | 16953 | |5;yui.html;699.154023631406;712.0849708125061;751.4664588142418;771.2326235395781;799.1249581708031;12886.097973141885;14082.859171408283;14123.293835308219;14144.787828182572;14211.64470888227;13355.666108347295;13574.117682350641;13579;13588.524401645944;13590.796138057913;654.4960380507007;675.4461341699808;798.8641930871737;820.6020080261069;827.8344331133767;823.172711425017;828.0766944856472;830.9792255193638;832.9541875196892;832.9875051874227;878.7934835313696;879.248242752447;879.5470332778624;880.0715245416084;880.1242763450376;675.4663815585706;698.2947223304449;853.590276667197;877.7454538183919;880.8370451466499;643.1189270699125;645.0356716708504;645.1612903225788;645.3256347117274;645.4352441613588;13892;14165.575032749033;14174.929125354307;14184.503542375967;14198.219097949608;12874.420651070724;13019.739605207937;13186.86813131866;13305;13366.799498007538;12093.79835733838;12180.269183848997;12198.939005304917;12211.69470763238;12366.381680916009;3295.3574053059665;3318.867245310185;3405.4891766235014;3527.153483164022;4186.413902053715;53442.198367024524;53687;57202.14196787051;57467.712661436424;59072;10305.536250868729;10319.1744660427;10585.100266477435;10597.84103238452;10995.34027958325;19114;19114.42656720273;19155.521111972314;19247.422577322704;19253.61492770137;6742.255013656617;6976.930230697628;7134.357907788324;7163.1404231491515;7246.492745507764;3595.8381872815785;3708.8145592720257;3721.330160571069;3745.981270093687;3775.4903088083306;2768.1280396674983;2818.055951256311;2858.9857050714613;2904.1142451552055;2951.7343439090587;482.7562081148997;482.8310091467958;488.5212491758097;493.30690380016136;498.0661260137243;638.5370606310481;658.7924803686919;665.2881416883985;671.9529632925746;673.1686367336335;8625.956870215608;8847.911520884709;8871.911280887109;8969.955150224338;8995.685151019683;614.2904944788687;621.6083867163658;639.8720255948829;640.9487241020707;650.9544331896722;4079.1234941252173;4110.527289361702;4253.851115210953;4298.505671847777;4344.739315641072;64017.35982640207;65547;65957.67021164864;66829;66859.33140668628;53488;57306;57898;57905;58149;44039.33940990888;44386.556134438244;50357;50689.74655126701;50693.23960140601;8836.644098901525;9391.812163756824;9467.905320946702;9565.569549370155;9574;31466.842665786524;32845.178870527474;34802.82598586991;35190.824045879606;37214.255714886094;43799.34300985424;44555.77722111368;44685;44767.55232447634;45009.32486012647;10451.524638375753;11084.16868734832;11482;11649.883501165219;12089.214201076902;13374.665633359244;13527.661808454868;13571.457141714616;14382.3527941245;14386.35261413218;11941.940290298493;12680.365981701063;12705.491780329054;13184.143030702973;13292.734145317232;12155.696107597381;12173.39133043362;12569.87430125687;12661.620151395473;12669.74660506803;12165.635030949086;12234.755304893673;12472.625821225014;12821.743565128458;12879.425600396138;10272.22958278147;10448.634297799541;10484.52819623134;10684.519196636014;11005.779884402427;9957.601695932082;10123.240756943405;10625.362478251329;10960.890391095987;10998.890011100106 20:26:19 INFO - PROCESS | 16953 | __end_tp_report 20:26:19 INFO - PROCESS | 16953 | __start_cc_report 20:26:19 INFO - PROCESS | 16953 | _x_x_mozilla_cycle_collect,1214 20:26:19 INFO - PROCESS | 16953 | __end_cc_report 20:26:19 INFO - PROCESS | 16953 | __startTimestamp1484627179364__endTimestamp 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | ------- Summary: start ------- 20:26:19 INFO - PROCESS | 16953 | Number of tests: 6 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#0] dojo.html Cycles:165 Average:4718.56 Median:4838.64 stddev:511.27 (10.6%) stddev-sans-first:483.24 20:26:19 INFO - PROCESS | 16953 | Values: 2532.9 2547.5 2581.3 2585.7 2590.9 4617.0 4681.4 4777.1 4807.3 4819.4 4740.5 4802.8 4812.8 4855.1 4856.9 4284.6 4306.3 4338.2 4416.0 4435.5 4153.9 4416.5 4442.3 4464.8 4496.7 4296.2 4449.4 4450.8 4493.8 4558.2 4337.4 4383.3 4411.0 4423.4 4497.9 4403.5 4421.5 4425.6 4427.1 4449.6 4766.6 4773.7 4795.5 4797.7 4812.8 4983.0 5007.5 5069.2 5122.8 5138.1 5165.1 5186.4 5189.9 5213.0 5221.3 4831.7 4842.5 4847.3 4847.4 4879.3 5199.2 5215.7 5229.3 5273.1 5291.2 5037.4 5048.6 5049.8 5094.5 5107.2 5008.5 5033.0 5138.5 5149.2 5202.2 5034.7 5067.7 5136.8 5139.2 5207.6 4916.4 4936.5 5093.4 5141.4 5143.1 4308.9 4324.3 4326.3 4340.7 4386.2 3738.1 3741.9 3744.8 3781.6 3787.4 4294.4 4398.0 4406.3 4409.3 4444.6 5056.7 5087.4 5124.3 5124.6 5215.8 4364.6 4384.8 4388.6 4392.0 4431.3 4599.4 4607.4 4608.7 4615.9 4643.5 4690.9 4693.6 4724.6 4726.3 4731.9 5117.0 5118.9 5119.7 5126.4 5159.7 4735.9 4736.1 4738.8 4739.9 4767.1 4901.6 4930.8 5043.5 5049.6 5068.2 5161.1 5167.3 5169.4 5199.6 5220.8 4761.7 4979.2 5019.2 5021.2 5067.8 4783.4 4838.6 4921.5 4921.6 4962.0 4911.7 4915.4 4970.1 4972.9 4976.6 4971.6 4995.0 5008.1 5014.3 5048.0 4802.6 4846.4 4898.8 4910.2 4950.3 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#1] ext.html Cycles:180 Average:47347.14 Median:33587.83 stddev:84941.04 (252.9%) stddev-sans-first:85106.64 20:26:19 INFO - PROCESS | 16953 | Values: 544.8 554.4 566.8 566.9 578.7 29709.7 40028.0 41228.0 41319.2 45497.3 42346.8 42753.4 42804.4 43130.4 43135.1 7452.6 7595.4 7748.4 7764.1 7766.3 7488.2 9886.7 10131.3 10134.5 10426.2 10108.3 10144.5 10178.7 10187.6 10191.2 10096.5 10111.8 10115.6 10148.1 10160.1 9960.9 10025.3 10044.7 10049.1 10063.3 39783.4 40064.6 40092.8 40104.0 40142.4 3733.3 3766.5 3804.2 3842.1 3855.9 28070.4 28407.9 29113.2 29938.3 30282.4 3422.0 3493.7 3545.2 3552.1 3583.4 246318.0 251342.0 251693.0 252284.0 252392.0 61644.4 62521.9 62579.7 62685.0 62753.4 65233.3 65317.3 65657.2 65860.3 65929.7 15166.4 15702.6 15730.4 15740.3 15742.4 8798.4 9031.7 11123.3 11548.1 11676.2 19383.6 19771.4 20088.5 20090.8 20134.4 7590.8 7663.8 7817.8 7822.8 7870.8 826.3 835.6 848.7 866.5 877.5 26636.7 27983.9 28598.9 28665.4 28824.3 939.6 981.6 990.8 996.5 1129.6 12904.7 13394.5 13427.3 13561.9 13608.5 379098.0 380369.0 380911.0 381105.0 382323.0 44021.8 44342.0 44447.6 44462.3 44535.0 1220.4 1257.7 1267.5 1273.9 1280.5 23530.3 24068.3 24959.6 25033.2 25047.7 37741.4 38394.8 38468.6 38472.2 38535.4 321673.0 322398.0 323329.0 323573.0 323676.0 20479.5 21244.4 21865.5 21916.2 24043.3 33789.7 34015.7 34163.3 34251.7 34568.3 32036.7 32231.7 33585.7 36057.7 36821.3 32035.4 33101.5 33256.8 33590.0 34014.9 32676.0 33330.3 33445.2 33702.5 33748.5 25872.9 26230.7 29906.3 30197.5 31378.4 23458.3 23743.8 23864.0 23983.5 24117.6 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#2] jquery.html Cycles:180 Average:27408.76 Median:45495.93 stddev:80715.37 (177.4%) stddev-sans-first:80916.28 20:26:19 INFO - PROCESS | 16953 | Values: 375.5 383.8 395.7 397.5 419.8 13109.0 13578.2 17226.5 17718.6 17722.0 14342.6 17062.7 17392.5 18106.7 18274.2 5160.4 5361.8 5367.9 5370.0 5372.4 5106.2 5196.7 5277.1 5314.7 5317.3 5282.8 5292.3 5293.3 5296.2 5300.0 5100.6 5191.7 5207.1 5220.8 5280.0 4690.4 4694.9 4708.9 4710.8 4714.6 20935.0 21920.9 21962.0 22083.3 22256.2 2579.5 2616.6 2653.0 2674.4 2682.9 13223.7 13406.6 13563.7 13624.9 14178.9 1759.4 1791.4 1812.4 1816.8 1824.0 70116.3 71517.0 71520.3 73122.6 73229.3 10292.9 10357.0 10434.5 10661.7 10700.7 14468.5 14484.6 14493.1 14496.6 14505.5 7559.7 7695.4 7707.1 7961.6 7968.2 7289.7 7292.8 7383.0 7510.1 7540.0 6687.4 6758.9 6804.7 6813.6 6887.2 1781.0 1792.5 1798.5 1818.0 1818.5 790.5 804.9 809.2 810.4 819.6 17253.9 18351.0 18700.9 18806.0 18957.2 793.7 809.0 813.7 822.7 832.9 9864.0 10166.2 10511.5 10514.7 10566.9 471139.0 492755.0 494041.0 500172.0 504705.0 73525.3 75930.0 76177.6 76473.6 76531.2 934.5 946.4 964.7 966.6 967.8 15390.8 15532.3 16096.9 16387.9 16405.5 33617.0 34104.3 34497.5 35008.6 35222.1 45416.3 45575.5 45712.0 47793.3 48021.0 7800.4 7894.2 8076.7 8162.3 8172.3 12062.3 12474.8 12678.8 12812.3 12907.4 9935.8 10054.8 10143.7 10666.5 11025.6 10580.2 10742.5 10858.2 10975.5 11280.0 9942.7 9945.4 10045.1 10522.1 10974.5 7985.8 8082.8 8143.1 8183.3 8315.4 9760.9 10014.4 10368.1 10600.7 10610.2 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#3] mootools.html Cycles:180 Average:4863.68 Median:4897.89 stddev:2594.84 (53.0%) stddev-sans-first:2588.71 20:26:19 INFO - PROCESS | 16953 | Values: 1353.6 1377.8 1394.1 1394.6 1398.3 7116.0 7467.5 7470.0 7479.9 7484.5 6268.5 6523.8 7041.9 7232.8 7313.1 2190.9 2232.9 2237.4 2237.4 2238.9 2104.5 2203.8 2208.3 2209.3 2221.3 1844.1 1908.4 2094.1 2162.1 2172.0 2116.7 2122.1 2136.3 2142.3 2145.0 2170.8 2202.2 2205.3 2208.8 2210.9 7380.3 7464.1 7494.5 7506.7 7527.1 4283.1 4368.3 4381.5 4382.0 4385.5 2791.6 2952.8 2978.6 2982.9 2996.9 1098.6 1157.1 1177.4 1189.5 1213.4 9644.1 9657.5 9706.7 9755.8 9756.9 4002.5 4206.7 4210.6 4321.8 4340.0 8599.0 8600.1 8601.5 8605.6 8618.8 4631.8 4632.4 4635.4 4636.2 4639.2 4080.4 4103.2 4131.8 4198.1 4208.7 3559.4 3590.9 3614.4 3667.5 3759.1 1212.6 1221.9 1223.0 1232.7 1240.6 711.5 746.8 749.0 749.2 756.7 4585.6 4769.2 4782.2 4783.2 4897.9 893.7 922.8 932.9 933.8 938.9 3239.6 3364.3 3392.3 3417.2 3604.3 8333.1 8786.5 8795.6 8799.5 8811.0 8784.8 8786.3 8787.9 8789.6 8790.4 6849.3 6863.0 6976.8 6984.5 6985.8 4846.0 4897.9 4902.5 4912.2 4991.3 7921.6 7959.2 7985.6 8043.1 8061.3 8113.7 8244.5 8268.5 8302.1 8312.9 6176.6 6287.3 6306.3 6307.4 6312.1 6645.4 6960.2 7007.5 7018.8 7036.0 6269.7 6507.0 6555.4 6665.8 6791.2 6541.7 6657.4 6710.4 6731.0 6891.4 5560.2 5632.1 5682.0 5687.9 5695.7 4276.3 4318.9 4352.9 4529.6 4613.4 4435.4 4492.0 4581.2 4625.2 4742.6 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#4] prototype.html Cycles:180 Average:4213.48 Median:4689.00 stddev:1175.63 (25.1%) stddev-sans-first:1142.64 20:26:19 INFO - PROCESS | 16953 | Values: 351.8 363.1 364.1 367.8 368.3 4882.4 4934.0 4953.2 4955.0 4964.7 4608.4 4733.6 4766.1 4821.7 4825.4 3956.7 3958.9 3966.2 3985.2 3994.4 3946.4 3965.1 3977.4 3984.7 3997.5 3796.3 3827.3 3927.7 3954.4 3984.4 3929.1 3930.2 3933.0 3943.8 3944.8 3581.6 3593.6 3597.6 3600.9 3613.7 4662.2 4680.8 4742.3 4757.7 4764.9 4485.3 4494.4 4502.8 4519.6 4527.8 5084.9 5088.5 5094.8 5105.7 5139.0 3858.7 3909.6 3924.5 3933.9 3943.2 5098.3 5252.3 5267.2 5273.0 5286.6 3975.7 3994.5 3994.6 3996.7 3997.7 4040.6 4049.5 4058.0 4080.9 4089.9 4086.6 4260.0 4307.5 4506.6 4519.2 5060.0 5068.5 5092.5 5097.4 5105.0 1266.5 1272.7 1273.3 1273.6 1280.0 827.7 839.7 862.5 875.8 883.6 4285.5 4285.9 4292.8 4293.7 4304.7 5046.1 5047.9 5059.0 5064.6 5075.9 4157.6 4204.8 4263.0 4305.1 4308.2 2652.9 2663.2 2664.8 2682.3 2692.2 4635.7 4684.2 4687.7 4690.3 4713.5 4981.3 5103.6 5149.4 5168.3 5195.2 4669.8 4675.3 4691.8 4693.6 4712.9 5013.6 5037.9 5044.5 5071.6 5101.3 4667.0 4914.1 4924.7 4961.9 4981.6 4678.9 4686.9 4700.5 4705.6 4715.5 3609.6 3619.1 3627.6 3636.3 3639.7 4932.6 5043.5 5069.9 5072.4 5074.4 5043.3 5065.0 5072.0 5074.1 5091.0 5068.5 5068.8 5089.3 5123.3 5123.5 4838.6 4985.8 4997.4 5002.1 5024.4 4849.4 4913.6 5009.0 5078.3 5089.4 4939.4 4965.4 4996.4 4999.1 4999.5 20:26:19 INFO - PROCESS | 16953 | 20:26:19 INFO - PROCESS | 16953 | [#5] yui.html Cycles:180 Average:14794.50 Median:4220.13 stddev:17542.30 (415.7%) stddev-sans-first:17559.58 20:26:19 INFO - PROCESS | 16953 | Values: 699.2 712.1 751.5 771.2 799.1 12886.1 14082.9 14123.3 14144.8 14211.6 13355.7 13574.1 13579.0 13588.5 13590.8 654.5 675.4 798.9 820.6 827.8 823.2 828.1 831.0 833.0 833.0 878.8 879.2 879.5 880.1 880.1 675.5 698.3 853.6 877.7 880.8 643.1 645.0 645.2 645.3 645.4 13892.0 14165.6 14174.9 14184.5 14198.2 12874.4 13019.7 13186.9 13305.0 13366.8 12093.8 12180.3 12198.9 12211.7 12366.4 3295.4 3318.9 3405.5 3527.2 4186.4 53442.2 53687.0 57202.1 57467.7 59072.0 10305.5 10319.2 10585.1 10597.8 10995.3 19114.0 19114.4 19155.5 19247.4 19253.6 6742.3 6976.9 7134.4 7163.1 7246.5 3595.8 3708.8 3721.3 3746.0 3775.5 2768.1 2818.1 2859.0 2904.1 2951.7 482.8 482.8 488.5 493.3 498.1 638.5 658.8 665.3 672.0 673.2 8626.0 8847.9 8871.9 8970.0 8995.7 614.3 621.6 639.9 640.9 651.0 4079.1 4110.5 4253.9 4298.5 4344.7 64017.4 65547.0 65957.7 66829.0 66859.3 53488.0 57306.0 57898.0 57905.0 58149.0 44039.3 44386.6 50357.0 50689.7 50693.2 8836.6 9391.8 9467.9 9565.6 9574.0 31466.8 32845.2 34802.8 35190.8 37214.3 43799.3 44555.8 44685.0 44767.6 45009.3 10451.5 11084.2 11482.0 11649.9 12089.2 13374.7 13527.7 13571.5 14382.4 14386.4 11941.9 12680.4 12705.5 13184.1 13292.7 12155.7 12173.4 12569.9 12661.6 12669.7 12165.6 12234.8 12472.6 12821.7 12879.4 10272.2 10448.6 10484.5 10684.5 11005.8 9957.6 10123.2 10625.4 10960.9 10998.9 20:26:19 INFO - PROCESS | 16953 | -------- Summary: end -------- 20:26:19 INFO - PROCESS | 16953 | 20:26:20 INFO - TEST-INFO | 16953: exit 0 20:26:20 INFO - TEST-OK | dromaeo_css | took 1121047ms 20:26:20 INFO - TEST-START | kraken 20:26:20 INFO - operating with platform_type : linux_ 20:26:20 INFO - Initialising browser for kraken test... 20:26:20 INFO - TEST-INFO | started process 17255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRIQkm/profile http://localhost:47049/getInfo.html) 20:26:24 INFO - PROCESS | 17255 | __metrics Screen width/height:1600/1200 20:26:24 INFO - PROCESS | 17255 | colorDepth:24 20:26:24 INFO - PROCESS | 17255 | Browser inner width/height: 1024/697 20:26:24 INFO - PROCESS | 17255 | __metrics 20:26:24 INFO - PROCESS | 17255 | 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" 20:26:24 INFO - PROCESS | 17255 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:26:25 INFO - PROCESS | 17255 | console.error: PushService: 20:26:25 INFO - PROCESS | 17255 | stateChangeProcessEnqueue: Error transitioning state 20:26:25 INFO - PROCESS | 17255 | UnknownError 20:26:26 INFO - TEST-INFO | 17255: exit 0 20:26:26 INFO - Browser initialized. 20:26:26 INFO - Running cycle 1/1 for kraken test... 20:26:26 INFO - TEST-INFO | started process 17338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWRIQkm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:38 INFO - PROCESS | 17338 | RSS: Main: 151887872 20:26:38 INFO - PROCESS | 17338 | 20:26:41 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47049/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:41 INFO - PROCESS | 17338 | RSS: Main: 207028224 20:26:41 INFO - PROCESS | 17338 | 20:26:44 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47049/tests/kraken/driver.html?testName=audio-dft) 20:26:45 INFO - PROCESS | 17338 | RSS: Main: 185987072 20:26:45 INFO - PROCESS | 17338 | 20:26:48 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47049/tests/kraken/driver.html?testName=audio-fft) 20:26:49 INFO - PROCESS | 17338 | RSS: Main: 269279232 20:26:49 INFO - PROCESS | 17338 | 20:26:51 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47049/tests/kraken/driver.html?testName=audio-oscillator) 20:26:51 INFO - PROCESS | 17338 | RSS: Main: 180117504 20:26:51 INFO - PROCESS | 17338 | 20:26:54 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47049/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:54 INFO - PROCESS | 17338 | RSS: Main: 182702080 20:26:54 INFO - PROCESS | 17338 | 20:26:57 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47049/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:58 INFO - PROCESS | 17338 | RSS: Main: 222289920 20:26:58 INFO - PROCESS | 17338 | 20:27:01 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47049/tests/kraken/driver.html?testName=imaging-desaturate) 20:27:02 INFO - PROCESS | 17338 | RSS: Main: 216092672 20:27:02 INFO - PROCESS | 17338 | 20:27:05 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47049/tests/kraken/driver.html?testName=json-parse-financial) 20:27:05 INFO - PROCESS | 17338 | RSS: Main: 218058752 20:27:05 INFO - PROCESS | 17338 | 20:27:07 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47049/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:27:08 INFO - PROCESS | 17338 | RSS: Main: 181604352 20:27:08 INFO - PROCESS | 17338 | 20:27:10 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:27:10 INFO - PROCESS | 17338 | RSS: Main: 189362176 20:27:10 INFO - PROCESS | 17338 | 20:27:12 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:27:13 INFO - PROCESS | 17338 | RSS: Main: 197943296 20:27:13 INFO - PROCESS | 17338 | 20:27:16 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:27:17 INFO - PROCESS | 17338 | RSS: Main: 207691776 20:27:17 INFO - PROCESS | 17338 | 20:27:20 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:27:20 INFO - PROCESS | 17338 | RSS: Main: 202956800 20:27:20 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | Cycle 1(1): loaded http://localhost:47049/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47049/tests/kraken/driver.html?testName=ai-astar) 20:27:22 INFO - PROCESS | 17338 | RSS: Main: 254181376 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | __start_tp_report 20:27:22 INFO - PROCESS | 17338 | _x_x_mozilla_page_load 20:27:22 INFO - PROCESS | 17338 | _x_x_mozilla_page_load_details 20:27:22 INFO - PROCESS | 17338 | |i|pagename|runs| 20:27:22 INFO - PROCESS | 17338 | |0;ai-astar;114;118;117;116;117;117;115;116;116;117 20:27:22 INFO - PROCESS | 17338 | |1;audio-beat-detection;153;126;127;162;127;133;126;134;150;135 20:27:22 INFO - PROCESS | 17338 | |2;audio-dft;160;162;163;162;162;161;160;162;161;164 20:27:22 INFO - PROCESS | 17338 | |3;audio-fft;75;77;77;105;77;77;76;77;91;77 20:27:22 INFO - PROCESS | 17338 | |4;audio-oscillator;84;86;113;85;85;84;106;85;85;110 20:27:22 INFO - PROCESS | 17338 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;118;117 20:27:22 INFO - PROCESS | 17338 | |6;imaging-darkroom;149;149;149;149;149;149;148;148;149;149 20:27:22 INFO - PROCESS | 17338 | |7;imaging-desaturate;96;95;94;96;94;95;95;96;95;95 20:27:22 INFO - PROCESS | 17338 | |8;json-parse-financial;59;58;58;59;60;59;58;58;59;61 20:27:22 INFO - PROCESS | 17338 | |9;json-stringify-tinderbox;69;73;67;68;68;67;68;69;70;69 20:27:22 INFO - PROCESS | 17338 | |10;stanford-crypto-aes;90;92;86;86;85;87;86;88;84;85 20:27:22 INFO - PROCESS | 17338 | |11;stanford-crypto-ccm;146;134;134;142;131;134;139;132;173;134 20:27:22 INFO - PROCESS | 17338 | |12;stanford-crypto-pbkdf2;182;175;178;176;175;174;178;177;178;176 20:27:22 INFO - PROCESS | 17338 | |13;stanford-crypto-sha256-iterative;68;70;71;70;70;71;71;69;69;67 20:27:22 INFO - PROCESS | 17338 | __end_tp_report 20:27:22 INFO - PROCESS | 17338 | __start_cc_report 20:27:22 INFO - PROCESS | 17338 | _x_x_mozilla_cycle_collect,1836 20:27:22 INFO - PROCESS | 17338 | __end_cc_report 20:27:22 INFO - PROCESS | 17338 | __startTimestamp1484627242815__endTimestamp 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | ------- Summary: start ------- 20:27:22 INFO - PROCESS | 17338 | Number of tests: 14 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.00 stddev:1.16 (1.0%) stddev-sans-first:0.88 20:27:22 INFO - PROCESS | 17338 | Values: 114.0 118.0 117.0 116.0 117.0 117.0 115.0 116.0 116.0 117.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:134.50 stddev:13.00 (9.7%) stddev-sans-first:12.48 20:27:22 INFO - PROCESS | 17338 | Values: 153.0 126.0 127.0 162.0 127.0 133.0 126.0 134.0 150.0 135.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.17 20:27:22 INFO - PROCESS | 17338 | Values: 160.0 162.0 163.0 162.0 162.0 161.0 160.0 162.0 161.0 164.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#3] audio-fft Cycles:10 Average:80.90 Median:77.00 stddev:9.62 (12.5%) stddev-sans-first:9.96 20:27:22 INFO - PROCESS | 17338 | Values: 75.0 77.0 77.0 105.0 77.0 77.0 76.0 77.0 91.0 77.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:85.00 stddev:12.11 (14.2%) stddev-sans-first:12.47 20:27:22 INFO - PROCESS | 17338 | Values: 84.0 86.0 113.0 85.0 85.0 84.0 106.0 85.0 85.0 110.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:27:22 INFO - PROCESS | 17338 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 20:27:22 INFO - PROCESS | 17338 | Values: 149.0 149.0 149.0 149.0 149.0 149.0 148.0 148.0 149.0 149.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 20:27:22 INFO - PROCESS | 17338 | Values: 96.0 95.0 94.0 96.0 94.0 95.0 95.0 96.0 95.0 95.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.00 stddev:0.99 (1.7%) stddev-sans-first:1.05 20:27:22 INFO - PROCESS | 17338 | Values: 59.0 58.0 58.0 59.0 60.0 59.0 58.0 58.0 59.0 61.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:1.75 (2.5%) stddev-sans-first:1.86 20:27:22 INFO - PROCESS | 17338 | Values: 69.0 73.0 67.0 68.0 68.0 67.0 68.0 69.0 70.0 69.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.50 stddev:2.47 (2.9%) stddev-sans-first:2.35 20:27:22 INFO - PROCESS | 17338 | Values: 90.0 92.0 86.0 86.0 85.0 87.0 86.0 88.0 84.0 85.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.50 stddev:12.56 (9.2%) stddev-sans-first:13.12 20:27:22 INFO - PROCESS | 17338 | Values: 146.0 134.0 134.0 142.0 131.0 134.0 139.0 132.0 173.0 134.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:177.50 stddev:2.28 (1.3%) stddev-sans-first:1.50 20:27:22 INFO - PROCESS | 17338 | Values: 182.0 175.0 178.0 176.0 175.0 174.0 178.0 177.0 178.0 176.0 20:27:22 INFO - PROCESS | 17338 | 20:27:22 INFO - PROCESS | 17338 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.35 (1.9%) stddev-sans-first:1.30 20:27:22 INFO - PROCESS | 17338 | Values: 68.0 70.0 71.0 70.0 70.0 71.0 71.0 69.0 69.0 67.0 20:27:22 INFO - PROCESS | 17338 | -------- Summary: end -------- 20:27:22 INFO - PROCESS | 17338 | 20:27:23 INFO - TEST-INFO | 17338: exit 0 20:27:24 INFO - TEST-OK | kraken | took 63893ms 20:27:24 INFO - SUITE-END | took 1184s 20:27:24 INFO - Completed test suite (00:19:45) 20:27:24 INFO - javascript benchmark 20:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2532.898684052638, 2547.528707189169, 2581.277242372136, 2585.741425857413, 2590.8704564771756, 4617.030423611046, 4681.4382274127065, 4777.06847164803, 4807.326974223607, 4819.421669399672, 4740.4548476925165, 4802.807887684488, 4812.831550895719, 4855.126077306083, 4856.878578035551, 4284.550122237167, 4306.310990241562, 4338.197433474801, 4416.006398560315, 4435.534268901767, 4153.916921661565, 4416.492103408117, 4442.267025940732, 4464.754438505897, 4496.707713998596, 4296.162248361571, 4449.443819522559, 4450.799714012877, 4493.797779099932, 4558.156741002908, 4337.414449049369, 4383.276759334706, 4410.977945110254, 4423.447069116361, 4497.9325310120375, 4403.537628548988, 4421.46942366918, 4425.601695847389, 4427.092446048552, 4449.599536041739, 4766.571008609207, 4773.737444440554, 4795.544423279783, 4797.736124513151, 4812.807487700487, 4982.950170498321, 5007.54932056113, 5069.163588008011, 5122.795088196468, 5138.100832354323, 5165.096108181091, 5186.377634683862, 5189.948100518985, 5213.035588416155, 5221.269022336875, 4831.661783675144, 4842.5157484251995, 4847.345608342899, 4847.394075740533, 4879.268109783561, 5199.168133098686, 5215.739213039333, 5229.294045303911, 5273.1299335609965, 5291.206319052096, 5037.4458809530925, 5048.646594738407, 5049.84850454487, 5094.541491265803, 5107.157319042316, 5008.549230569266, 5032.974835125801, 5138.537531622172, 5149.201873709506, 5202.193659982633, 5034.723090229999, 5067.721275329818, 5136.794528218829, 5139.229115632685, 5207.583393328525, 4916.434610019894, 4936.531029552187, 5093.363329583802, 5141.38303403594, 5143.12566863634, 4308.870733877989, 4324.329728892027, 4326.307790753464, 4340.717853339523, 4386.210482113186, 3738.140227747633, 3741.85032598693, 3744.8314825832904, 3781.621837816251, 3787.394016957274, 4294.420253265832, 4398.0, 4406.294992801137, 4409.272470042407, 4444.577765112309, 5056.696598204119, 5087.414947281036, 5124.282600435942, 5124.615653825978, 5215.765290561933, 4364.60718535327, 4384.802683879233, 4388.648908087345, 4392.033752574429, 4431.313146462304, 4599.425071866017, 4607.378003969488, 4608.700434471749, 4615.930761038587, 4643.512431194676, 4690.882727931829, 4693.601043911306, 4724.598409135125, 4726.338312636302, 4731.905361892812, 5116.976604679005, 5118.872028199325, 5119.718415487184, 5126.4360920297995, 5159.716215608028, 4735.8870665392915, 4736.052789442057, 4738.8341408050555, 4739.928901066418, 4767.070421267819, 4901.6323775716255, 4930.778114984762, 5043.4956504349275, 5049.596032317332, 5068.239764035424, 5161.122609156528, 5167.302414174038, 5169.353830771153, 5199.584033277404, 5220.791168353223, 4761.738104404291, 4979.228219625964, 5019.247112933089, 5021.171506701354, 5067.771950262173, 4783.425988881357, 4838.637102217277, 4921.532454416824, 4921.63087768426, 4962.0, 4911.656184067081, 4915.434725006527, 4970.080535101018, 4972.900541989212, 4976.601871850316, 4971.577415919687, 4994.9500504994485, 5008.123578373843, 5014.297998280171, 5047.974760126176, 4802.639802014793, 4846.418429788448, 4898.804047838046, 4910.189818679878, 4950.331705219749], "value": 4684.237506450412, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.7902557515356, 554.4261689151729, 566.7704579645242, 566.897958367494, 578.6759414727755, 29709.702902970963, 40028.0, 41228.0, 41319.17361652765, 45497.31754023684, 42346.788266058706, 42753.35869961953, 42804.35793463101, 43130.35304470435, 43135.137297254034, 7452.6273686315735, 7595.392368610498, 7748.380129589619, 7764.107127680304, 7766.301032907038, 7488.213737557559, 9886.653967111153, 10131.341462804894, 10134.493275336241, 10426.165906727443, 10108.292419530635, 10144.49277536124, 10178.6946391608, 10187.59249630014, 10191.235657325693, 10096.495175241245, 10111.797764044677, 10115.595376184943, 10148.1374083203, 10160.08559229673, 9960.850587241197, 10025.348352357147, 10044.698659040241, 10049.145822605087, 10063.345882517613, 39783.40324895129, 40064.59935400638, 40092.79953600242, 40104.0, 40142.397864032064, 3733.2533493301175, 3766.5291838520184, 3804.1630841214887, 3842.1163132479405, 3855.9228815423817, 28070.43859122806, 28407.857960710066, 29113.249194066662, 29938.251543711365, 30282.394352113053, 3421.9657803421896, 3493.7030352420074, 3545.2200515886466, 3552.0942159749357, 3583.426651735736, 246318.0, 251342.0, 251693.0, 252284.0, 252392.0, 61644.38355616386, 62521.8739063045, 62579.6871015642, 62685.0, 62753.372466275665, 65233.34766652273, 65317.34682653208, 65657.16656751678, 65860.34139658637, 65929.67035164793, 15166.393344266326, 15702.607434813992, 15730.449434269745, 15740.291686874118, 15742.449014284673, 8798.38411311202, 9031.683891063782, 11123.332600044023, 11548.133889958119, 11676.182667213383, 19383.612327753366, 19771.39604212548, 20088.497787555134, 20090.799092008892, 20134.395968120978, 7590.8102297443, 7663.846723065508, 7817.80455488606, 7822.765317040498, 7870.803229919184, 826.2935190412231, 835.6364981233183, 848.6520526584071, 866.5234121233296, 877.4515927545284, 26636.733632663814, 27983.860080699465, 28598.85700571484, 28665.42669146647, 28824.279393014924, 939.6100618243489, 981.6367943860818, 990.7919336939179, 996.5415908682088, 1129.5594718059963, 12904.741905161844, 13394.531191408449, 13427.287133844275, 13561.932190339183, 13608.523701670592, 379098.0, 380369.0, 380911.0, 381105.0, 382323.0, 44021.77989110034, 44342.0, 44447.555524444986, 44462.33306500405, 44535.0, 1220.408102070495, 1257.7044394567085, 1267.5056727876135, 1273.923564586128, 1280.5262053040435, 23530.294091177293, 24068.27795166148, 24959.625605616293, 25033.249002529952, 25047.749522504542, 37741.4338784924, 38394.80802595969, 38468.6153138465, 38472.230555389295, 38535.42196866993, 321673.0, 322398.0, 323329.0, 323573.0, 323676.0, 20479.468122807215, 21244.36266911995, 21865.453363666034, 21916.23293184731, 24043.278701638978, 33789.66210337963, 34015.65984340125, 34163.316733665684, 34251.65748342584, 34568.308633827684, 32036.67963320337, 32231.677683222868, 33585.66414335923, 36057.68990426717, 36821.26357472889, 32035.359292813548, 33101.503477448336, 33256.83371583223, 33590.0, 34014.938655521124, 32676.019719408458, 33330.33339333248, 33445.16387090245, 33702.49446258357, 33748.49377259392, 25872.870635647454, 26230.721159855017, 29906.252343691584, 30197.547036794025, 31378.372432551678, 23458.296251112493, 23743.762562374155, 23864.03918259758, 23983.52032959366, 24117.638235426133], "value": 17867.544798883115, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.4743359296984, 383.8407061069656, 395.7309029859695, 397.5031210986267, 419.8152812762384, 13109.0, 13578.185308881473, 17226.48320550384, 17718.64562708745, 17722.0, 14342.569722908303, 17062.744058839096, 17392.47822565322, 18106.728399074025, 18274.17766200524, 5160.432352441228, 5361.812336568221, 5367.946320536803, 5370.0, 5372.382176049765, 5106.183010718286, 5196.714180720059, 5277.12927366984, 5314.681119132845, 5317.282166907476, 5282.7622756976025, 5292.285541451913, 5293.338332708411, 5296.232046353276, 5300.0, 5100.617453690969, 5191.740412979374, 5207.062728708831, 5220.791168353261, 5279.973600132013, 4690.366800481959, 4694.929576056362, 4708.905821883577, 4710.764461776897, 4714.57568818808, 20935.0, 21920.89039554792, 21962.0, 22083.33749987503, 22256.221032263955, 2579.496998085374, 2616.5813469844925, 2652.9867350663317, 2674.3848914749524, 2682.919512414631, 13223.73552528944, 13406.597802065953, 13563.728725425535, 13624.863751362458, 14178.929105354511, 1759.41141135178, 1791.408835084419, 1812.420025591811, 1816.7729033870767, 1823.9908800456046, 70116.29883701149, 71517.0, 71520.2847971524, 73122.63438682826, 73229.26770732278, 10292.948535257276, 10357.0, 10434.530446129942, 10661.68014959537, 10700.732481688021, 14468.493602723855, 14484.637884052983, 14493.130412175304, 14496.565103046925, 14505.492307769178, 7559.697612095454, 7695.422843286776, 7707.113681926538, 7961.641726122339, 7968.243016913384, 7289.744858929912, 7292.781216563511, 7382.9630851845395, 7510.061242344707, 7539.962300188574, 6687.398134167948, 6758.864822703518, 6804.693788779517, 6813.625250611165, 6887.173539175331, 1780.97328540072, 1792.4801807475685, 1798.5323815807983, 1818.0, 1818.4999125240665, 790.4585359029084, 804.8511025460308, 809.1746418652941, 810.3679130278274, 819.5861090149436, 17253.913730431268, 18351.0, 18700.906495467436, 18806.0, 18957.247028765352, 793.6825269892089, 808.9514629122272, 813.6867306087199, 822.6668199379261, 832.8958880139983, 9863.950680246553, 10166.186705063577, 10511.474426278808, 10514.737131571772, 10566.947165264279, 471139.0, 492755.0, 494041.0, 500172.0, 504705.0, 73525.2647473529, 75930.0, 76177.61911190409, 76473.6176319126, 76531.23468765241, 934.458014351688, 946.3517490519016, 964.6864768950119, 966.5505539923969, 967.849983252597, 15390.769138462709, 15532.30104645271, 16096.919515402347, 16387.918060409622, 16405.507834764976, 33617.0, 34104.34119203187, 34497.482537761454, 35008.649913500536, 35222.11944701403, 45416.318755219356, 45575.544244558456, 45712.0, 47793.28310075421, 48021.0, 7800.414968877243, 7894.21057894206, 8076.71731489395, 8162.265396114378, 8172.346212302882, 12062.276263424223, 12474.75050499003, 12678.809817852924, 12812.295323757282, 12907.419166137734, 9935.801283974424, 10054.798904022025, 10143.7464063399, 10666.46667666629, 11025.61410350634, 10580.20648451354, 10742.516586753458, 10858.185636077167, 10975.50610222526, 11280.0, 9942.652007180004, 9945.353552019096, 10045.095941365313, 10522.053015228666, 10974.451277435937, 7985.800354991172, 8082.83834323322, 8143.063547692092, 8183.304419124203, 8315.376346773895, 9760.853587196056, 10014.39913605186, 10368.051366670332, 10600.681979540626, 10610.249308863951], "value": 8617.347198697074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.6345186799565, 1377.8071070050191, 1394.142602299586, 1394.5955672854873, 1398.2938615998933, 7116.0, 7467.514611550259, 7469.962650186755, 7479.887801682972, 7484.476086673928, 6268.467180289681, 6523.771667991621, 7041.894371584431, 7232.7830165095, 7313.085864266966, 2190.857594256376, 2232.9330120096424, 2237.3511681612313, 2237.4182712494785, 2238.854474459163, 2104.547522282709, 2203.790639889208, 2208.2712704807377, 2209.3482422685347, 2221.3002904085242, 1844.1332573690345, 1908.4179325305777, 2094.110003248621, 2162.145952348821, 2172.0225898345807, 2116.7354080739906, 2122.129926730041, 2136.316378758798, 2142.2609199826034, 2144.9892750536305, 2170.848040637156, 2202.1631779923528, 2205.283282933053, 2208.7570367259586, 2210.9226177083888, 7380.261973802631, 7464.1416237132335, 7494.5128566643, 7506.699732010713, 7527.134379546367, 4283.1433713257475, 4368.257396242647, 4381.452318460192, 4381.9561804381865, 4385.451818522684, 2791.595218693278, 2952.7637788977045, 2978.6425628924453, 2982.8508574571183, 2996.8951086712077, 1098.6154845803985, 1157.0552942760694, 1177.43483128099, 1189.5360809284387, 1213.3811756004413, 9644.083812037845, 9657.46883921384, 9706.70879873605, 9755.756106097333, 9756.853647195298, 4002.4996875390575, 4206.705530612889, 4210.59999300066, 4321.827126914951, 4340.045190058182, 8599.0, 8600.096989816104, 8601.526916019679, 8605.612747426381, 8618.827623447496, 4631.814727410933, 4632.3977882875015, 4635.374224479652, 4636.165490211727, 4639.211334073216, 4080.4491393661474, 4103.199876024147, 4131.772752498641, 4198.118395136994, 4208.6633069354375, 3559.430491121408, 3590.868876303956, 3614.403623402109, 3667.504886840296, 3759.0978165240144, 1212.6240865331774, 1221.8961388282096, 1222.9816552751715, 1232.6610182199788, 1240.64021433785, 711.5161690050712, 746.8058304840672, 749.0, 749.2432643030578, 756.6859753202359, 4585.587297143273, 4769.189237829577, 4782.187028205213, 4783.210770222874, 4897.877553061131, 893.7095443980733, 922.7739203895088, 932.8693982842408, 933.8459154239611, 938.9248860091176, 3239.5950506186728, 3364.327134573095, 3392.3215356928713, 3417.162795115163, 3604.2971620534267, 8333.083360830304, 8786.472811631322, 8795.604197811113, 8799.47203167812, 8811.030786613468, 8784.824303513893, 8786.253168480624, 8787.91212087871, 8789.560521973875, 8790.384673072951, 6849.315068493111, 6863.0, 6976.790696279119, 6984.476164287597, 6985.79042628722, 4846.006568653488, 4897.9020419592125, 4902.460729319843, 4912.214045752662, 4991.326170967018, 7921.564313962787, 7959.164287749934, 7985.6007199638625, 8043.075046369742, 8061.314788243065, 8113.716019939274, 8244.54654993957, 8268.503889766633, 8302.086770455366, 8312.916870831456, 6176.567640265138, 6287.339829317856, 6306.337834527309, 6307.369263073656, 6312.053192021233, 6645.401913827779, 6960.234374218933, 7007.544509607063, 7018.789436316919, 7036.0, 6269.68651567429, 6507.0, 6555.4427873629365, 6665.833354166185, 6791.2190098139345, 6541.70562324706, 6657.40083392497, 6710.429613482908, 6731.024001519851, 6891.3797758202, 5560.165975103767, 5632.098864181711, 5681.971590142023, 5687.9431205687415, 5695.715214239189, 4276.337167739005, 4318.892027699333, 4352.934705979476, 4529.569690879362, 4613.446386433515, 4435.379046933367, 4491.955080449285, 4581.1753884299815, 4625.213713668617, 4742.620590352694], "value": 3998.0698438293052, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.82584620612784, 363.11581299535646, 364.0661702732491, 367.77014366021234, 368.3222869919348, 4882.389701287339, 4934.0, 4953.157963146265, 4954.975225123874, 4964.702117872921, 4608.400907881979, 4733.5739783419485, 4766.070616229837, 4821.710697358161, 4825.420949486067, 3956.663683586884, 3958.8812335629977, 3966.2067586482676, 3985.2029594081155, 3994.380870964998, 3946.3685810270363, 3965.1252841689834, 3977.4431579578736, 3984.740991835536, 3997.460342853721, 3796.2976849282973, 3827.349350610403, 3927.725059245854, 3954.3673012318036, 3984.402339649047, 3929.135590170158, 3930.21395720857, 3932.980335098306, 3943.8225279862477, 3944.8224829882724, 3581.5673730507747, 3593.6406359364114, 3597.5862775780856, 3600.873969411084, 3613.7109031277437, 4662.184117779409, 4680.836170734042, 4742.264948932921, 4757.690750101232, 4764.927891224482, 4485.304777759453, 4494.438195225597, 4502.797374118172, 4519.593236608721, 4527.750973696446, 5084.898302033976, 5088.516590923857, 5094.821681241138, 5105.7191854448365, 5138.974305128488, 3858.7298889077774, 3909.648131668135, 3924.47019652349, 3933.9016524586827, 3943.1719338938856, 5098.337216161875, 5252.264682944353, 5267.236250743621, 5273.0, 5286.5770738341225, 3975.662068724133, 3994.5206575210577, 3994.6005399459823, 3996.720229583901, 3997.700172487075, 4040.6363427291685, 4049.4735684360844, 4057.9797101014306, 4080.9387859182134, 4089.8773036808943, 4086.5504794472586, 4259.997801033509, 4307.461567304087, 4506.59440650343, 4519.209138400766, 5060.0, 5068.493150684976, 5092.516210959953, 5097.362829646294, 5104.974475127675, 1266.5377137344988, 1272.7327261275236, 1273.2996851731696, 1273.57335292678, 1280.0, 827.71443851871, 839.6641343462663, 862.5169904853177, 875.7810547363159, 883.6465413834518, 4285.507166675872, 4285.914281714348, 4292.763897985641, 4293.742375457483, 4304.655627549789, 5046.082488654361, 5047.9495205048215, 5059.0, 5064.620153488503, 5075.949240507622, 4157.605027522381, 4204.810783514749, 4262.978685106555, 4305.084237514338, 4308.246056940023, 2652.8938842446473, 2663.187727743057, 2664.8401095934305, 2682.316009417586, 2692.2192564156567, 4635.6523260755575, 4684.2271025281125, 4687.718736875799, 4690.273007683814, 4713.528647135259, 4981.252812078217, 5103.566196873233, 5149.407818100892, 5168.328117344797, 5195.246689230041, 4669.836555720533, 4675.259792166254, 4691.7888695008805, 4693.55411235932, 4712.905741885212, 5013.598912086952, 5037.92443113361, 5044.495550444926, 5071.6163403200435, 5101.311322971352, 4667.0, 4914.066327397783, 4924.704517728947, 4961.8511444656715, 4981.626378021735, 4678.929816052694, 4686.906261874811, 4700.45944716362, 4705.576498115186, 4715.510522213606, 3609.6283412303155, 3619.1314084618975, 3627.5900653385734, 3636.3272794533095, 3639.7088232941833, 4932.63005274613, 5043.5460808527405, 5069.923951140662, 5072.442031376472, 5074.3657042869645, 5043.319151914445, 5065.0, 5072.0, 5074.137396642506, 5090.974545127251, 5068.493150684902, 5068.82259120929, 5089.312942752829, 5123.308353372247, 5123.541609413705, 4838.588719958702, 4985.775640096132, 4997.375328083989, 5002.099622068063, 5024.42219144803, 4849.418069831643, 4913.606911447004, 5008.974955125347, 5078.339815823919, 5089.3638295213095, 4939.407271127488, 4965.4041515018425, 4996.350474438445, 4999.10016197088, 4999.475055119306], "value": 3851.613165204497, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.154023631406, 712.0849708125061, 751.4664588142418, 771.2326235395781, 799.1249581708031, 12886.097973141885, 14082.859171408283, 14123.293835308219, 14144.787828182572, 14211.64470888227, 13355.666108347295, 13574.117682350641, 13579.0, 13588.524401645944, 13590.796138057913, 654.4960380507007, 675.4461341699808, 798.8641930871737, 820.6020080261069, 827.8344331133767, 823.172711425017, 828.0766944856472, 830.9792255193638, 832.9541875196892, 832.9875051874227, 878.7934835313696, 879.248242752447, 879.5470332778624, 880.0715245416084, 880.1242763450376, 675.4663815585706, 698.2947223304449, 853.590276667197, 877.7454538183919, 880.8370451466499, 643.1189270699125, 645.0356716708504, 645.1612903225788, 645.3256347117274, 645.4352441613588, 13892.0, 14165.575032749033, 14174.929125354307, 14184.503542375967, 14198.219097949608, 12874.420651070724, 13019.739605207937, 13186.86813131866, 13305.0, 13366.799498007538, 12093.79835733838, 12180.269183848997, 12198.939005304917, 12211.69470763238, 12366.381680916009, 3295.3574053059665, 3318.867245310185, 3405.4891766235014, 3527.153483164022, 4186.413902053715, 53442.198367024524, 53687.0, 57202.14196787051, 57467.712661436424, 59072.0, 10305.536250868729, 10319.1744660427, 10585.100266477435, 10597.84103238452, 10995.34027958325, 19114.0, 19114.42656720273, 19155.521111972314, 19247.422577322704, 19253.61492770137, 6742.255013656617, 6976.930230697628, 7134.357907788324, 7163.1404231491515, 7246.492745507764, 3595.8381872815785, 3708.8145592720257, 3721.330160571069, 3745.981270093687, 3775.4903088083306, 2768.1280396674983, 2818.055951256311, 2858.9857050714613, 2904.1142451552055, 2951.7343439090587, 482.7562081148997, 482.8310091467958, 488.5212491758097, 493.30690380016136, 498.0661260137243, 638.5370606310481, 658.7924803686919, 665.2881416883985, 671.9529632925746, 673.1686367336335, 8625.956870215608, 8847.911520884709, 8871.911280887109, 8969.955150224338, 8995.685151019683, 614.2904944788687, 621.6083867163658, 639.8720255948829, 640.9487241020707, 650.9544331896722, 4079.1234941252173, 4110.527289361702, 4253.851115210953, 4298.505671847777, 4344.739315641072, 64017.35982640207, 65547.0, 65957.67021164864, 66829.0, 66859.33140668628, 53488.0, 57306.0, 57898.0, 57905.0, 58149.0, 44039.33940990888, 44386.556134438244, 50357.0, 50689.74655126701, 50693.23960140601, 8836.644098901525, 9391.812163756824, 9467.905320946702, 9565.569549370155, 9574.0, 31466.842665786524, 32845.178870527474, 34802.82598586991, 35190.824045879606, 37214.255714886094, 43799.34300985424, 44555.77722111368, 44685.0, 44767.55232447634, 45009.32486012647, 10451.524638375753, 11084.16868734832, 11482.0, 11649.883501165219, 12089.214201076902, 13374.665633359244, 13527.661808454868, 13571.457141714616, 14382.3527941245, 14386.35261413218, 11941.940290298493, 12680.365981701063, 12705.491780329054, 13184.143030702973, 13292.734145317232, 12155.696107597381, 12173.39133043362, 12569.87430125687, 12661.620151395473, 12669.74660506803, 12165.635030949086, 12234.755304893673, 12472.625821225014, 12821.743565128458, 12879.425600396138, 10272.22958278147, 10448.634297799541, 10484.52819623134, 10684.519196636014, 11005.779884402427, 9957.601695932082, 10123.240756943405, 10625.362478251329, 10960.890391095987, 10998.890011100106], "value": 6505.100534260199, "unit": "score"}], "name": "dromaeo_css", "value": 6453.758394622657, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 116.0, 117.0, 117.0, 115.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 127.0, 162.0, 127.0, 133.0, 126.0, 134.0, 150.0, 135.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 163.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0, 164.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 77.0, 105.0, 77.0, 77.0, 76.0, 77.0, 91.0, 77.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 113.0, 85.0, 85.0, 84.0, 106.0, 85.0, 85.0, 110.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 96.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 59.0, 60.0, 59.0, 58.0, 58.0, 59.0, 61.0], "value": 58.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 67.0, 68.0, 68.0, 67.0, 68.0, 69.0, 70.0, 69.0], "value": 68.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 86.0, 86.0, 85.0, 87.0, 86.0, 88.0, 84.0, 85.0], "value": 86.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 134.0, 134.0, 142.0, 131.0, 134.0, 139.0, 132.0, 173.0, 134.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 175.0, 178.0, 176.0, 175.0, 174.0, 178.0, 177.0, 178.0, 176.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 71.0, 70.0, 70.0, 71.0, 71.0, 69.0, 69.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1550.6000000000001, "alertThreshold": 2.0}]} 20:27:24 INFO - Return code: 0 20:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:27:24 ERROR - # TBPL SUCCESS # 20:27:24 INFO - Running post-action listener: _resource_record_post_action 20:27:24 INFO - [mozharness: 2017-01-17 04:27:24.598336Z] Finished run-tests step (success) 20:27:24 INFO - Running post-run listener: _resource_record_post_run 20:27:24 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 384200704; Read time: 12; Write time: 254248 20:27:24 INFO - TinderboxPrint: CPU usage
13.1% 20:27:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 20:27:24 INFO - TinderboxPrint: I/O write bytes / time
384,200,704 / 254,248 20:27:24 INFO - TinderboxPrint: CPU idle
8,335.3 (86.9%) 20:27:24 INFO - TinderboxPrint: CPU user
1,213.6 (12.6%) 20:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 20:27:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100192256; Read time: 0; Write time: 86284 20:27:24 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 284008448; Read time: 0; Write time: 167964 20:27:25 INFO - Running post-run listener: _upload_blobber_files 20:27:25 INFO - Blob upload gear active. 20:27:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:27:25 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 20:27:25 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:27:25 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 20:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:26 INFO - (blobuploader) - INFO - Done attempting. 20:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:27 INFO - (blobuploader) - INFO - Done attempting. 20:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:27:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:28 INFO - (blobuploader) - INFO - Done attempting. 20:27:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:27:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:27:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:27:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:27:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:27:31 INFO - (blobuploader) - INFO - Done attempting. 20:27:31 INFO - (blobuploader) - INFO - Iteration through files over. 20:27:31 INFO - Return code: 0 20:27:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:27:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:27:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89d7c6af3b7714fbfc731f6eefc1ea7a5e26a8c71afe68a3d0656ce5807a79acf9160ac253771a0b85b054debd36b7dfa6ec49f7f5bdfbcb80ea170c2f8d2d9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cab9bf11f7a82eed2ca6c4917b8170efc41cbfc49f1b8d87df5eed52adc7e702a86d6b58e37c58d02ee849aeedff571855a2c39262c3cc561fe1588ed43ceaf0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d11f02b18fc35981b780cdd7c413e3777407cad4dc2e95487571498ea066ed709570923a15afc53c99b6972c8728e0f3c858363bd23a7b853bdaf6d89d131817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dbcc29c25a2ddfd5ad49e558b1c33b1b271a559aebd5d063c3b72cf3d966b6731c362ef0325b1c498a97a13bccc0647fecd36d50d23001dda9ce77338a5fc150"} 20:27:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:27:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:27:31 INFO - Contents: 20:27:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89d7c6af3b7714fbfc731f6eefc1ea7a5e26a8c71afe68a3d0656ce5807a79acf9160ac253771a0b85b054debd36b7dfa6ec49f7f5bdfbcb80ea170c2f8d2d9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cab9bf11f7a82eed2ca6c4917b8170efc41cbfc49f1b8d87df5eed52adc7e702a86d6b58e37c58d02ee849aeedff571855a2c39262c3cc561fe1588ed43ceaf0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d11f02b18fc35981b780cdd7c413e3777407cad4dc2e95487571498ea066ed709570923a15afc53c99b6972c8728e0f3c858363bd23a7b853bdaf6d89d131817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dbcc29c25a2ddfd5ad49e558b1c33b1b271a559aebd5d063c3b72cf3d966b6731c362ef0325b1c498a97a13bccc0647fecd36d50d23001dda9ce77338a5fc150"} 20:27:31 INFO - Running post-run listener: copy_logs_to_upload_dir 20:27:31 INFO - Copying logs to upload dir... 20:27:31 INFO - mkdir: /builds/slave/test/build/upload/logs 20:27:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.205325 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-16 20:27:31.417045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 20:27:31.421964) ========= 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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89d7c6af3b7714fbfc731f6eefc1ea7a5e26a8c71afe68a3d0656ce5807a79acf9160ac253771a0b85b054debd36b7dfa6ec49f7f5bdfbcb80ea170c2f8d2d9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cab9bf11f7a82eed2ca6c4917b8170efc41cbfc49f1b8d87df5eed52adc7e702a86d6b58e37c58d02ee849aeedff571855a2c39262c3cc561fe1588ed43ceaf0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d11f02b18fc35981b780cdd7c413e3777407cad4dc2e95487571498ea066ed709570923a15afc53c99b6972c8728e0f3c858363bd23a7b853bdaf6d89d131817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dbcc29c25a2ddfd5ad49e558b1c33b1b271a559aebd5d063c3b72cf3d966b6731c362ef0325b1c498a97a13bccc0647fecd36d50d23001dda9ce77338a5fc150"} build_url:https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/eAQFLDFTRdWzqPkZ-vCB5w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/89d7c6af3b7714fbfc731f6eefc1ea7a5e26a8c71afe68a3d0656ce5807a79acf9160ac253771a0b85b054debd36b7dfa6ec49f7f5bdfbcb80ea170c2f8d2d9f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/cab9bf11f7a82eed2ca6c4917b8170efc41cbfc49f1b8d87df5eed52adc7e702a86d6b58e37c58d02ee849aeedff571855a2c39262c3cc561fe1588ed43ceaf0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/d11f02b18fc35981b780cdd7c413e3777407cad4dc2e95487571498ea066ed709570923a15afc53c99b6972c8728e0f3c858363bd23a7b853bdaf6d89d131817", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/dbcc29c25a2ddfd5ad49e558b1c33b1b271a559aebd5d063c3b72cf3d966b6731c362ef0325b1c498a97a13bccc0647fecd36d50d23001dda9ce77338a5fc150"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-16 20:27:31.450594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:27:31.450946) ========= 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=14ef55db36f7623abb31b9cf000001d5-1484617512.348818-981513576 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-16 20:27:31.533562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 20:27:31.533962) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-16 20:27:31.534308) ========= ========= Total master_lag: 0.20 =========