builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1486570596.18 results: success (0) revision: 5e17f9181c6cb0968966280d1c1d96e725702af1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.179169) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.179629) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.179902) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.196056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.196333) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-08 08:16:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 230M=0s 2017-02-08 08:16:37 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140367 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.349739) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.350046) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020323 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:36.399461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 08:16:36.399804) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e17f9181c6cb0968966280d1c1d96e725702af1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 5e17f9181c6cb0968966280d1c1d96e725702af1 --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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-08 08:16:37,426 truncating revision to first 12 chars 2017-02-08 08:16:37,426 Setting DEBUG logging. 2017-02-08 08:16:37,426 attempt 1/10 2017-02-08 08:16:37,426 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e17f9181c6c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-08 08:16:38,136 unpacking tar archive at: mozilla-central-5e17f9181c6c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.036923 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-08 08:16:37.449265) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:37.449607) ========= script_repo_revision: 5e17f9181c6cb0968966280d1c1d96e725702af1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:37.449995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:37.450288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-08 08:16:37.460643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-02-08 08:16:37.461100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:38 INFO - MultiFileLogger online at 20170208 08:16:38 in /builds/slave/test 08:16:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:16:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:38 INFO - {'append_to_log': False, 08:16:38 INFO - 'base_work_dir': '/builds/slave/test', 08:16:38 INFO - 'blob_upload_branch': 'Firefox', 08:16:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:38 INFO - 'branch': 'Firefox', 08:16:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:38 INFO - 'config_files': ('talos/linux_config.py',), 08:16:38 INFO - 'default_actions': ('clobber', 08:16:38 INFO - 'read-buildbot-config', 08:16:38 INFO - 'download-and-extract', 08:16:38 INFO - 'populate-webroot', 08:16:38 INFO - 'create-virtualenv', 08:16:38 INFO - 'install', 08:16:38 INFO - 'run-tests'), 08:16:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:38 INFO - 'download_minidump_stackwalk': True, 08:16:38 INFO - 'download_symbols': 'ondemand', 08:16:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:38 INFO - 'installer_path': 'installer.exe', 08:16:38 INFO - 'log_level': 'info', 08:16:38 INFO - 'log_name': 'talos', 08:16:38 INFO - 'log_to_console': True, 08:16:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:38 INFO - 'opt_config_files': (), 08:16:38 INFO - 'pip_index': False, 08:16:38 INFO - 'sps_profile': False, 08:16:38 INFO - 'sps_profile_interval': 0, 08:16:38 INFO - 'suite': 'dromaeojs', 08:16:38 INFO - 'system_bits': '32', 08:16:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:38 INFO - 'title': 'talos-linux64-ix-068', 08:16:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:38 INFO - 'use_talos_json': True, 08:16:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:38 INFO - 'work_dir': 'build'} 08:16:38 INFO - [mozharness: 2017-02-08 16:16:38.584616Z] Running clobber step. 08:16:38 INFO - Running pre-action listener: _resource_record_pre_action 08:16:38 INFO - Running main action method: clobber 08:16:38 INFO - rmtree: /builds/slave/test/build 08:16:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:39 INFO - Running post-action listener: _resource_record_post_action 08:16:39 INFO - [mozharness: 2017-02-08 16:16:39.586538Z] Finished clobber step (success) 08:16:39 INFO - [mozharness: 2017-02-08 16:16:39.586638Z] Running read-buildbot-config step. 08:16:39 INFO - Running pre-action listener: _resource_record_pre_action 08:16:39 INFO - Running main action method: read_buildbot_config 08:16:39 INFO - Using buildbot properties: 08:16:39 INFO - { 08:16:39 INFO - "project": "", 08:16:39 INFO - "product": "firefox", 08:16:39 INFO - "who": "ffxbld@noreply.mozilla.org", 08:16:39 INFO - "installer_path": "public/build/target.tar.bz2", 08:16:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:16:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:16:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:16:39 INFO - "stage_platform": "linux64-pgo", 08:16:39 INFO - "basedir": "/builds/slave/test", 08:16:39 INFO - "buildnumber": 24, 08:16:39 INFO - "platform": "ubuntu64_hw", 08:16:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:16:39 INFO - "slavebuilddir": "test", 08:16:39 INFO - "taskId": "cPje0ts8Q169CKyb1SgQRA", 08:16:39 INFO - "branch": "mozilla-central", 08:16:39 INFO - "script_repo_revision": "production", 08:16:39 INFO - "revision": "5e17f9181c6cb0968966280d1c1d96e725702af1", 08:16:39 INFO - "slavename": "talos-linux64-ix-068", 08:16:39 INFO - "repo_path": "mozilla-central" 08:16:39 INFO - } 08:16:39 INFO - Finding installer, test and symbols from parent task. 08:16:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPje0ts8Q169CKyb1SgQRA'}, attempt #1 08:16:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cPje0ts8Q169CKyb1SgQRA'}, attempt #1 08:16:40 INFO - Task dependencies: ahiRiLMvRo6roo8vRbjexg 08:16:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg'}, attempt #1 08:16:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 08:16:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/test_packages.json 08:16:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.crashreporter-symbols.zip 08:16:41 INFO - Running post-action listener: _resource_record_post_action 08:16:41 INFO - [mozharness: 2017-02-08 16:16:41.115402Z] Finished read-buildbot-config step (success) 08:16:41 INFO - [mozharness: 2017-02-08 16:16:41.115621Z] Running download-and-extract step. 08:16:41 INFO - Running pre-action listener: _resource_record_pre_action 08:16:41 INFO - Running main action method: download_and_extract 08:16:41 INFO - mkdir: /builds/slave/test/build/tests 08:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:41 INFO - trying https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.test_packages.json 08:16:41 INFO - Downloading https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:16:41 INFO - Downloaded 896 bytes. 08:16:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:16:41 INFO - Using the following test package requirements: 08:16:41 INFO - {u'common': [u'target.common.tests.zip'], 08:16:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:16:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:16:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:16:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:16:41 INFO - u'mozbase': [u'target.common.tests.zip'], 08:16:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:16:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:16:41 INFO - u'web-platform': [u'target.common.tests.zip', 08:16:41 INFO - u'target.web-platform.tests.zip'], 08:16:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:16:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:16:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip 08:16:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip into memory 08:16:42 INFO - Expected file size: 42423350 08:16:42 INFO - Obtained file size: 42423350 08:16:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:16:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip 08:16:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:16:46 INFO - Fetch https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.common.tests.zip into memory 08:16:47 INFO - Expected file size: 42423350 08:16:47 INFO - Obtained file size: 42423350 08:16:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.talos.tests.zip 08:16:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:16:52 INFO - Fetch https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.talos.tests.zip into memory 08:16:53 INFO - Expected file size: 14403454 08:16:53 INFO - Obtained file size: 14403454 08:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:53 INFO - trying https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 08:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:16:54 INFO - Downloaded 61571168 bytes. 08:16:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 08:16:54 INFO - mkdir: /builds/slave/test/properties 08:16:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:54 INFO - Contents: 08:16:54 INFO - build_url:https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 08:16:54 INFO - Running post-action listener: _resource_record_post_action 08:16:54 INFO - Running post-action listener: set_extra_try_arguments 08:16:54 INFO - [mozharness: 2017-02-08 16:16:54.821089Z] Finished download-and-extract step (success) 08:16:54 INFO - [mozharness: 2017-02-08 16:16:54.821186Z] Running populate-webroot step. 08:16:54 INFO - Running pre-action listener: _resource_record_pre_action 08:16:54 INFO - Running main action method: populate_webroot 08:16:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:54 INFO - '--tppagecycles', 08:16:54 INFO - '7'], 08:16:54 INFO - 'tests': ['tsvgm']}}, 08:16:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:54 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:54 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['damp', 'tps']}, 08:16:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'tests': ['damp', 'tps']}, 08:16:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['dromaeo_dom']}, 08:16:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['basic_compositor_video']}, 08:16:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['a11yr', 08:16:54 INFO - 'ts_paint', 08:16:54 INFO - 'tpaint', 08:16:54 INFO - 'sessionrestore', 08:16:54 INFO - 'sessionrestore_no_auto_restore', 08:16:54 INFO - 'tabpaint']}, 08:16:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['tsvgx', 08:16:54 INFO - 'tsvgr_opacity', 08:16:54 INFO - 'tart', 08:16:54 INFO - 'tscrollx', 08:16:54 INFO - 'cart', 08:16:54 INFO - 'tsvg_static']}, 08:16:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:54 INFO - 'tsvgr_opacity', 08:16:54 INFO - 'tart', 08:16:54 INFO - 'tscrollx', 08:16:54 INFO - 'cart', 08:16:54 INFO - 'tsvg_static']}, 08:16:54 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'talos_options': ['--disable-e10s'], 08:16:54 INFO - 'tests': ['tp5o']}, 08:16:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:16:54 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'talos_options': ['--disable-e10s', 08:16:54 INFO - '--xperf_path', 08:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:54 INFO - 'tests': ['tp5n']}, 08:16:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:16:54 INFO - 'talos_options': ['--xperf_path', 08:16:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:54 INFO - 'tests': ['tp5n']}}, 08:16:54 INFO - 'talos.zip': {'path': '', 08:16:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:54 INFO - Running post-action listener: _resource_record_post_action 08:16:54 INFO - [mozharness: 2017-02-08 16:16:54.834432Z] Finished populate-webroot step (success) 08:16:54 INFO - [mozharness: 2017-02-08 16:16:54.834525Z] Running create-virtualenv step. 08:16:54 INFO - Running pre-action listener: _resource_record_pre_action 08:16:54 INFO - Running main action method: create_virtualenv 08:16:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:16:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:54 INFO - Using real prefix '/usr' 08:16:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:57 INFO - Installing pip.................done. 08:16:57 INFO - Return code: 0 08:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:57 INFO - Reading from file tmpfile_stdout 08:16:57 INFO - Output received: 08:16:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:16:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:57 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:16:57 INFO - Using env: {'DISPLAY': ':0', 08:16:57 INFO - 'HOME': '/home/cltbld', 08:16:57 INFO - 'LANG': 'en_US.UTF-8', 08:16:57 INFO - 'LANGUAGE': 'en_US:en', 08:16:57 INFO - 'LOGNAME': 'cltbld', 08:16:57 INFO - 'MAIL': '/var/mail/cltbld', 08:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:57 INFO - 'MOZ_NO_REMOTE': '1', 08:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:57 INFO - 'NO_EM_RESTART': '1', 08:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:57 INFO - 'PWD': '/builds/slave/test', 08:16:57 INFO - 'SHELL': '/bin/bash', 08:16:57 INFO - 'SHLVL': '1', 08:16:57 INFO - 'TERM': 'linux', 08:16:57 INFO - 'TMOUT': '86400', 08:16:57 INFO - 'USER': 'cltbld', 08:16:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:57 INFO - '_': '/tools/buildbot/bin/python'} 08:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:16:57 INFO - Cleaning up... 08:16:57 INFO - Return code: 0 08:16:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:57 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:16:57 INFO - Using env: {'DISPLAY': ':0', 08:16:57 INFO - 'HOME': '/home/cltbld', 08:16:57 INFO - 'LANG': 'en_US.UTF-8', 08:16:57 INFO - 'LANGUAGE': 'en_US:en', 08:16:57 INFO - 'LOGNAME': 'cltbld', 08:16:57 INFO - 'MAIL': '/var/mail/cltbld', 08:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:57 INFO - 'MOZ_NO_REMOTE': '1', 08:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:57 INFO - 'NO_EM_RESTART': '1', 08:16:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:57 INFO - 'PWD': '/builds/slave/test', 08:16:57 INFO - 'SHELL': '/bin/bash', 08:16:57 INFO - 'SHLVL': '1', 08:16:57 INFO - 'TERM': 'linux', 08:16:57 INFO - 'TMOUT': '86400', 08:16:57 INFO - 'USER': 'cltbld', 08:16:57 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:57 INFO - '_': '/tools/buildbot/bin/python'} 08:16:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:58 INFO - Downloading/unpacking psutil>=3.1.1 08:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:00 INFO - Installing collected packages: psutil 08:17:00 INFO - Running setup.py install for psutil 08:17:00 INFO - building 'psutil._psutil_linux' extension 08:17:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:17:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:17:00 INFO - building 'psutil._psutil_posix' extension 08:17:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:17:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:17:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:17:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:17:00 INFO - Successfully installed psutil 08:17:00 INFO - Cleaning up... 08:17:00 INFO - Return code: 0 08:17:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:00 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:17:00 INFO - Using env: {'DISPLAY': ':0', 08:17:00 INFO - 'HOME': '/home/cltbld', 08:17:00 INFO - 'LANG': 'en_US.UTF-8', 08:17:00 INFO - 'LANGUAGE': 'en_US:en', 08:17:00 INFO - 'LOGNAME': 'cltbld', 08:17:00 INFO - 'MAIL': '/var/mail/cltbld', 08:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:00 INFO - 'MOZ_NO_REMOTE': '1', 08:17:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:00 INFO - 'NO_EM_RESTART': '1', 08:17:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:00 INFO - 'PWD': '/builds/slave/test', 08:17:00 INFO - 'SHELL': '/bin/bash', 08:17:00 INFO - 'SHLVL': '1', 08:17:00 INFO - 'TERM': 'linux', 08:17:00 INFO - 'TMOUT': '86400', 08:17:00 INFO - 'USER': 'cltbld', 08:17:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:00 INFO - '_': '/tools/buildbot/bin/python'} 08:17:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:17:03 INFO - Installing collected packages: mozsystemmonitor 08:17:03 INFO - Running setup.py install for mozsystemmonitor 08:17:03 INFO - Successfully installed mozsystemmonitor 08:17:03 INFO - Cleaning up... 08:17:03 INFO - Return code: 0 08:17:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:17:03 INFO - Using env: {'DISPLAY': ':0', 08:17:03 INFO - 'HOME': '/home/cltbld', 08:17:03 INFO - 'LANG': 'en_US.UTF-8', 08:17:03 INFO - 'LANGUAGE': 'en_US:en', 08:17:03 INFO - 'LOGNAME': 'cltbld', 08:17:03 INFO - 'MAIL': '/var/mail/cltbld', 08:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:03 INFO - 'MOZ_NO_REMOTE': '1', 08:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:03 INFO - 'NO_EM_RESTART': '1', 08:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:03 INFO - 'PWD': '/builds/slave/test', 08:17:03 INFO - 'SHELL': '/bin/bash', 08:17:03 INFO - 'SHLVL': '1', 08:17:03 INFO - 'TERM': 'linux', 08:17:03 INFO - 'TMOUT': '86400', 08:17:03 INFO - 'USER': 'cltbld', 08:17:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:03 INFO - '_': '/tools/buildbot/bin/python'} 08:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:17:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:17:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:17:05 INFO - warning: no files found matching '*.txt' 08:17:05 INFO - no previously-included directories found matching 'build' 08:17:05 INFO - no previously-included directories found matching 'dist' 08:17:05 INFO - no previously-included directories found matching '.git*' 08:17:05 INFO - Installing collected packages: jsonschema, functools32 08:17:05 INFO - Running setup.py install for functools32 08:17:05 INFO - warning: no files found matching '*.txt' 08:17:05 INFO - no previously-included directories found matching 'build' 08:17:05 INFO - no previously-included directories found matching 'dist' 08:17:05 INFO - no previously-included directories found matching '.git*' 08:17:05 INFO - Successfully installed jsonschema functools32 08:17:05 INFO - Cleaning up... 08:17:05 INFO - Return code: 0 08:17:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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', '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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:17: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 functools32==3.2.3-2 08:17:05 INFO - Using env: {'DISPLAY': ':0', 08:17:05 INFO - 'HOME': '/home/cltbld', 08:17:05 INFO - 'LANG': 'en_US.UTF-8', 08:17:05 INFO - 'LANGUAGE': 'en_US:en', 08:17:05 INFO - 'LOGNAME': 'cltbld', 08:17:05 INFO - 'MAIL': '/var/mail/cltbld', 08:17:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:05 INFO - 'MOZ_NO_REMOTE': '1', 08:17:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:05 INFO - 'NO_EM_RESTART': '1', 08:17:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:05 INFO - 'PWD': '/builds/slave/test', 08:17:05 INFO - 'SHELL': '/bin/bash', 08:17:05 INFO - 'SHLVL': '1', 08:17:05 INFO - 'TERM': 'linux', 08:17:05 INFO - 'TMOUT': '86400', 08:17:05 INFO - 'USER': 'cltbld', 08:17:05 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:05 INFO - '_': '/tools/buildbot/bin/python'} 08:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:17:06 INFO - Cleaning up... 08:17:06 INFO - Return code: 0 08:17:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:17:06 INFO - Using env: {'DISPLAY': ':0', 08:17:06 INFO - 'HOME': '/home/cltbld', 08:17:06 INFO - 'LANG': 'en_US.UTF-8', 08:17:06 INFO - 'LANGUAGE': 'en_US:en', 08:17:06 INFO - 'LOGNAME': 'cltbld', 08:17:06 INFO - 'MAIL': '/var/mail/cltbld', 08:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:06 INFO - 'MOZ_NO_REMOTE': '1', 08:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:06 INFO - 'NO_EM_RESTART': '1', 08:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:06 INFO - 'PWD': '/builds/slave/test', 08:17:06 INFO - 'SHELL': '/bin/bash', 08:17:06 INFO - 'SHLVL': '1', 08:17:06 INFO - 'TERM': 'linux', 08:17:06 INFO - 'TMOUT': '86400', 08:17:06 INFO - 'USER': 'cltbld', 08:17:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:06 INFO - '_': '/tools/buildbot/bin/python'} 08:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:08 INFO - Downloading blobuploader-1.2.4.tar.gz 08:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:17:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17: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 08:17:09 INFO - Downloading docopt-0.6.1.tar.gz 08:17:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:17:09 INFO - Installing collected packages: blobuploader, requests, docopt 08:17:09 INFO - Running setup.py install for blobuploader 08:17:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:17:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:17:09 INFO - Running setup.py install for requests 08:17:09 INFO - Running setup.py install for docopt 08:17:09 INFO - Successfully installed blobuploader requests docopt 08:17:09 INFO - Cleaning up... 08:17:09 INFO - Return code: 0 08:17:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:09 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:09 INFO - Using env: {'DISPLAY': ':0', 08:17:09 INFO - 'HOME': '/home/cltbld', 08:17:09 INFO - 'LANG': 'en_US.UTF-8', 08:17:09 INFO - 'LANGUAGE': 'en_US:en', 08:17:09 INFO - 'LOGNAME': 'cltbld', 08:17:09 INFO - 'MAIL': '/var/mail/cltbld', 08:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:09 INFO - 'MOZ_NO_REMOTE': '1', 08:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:09 INFO - 'NO_EM_RESTART': '1', 08:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:09 INFO - 'PWD': '/builds/slave/test', 08:17:09 INFO - 'SHELL': '/bin/bash', 08:17:09 INFO - 'SHLVL': '1', 08:17:09 INFO - 'TERM': 'linux', 08:17:09 INFO - 'TMOUT': '86400', 08:17:09 INFO - 'USER': 'cltbld', 08:17:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:09 INFO - '_': '/tools/buildbot/bin/python'} 08:17:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:10 INFO - Running setup.py (path:/tmp/pip-7PJOJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:10 INFO - Running setup.py (path:/tmp/pip-LOciuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:10 INFO - Running setup.py (path:/tmp/pip-orQsI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:10 INFO - Running setup.py (path:/tmp/pip-AE9Xa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:10 INFO - Running setup.py (path:/tmp/pip-FQwCw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:10 INFO - Running setup.py (path:/tmp/pip-FjIOZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:10 INFO - Running setup.py (path:/tmp/pip-HMa7U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:10 INFO - Running setup.py (path:/tmp/pip-pF6lDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:10 INFO - Running setup.py (path:/tmp/pip-p4g44L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:10 INFO - Running setup.py (path:/tmp/pip-z64u3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:10 INFO - Running setup.py (path:/tmp/pip-RCFoiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:10 INFO - Running setup.py (path:/tmp/pip-sjSERz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:10 INFO - Running setup.py (path:/tmp/pip-IiXGEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:10 INFO - Running setup.py (path:/tmp/pip-CnOnDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:11 INFO - Running setup.py (path:/tmp/pip-97SRO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:11 INFO - Running setup.py (path:/tmp/pip-d5weF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:11 INFO - Running setup.py (path:/tmp/pip-7TfOnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:17:11 INFO - Running setup.py install for manifestparser 08:17:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozcrash 08:17:11 INFO - Running setup.py install for mozdebug 08:17:11 INFO - Running setup.py install for mozdevice 08:17:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozfile 08:17:11 INFO - Running setup.py install for mozhttpd 08:17:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozinfo 08:17:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:17:11 INFO - Running setup.py install for mozInstall 08:17:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozleak 08:17:12 INFO - Running setup.py install for mozlog 08:17:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for moznetwork 08:17:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozprocess 08:17:12 INFO - Running setup.py install for mozprofile 08:17:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozrunner 08:17:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:17:12 INFO - Running setup.py install for mozscreenshot 08:17:12 INFO - Running setup.py install for moztest 08:17:12 INFO - Running setup.py install for mozversion 08:17:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:17:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:17:13 INFO - Cleaning up... 08:17:13 INFO - Return code: 0 08:17:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:13 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:17:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:13 INFO - Using env: {'DISPLAY': ':0', 08:17:13 INFO - 'HOME': '/home/cltbld', 08:17:13 INFO - 'LANG': 'en_US.UTF-8', 08:17:13 INFO - 'LANGUAGE': 'en_US:en', 08:17:13 INFO - 'LOGNAME': 'cltbld', 08:17:13 INFO - 'MAIL': '/var/mail/cltbld', 08:17:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:13 INFO - 'MOZ_NO_REMOTE': '1', 08:17:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:13 INFO - 'NO_EM_RESTART': '1', 08:17:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:13 INFO - 'PWD': '/builds/slave/test', 08:17:13 INFO - 'SHELL': '/bin/bash', 08:17:13 INFO - 'SHLVL': '1', 08:17:13 INFO - 'TERM': 'linux', 08:17:13 INFO - 'TMOUT': '86400', 08:17:13 INFO - 'USER': 'cltbld', 08:17:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:13 INFO - '_': '/tools/buildbot/bin/python'} 08:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:17:13 INFO - Running setup.py (path:/tmp/pip-qisJyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:13 INFO - Running setup.py (path:/tmp/pip-KdZL4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:13 INFO - Running setup.py (path:/tmp/pip-IEVGIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:13 INFO - Running setup.py (path:/tmp/pip-gm2_r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:13 INFO - Running setup.py (path:/tmp/pip-YsfSlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:13 INFO - Running setup.py (path:/tmp/pip-Bc2b8k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:13 INFO - Running setup.py (path:/tmp/pip-fkiqwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:13 INFO - Running setup.py (path:/tmp/pip-2ytkjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:13 INFO - Running setup.py (path:/tmp/pip-FrNcqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:17:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:13 INFO - Running setup.py (path:/tmp/pip-Qbx3KS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:14 INFO - Running setup.py (path:/tmp/pip-DRRJMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:14 INFO - Running setup.py (path:/tmp/pip-BRCrAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:14 INFO - Running setup.py (path:/tmp/pip-LbN2Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:14 INFO - Running setup.py (path:/tmp/pip-07w88g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:14 INFO - Running setup.py (path:/tmp/pip-RZXl_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:14 INFO - Running setup.py (path:/tmp/pip-4iyMWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:17:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:14 INFO - Running setup.py (path:/tmp/pip-mrsyig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:16 INFO - Downloading blessings-1.6.tar.gz 08:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:16 INFO - Installing collected packages: blessings 08:17:16 INFO - Running setup.py install for blessings 08:17:16 INFO - Successfully installed blessings 08:17:16 INFO - Cleaning up... 08:17:16 INFO - Return code: 0 08:17:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:17 INFO - Reading from file tmpfile_stdout 08:17:17 INFO - Current package versions: 08:17:17 INFO - argparse == 1.2.1 08:17:17 INFO - blessings == 1.6 08:17:17 INFO - blobuploader == 1.2.4 08:17:17 INFO - docopt == 0.6.1 08:17:17 INFO - functools32 == 3.2.3-2 08:17:17 INFO - jsonschema == 2.5.1 08:17:17 INFO - manifestparser == 1.1 08:17:17 INFO - mozInstall == 1.12 08:17:17 INFO - mozcrash == 1.0 08:17:17 INFO - mozdebug == 0.1 08:17:17 INFO - mozdevice == 0.49 08:17:17 INFO - mozfile == 1.2 08:17:17 INFO - mozhttpd == 0.7 08:17:17 INFO - mozinfo == 0.9 08:17:17 INFO - mozleak == 0.1 08:17:17 INFO - mozlog == 3.4 08:17:17 INFO - moznetwork == 0.27 08:17:17 INFO - mozprocess == 0.24 08:17:17 INFO - mozprofile == 0.28 08:17:17 INFO - mozrunner == 6.13 08:17:17 INFO - mozscreenshot == 0.1 08:17:17 INFO - mozsystemmonitor == 0.3 08:17:17 INFO - moztest == 0.8 08:17:17 INFO - mozversion == 1.4 08:17:17 INFO - psutil == 3.1.1 08:17:17 INFO - requests == 1.2.3 08:17:17 INFO - wsgiref == 0.1.2 08:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:17 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:17:17 INFO - Using env: {'DISPLAY': ':0', 08:17:17 INFO - 'HOME': '/home/cltbld', 08:17:17 INFO - 'LANG': 'en_US.UTF-8', 08:17:17 INFO - 'LANGUAGE': 'en_US:en', 08:17:17 INFO - 'LOGNAME': 'cltbld', 08:17:17 INFO - 'MAIL': '/var/mail/cltbld', 08:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:17 INFO - 'MOZ_NO_REMOTE': '1', 08:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:17 INFO - 'NO_EM_RESTART': '1', 08:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:17 INFO - 'PWD': '/builds/slave/test', 08:17:17 INFO - 'SHELL': '/bin/bash', 08:17:17 INFO - 'SHLVL': '1', 08:17:17 INFO - 'TERM': 'linux', 08:17:17 INFO - 'TMOUT': '86400', 08:17:17 INFO - 'USER': 'cltbld', 08:17:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:17 INFO - '_': '/tools/buildbot/bin/python'} 08:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:17:17 INFO - Cleaning up... 08:17:17 INFO - Return code: 0 08:17:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17: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')]} 08:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17: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')]} 08:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:17 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 0xe1c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfe8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x118dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:17 INFO - Using env: {'DISPLAY': ':0', 08:17:17 INFO - 'HOME': '/home/cltbld', 08:17:17 INFO - 'LANG': 'en_US.UTF-8', 08:17:17 INFO - 'LANGUAGE': 'en_US:en', 08:17:17 INFO - 'LOGNAME': 'cltbld', 08:17:17 INFO - 'MAIL': '/var/mail/cltbld', 08:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:17 INFO - 'MOZ_NO_REMOTE': '1', 08:17:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:17 INFO - 'NO_EM_RESTART': '1', 08:17:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:17 INFO - 'PWD': '/builds/slave/test', 08:17:17 INFO - 'SHELL': '/bin/bash', 08:17:17 INFO - 'SHLVL': '1', 08:17:17 INFO - 'TERM': 'linux', 08:17:17 INFO - 'TMOUT': '86400', 08:17:17 INFO - 'USER': 'cltbld', 08:17:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:17 INFO - '_': '/tools/buildbot/bin/python'} 08:17:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:17 INFO - Cleaning up... 08:17:17 INFO - Return code: 0 08:17:17 INFO - Running post-action listener: _resource_record_post_action 08:17:17 INFO - Running post-action listener: _start_resource_monitoring 08:17:17 INFO - Starting resource monitoring. 08:17:17 INFO - [mozharness: 2017-02-08 16:17:17.551411Z] Finished create-virtualenv step (success) 08:17:17 INFO - [mozharness: 2017-02-08 16:17:17.551995Z] Running install step. 08:17:17 INFO - Running pre-action listener: _resource_record_pre_action 08:17:17 INFO - Running main action method: install 08:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:17 INFO - Reading from file tmpfile_stdout 08:17:17 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:17 INFO - Reading from file tmpfile_stdout 08:17:17 INFO - Output received: 08:17:17 INFO - Usage: mozinstall [options] installer 08:17:17 INFO - Options: 08:17:17 INFO - -h, --help show this help message and exit 08:17:17 INFO - -d DEST, --destination=DEST 08:17:17 INFO - Directory to install application into. [default: 08:17:17 INFO - "/builds/slave/test"] 08:17:17 INFO - --app=APP Application being installed. [default: firefox] 08:17:17 INFO - mkdir: /builds/slave/test/build/application 08:17:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:17:35 INFO - Reading from file tmpfile_stdout 08:17:35 INFO - Output received: 08:17:35 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:35 INFO - Running post-action listener: _resource_record_post_action 08:17:35 INFO - [mozharness: 2017-02-08 16:17:35.326071Z] Finished install step (success) 08:17:35 INFO - [mozharness: 2017-02-08 16:17:35.326208Z] Running run-tests step. 08:17:35 INFO - Running pre-action listener: _resource_record_pre_action 08:17:35 INFO - Running main action method: run_tests 08:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:35 INFO - Python 2.7.3 08:17:35 INFO - Return code: 0 08:17:35 INFO - grabbing minidump binary from tooltool 08:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:35 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 0x118b3f0>, '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 0x118bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x118c1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:17:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:17:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:17:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:35 INFO - Return code: 0 08:17:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:17:35 INFO - Using env: {'DISPLAY': ':0', 08:17:35 INFO - 'HOME': '/home/cltbld', 08:17:35 INFO - 'LANG': 'en_US.UTF-8', 08:17:35 INFO - 'LANGUAGE': 'en_US:en', 08:17:35 INFO - 'LOGNAME': 'cltbld', 08:17:35 INFO - 'MAIL': '/var/mail/cltbld', 08:17:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:35 INFO - 'MOZ_NO_REMOTE': '1', 08:17:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:35 INFO - 'NO_EM_RESTART': '1', 08:17:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:35 INFO - 'PWD': '/builds/slave/test', 08:17:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:35 INFO - 'SHELL': '/bin/bash', 08:17:35 INFO - 'SHLVL': '1', 08:17:35 INFO - 'TERM': 'linux', 08:17:35 INFO - 'TMOUT': '86400', 08:17:35 INFO - 'USER': 'cltbld', 08:17:35 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190', 08:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:35 INFO - '_': '/tools/buildbot/bin/python'} 08:17:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:17:35 INFO - mozversion application_buildid: 20170208151920 08:17:35 INFO - mozversion application_changeset: 5e17f9181c6cb0968966280d1c1d96e725702af1 08:17:35 INFO - mozversion application_display_name: Nightly 08:17:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:35 INFO - mozversion application_name: Firefox 08:17:35 INFO - mozversion application_remotingname: firefox 08:17:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:17:35 INFO - mozversion application_vendor: Mozilla 08:17:35 INFO - mozversion application_version: 54.0a1 08:17:35 INFO - mozversion platform_buildid: 20170208151920 08:17:35 INFO - mozversion platform_changeset: 5e17f9181c6cb0968966280d1c1d96e725702af1 08:17:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:17:35 INFO - mozversion platform_version: 54.0a1 08:17:35 INFO - using testdate: 1486570655 08:17:35 INFO - actual date: 1486570655 08:17:35 INFO - starting webserver on 'localhost:37401' 08:17:35 INFO - SUITE-START | Running 2 tests 08:17:35 INFO - TEST-START | dromaeo_css 08:17:35 INFO - operating with platform_type : linux_ 08:17:35 INFO - Initialising browser for dromaeo_css test... 08:17:35 INFO - TEST-INFO | started process 5994 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeHF0B/profile http://localhost:37401/getInfo.html) 08:17:38 INFO - PROCESS | 5994 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:17:39 INFO - PROCESS | 5994 | __metrics Screen width/height:1600/1200 08:17:39 INFO - PROCESS | 5994 | colorDepth:24 08:17:39 INFO - PROCESS | 5994 | Browser inner width/height: 1024/697 08:17:39 INFO - PROCESS | 5994 | __metrics 08:17:40 INFO - PROCESS | 5994 | 1486570660275 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:17:40 INFO - PROCESS | 5994 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:17:40 INFO - PROCESS | 5994 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:41 INFO - TEST-INFO | 5994: exit 0 08:17:41 INFO - Browser initialized. 08:17:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:41 INFO - TEST-INFO | started process 6079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFeHF0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:53 INFO - PROCESS | 6079 | RSS: Main: 149049344 08:17:53 INFO - PROCESS | 6079 | 08:20:54 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37401/tests/dromaeo/cssquery-ext.html) 08:20:56 INFO - PROCESS | 6079 | RSS: Main: 275050496 08:20:56 INFO - PROCESS | 6079 | 08:22:42 INFO - PROCESS | 6079 | ************************* 08:22:42 INFO - PROCESS | 6079 | A coding exception was thrown and uncaught in a Task. 08:22:42 INFO - PROCESS | 6079 | 08:22:42 ERROR - PROCESS | 6079 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:22:42 INFO - PROCESS | 6079 | Full stack: 08:22:42 INFO - PROCESS | 6079 | ************************* 08:23:58 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-ext.html (next: http://localhost:37401/tests/dromaeo/cssquery-jquery.html) 08:23:59 INFO - PROCESS | 6079 | RSS: Main: 237821952 08:23:59 INFO - PROCESS | 6079 | 08:27:01 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37401/tests/dromaeo/cssquery-mootools.html) 08:27:01 INFO - PROCESS | 6079 | RSS: Main: 219103232 08:27:01 INFO - PROCESS | 6079 | 08:30:03 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37401/tests/dromaeo/cssquery-prototype.html) 08:30:04 INFO - PROCESS | 6079 | RSS: Main: 234098688 08:30:04 INFO - PROCESS | 6079 | 08:33:07 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37401/tests/dromaeo/cssquery-yui.html) 08:33:07 INFO - PROCESS | 6079 | RSS: Main: 185683968 08:33:07 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | Cycle 1(1): loaded http://localhost:37401/tests/dromaeo/cssquery-yui.html (next: http://localhost:37401/tests/dromaeo/cssquery-dojo.html) 08:36:10 INFO - PROCESS | 6079 | RSS: Main: 272891904 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | __start_tp_report 08:36:10 INFO - PROCESS | 6079 | _x_x_mozilla_page_load 08:36:10 INFO - PROCESS | 6079 | _x_x_mozilla_page_load_details 08:36:10 INFO - PROCESS | 6079 | |i|pagename|runs| 08:36:10 INFO - PROCESS | 6079 | |0;dojo.html;3137.1843320736607;3158.88943886964;3164.52532120182;3199.42410366134;3221.5006673965545;5202.661826981243;5225.3990791059;5230.555402790763;5231.633785635007;5279.788808447657;5208.140656791625;5216.973915130419;5222.138347172721;5255.684658920468;5367.624266301361;4538.591526762591;4706.3411122442885;4914.778834952418;4922.852314430573;4935.5804756595735;4625.098105869357;4926.2364333528185;4940.802367905279;4963.578095861856;4967.528084831935;4595.770211489412;4788.28175773635;4802.423709154924;4841.443234028096;4914.11545921734;4841.9031619367415;4842.15262329091;4847.5394837490385;4853.854384368475;4883.609311255126;4636.443626764776;4792.472827988919;4847.636427267969;4856.441509226449;4880.633952453544;5048.015636950796;5220.29526013987;5284.392294886099;5287.206918962148;5291.3385826771655;5698.230738850244;5711.857203569903;5712.200291959129;5717.799877004285;5726.427357264281;5529.723513824292;5719.14212868069;5766.250387449647;5771.220885180489;5772.134179873011;5207.921881171786;5276.234945932857;5306.893862122736;5308.230306605559;5386;5774.653520788766;5787.334456537468;5787.5080618147085;5791.3339965903615;5795.217645617872;5520.089185284383;5562.888742225133;5576.721163941867;5577.9163312550345;5578.748956296977;5543.45182854508;5669.603127781098;5670.943290567042;5688.857778555486;5713.885722285531;5692.316921969307;5723.6851973141875;5725.742341594639;5727.4845263926445;5740.827775166752;5537.889242215133;5587.106063029895;5689.2319536862;5692.48767610917;5695.686737229409;4385.824567017284;4395.560443955579;4395.890102747457;4404;4446.288593825037;3918.5885482024546;3929.5284565851707;3933.665638420709;3966.603339666068;3968.900777480586;5238.73806309683;5411.512963833274;5429.239906413105;5431.67409955396;5434.049041417736;5587.636803607753;5612.663240205601;5613.915791263134;5646.887062258732;5652.349979752299;5302.125149350391;5305.204219367126;5305.522502974673;5334.7065911374475;5351.983123206578;4795.328653988445;4815.903681926342;4818.807247710122;4824.179889418807;4863.562279394871;5712.685802280831;5747.511461525817;5763.510101641407;5800.6809625471005;5834.533237341003;5587.664740115606;5633.267675202197;5650.660960342392;5668.7732490701555;5702.40124786908;5819.039858423313;5853.443922827325;5858.5898987070495;5860.38465961068;5874.735636896265;5353.892922141613;5370.3287089113865;5560.165975103767;5561.833145005657;5580.972095139661;5571.331440227199;5592;5603.047481928001;5634.661920284632;5683.23276357703;5489.505944465017;5489.58828087887;5493.450654934474;5494.038543254995;5497.065498865282;5410.188471729272;5462.071447853795;5474.671519708831;5511.614187006871;5561.972190139023;5341.4925582069645;5512.6692398456225;5520.86197845041;5566.165075238585;5608;5427.565794736491;5471;5496.890062198813;5502.477264659851;5528.751206195811;5421.891562168814;5428.6199966002005;5440.891182176413;5451.972740136274;5467.58993075513 08:36:10 INFO - PROCESS | 6079 | |1;ext.html;561.9844125269364;576.3775122867306;580.4282781460262;593.902006168982;595.609875531527;32185.51721724176;43708;44584.77707611457;44621.77689111558;44659.33011004834;46046.079078418414;46539.76730116345;46540.301895471595;46580.06839863201;46626.06747865049;7736.535807851519;9125.49809760463;9305.395149315307;9322.720318390458;9330.486823224719;7701.6919323227;9906.306558540906;10076.445795481246;10082.092611664948;10320.122789562896;10993.285436446646;11076.944615276912;11084.833727494093;11086.889131108706;11087.113030957504;10946.288491248044;11001.504932278067;11034.172437067253;11040.227184097157;11046.061084807801;10830.891691083067;10846.457677116112;10871.565137394495;10886.129109671207;10900.836487452694;40446.79776601098;40499.39250911239;40543.39184912229;40758;40808.38787418191;3944.5858184890462;3982.2234664240486;4009.6343157537194;4010.1578668479656;4122.773247471388;31276;31582.526262106087;31651.36697266065;31705.682943170505;31861.84069079663;4279.957200427987;4381.298992161271;4504.459464864237;4587.7017993830295;4604.194266003469;328794;328875;330892.9999999976;331877;332659.427680125;59523.404765952655;60175.09737353943;60201.397986020456;60209.39790602038;60299.69850150721;62407.37592624016;62431.37568624256;62591.374086258555;62675.926064805644;62720;16214.432494862858;16656.333746649998;16672.666546669243;16687.08221047854;16695.332186712396;10718.624848130277;10880.510377033053;12201.633950981484;12411.131220814455;12504.499820007099;16421.261043253082;16944.745828812578;16952.101016766213;17009.744853827204;17038.74441883373;6199.969000154971;6329.3354197809485;6342.809715708536;6357.586756860789;6365.4589359904;890.8129292848445;907.6324088744069;920.5305294299956;921.8525035994343;937.6155776131753;31196;32068.358632827214;32271.838640807116;32295.192620184684;32824;963.8265112279717;1082.1342925659442;1083.3337497439018;1083.3716444462193;1099.7910397024539;15517.45688900883;15752.68494630101;16311.429099981444;16502.83497165037;16826.57933551671;437584;438509;439619;440395;441647;54128;54273.72863135659;54581.727091364286;54779.72610136924;54996;1329.2091205732575;1342.4563051963971;1379.0346757269751;1380.1167252958114;1382.0740104130257;27377.619580866965;28468.29190248592;28739.8563007192;29677.258068548457;29686;36477.63522364743;50166.74916625393;51283.74358128185;51405.7429712864;56621.71689141528;399713;400406;401455;401733;402905;23098.884505577364;23748.168814091423;26361;26420.867895660398;27013.459730805665;42731.35902961396;42876.78561607172;42945.570544294154;43059.138817224106;43125.13749724925;36361.636383636884;36481.4398200225;36800;36998.26003479969;37812;36590.08524786795;37122.8143859279;37169.81415092907;37218.25563488769;37795;33296.833515832266;33523.664763352055;33826.15434614154;33857.66142338545;34406.13984650404;30208.5468717965;32358.514622281156;32406.675933240367;32530;33025.33949321048;24546.63180052265;24668.629970550097;25134;25286.620700689138;25390.111346102796 08:36:10 INFO - PROCESS | 6079 | |2;jquery.html;421.5531536571234;429.70779869688636;434.50640363511167;439.82626862389355;441.25207772825075;18248.361307354262;18250.17874195661;19694.606107877833;19814.207431702715;19956.401307960765;20436.8978155109;20534.281300154496;20889.582208355863;21038.68441973368;21216.57566848662;5676;5907.084401917709;5914.4381283777975;5920.4671579557835;5924.111383292519;5772.509336706385;5825.359210486843;5872.324682661484;5884.411558844103;6000.309964354112;5754.367019627837;5756;5758.165066065418;5772.509336706385;5815.302163740336;5619.297587801545;5654.067078932012;5698.373178950312;5768.105943578752;5798.449147330997;5131.255967884673;5144.125498665198;5146.356705411824;5147.073526765181;5154.123798954187;23821.523569528686;24055.398615034588;24060.278191654277;24283;24302.270931872074;2650.5891586804078;2665.4802313548867;2700.9594856077174;2705.242532090998;2708.986455067712;14549.345279462344;14669.559913202622;14688.192149431778;14815.851841481555;15499;1787.2843510786788;1846.2891786662233;1873.5409824592925;1882.4164509002253;1889.6598612249788;79750;82070;82188;82665;84039.57980210122;11206.15953803468;11402.828957565644;11422.94288528552;11423.314601123959;11703.23928944616;16266.105364204846;16266.18669066542;16270.75593866093;16290.83709162917;16303.59241018984;8328.875066874001;8428.367872409593;8476.194761497647;8655;8672.956635216784;8019;8104.756857294291;8291.170882911782;8293.33653307734;8317.625706843206;7239.276072392719;7256.383207427322;7277;7371.483996120327;7440.516366436164;2005.8867328632748;2027.1688607671078;2053.910156386322;2060.3612880006945;2133.5570771466582;875.4747151708924;893.6068130022769;895.4761464543316;898.8471959766855;911.6763548940163;19634.70547941782;20680.172793088408;20718.689219661715;20779.8961005197;20959.371218863154;894.3873446689039;899.0625202688217;924.357571487823;925.6528801699362;939.492673956056;11048.779024419466;11570.247933884271;11647.6505704829;11699.88300117005;11874.34691091981;614626;615372;617566;646747;649177;87034.56482717546;87540;89350.55324723334;90045.54977225071;90160.09839901517;1102.7959827431791;1125.5947858770835;1155.4165146600913;1159.5419809175328;1161.440185830427;17396.217170227115;17525.31045833146;17903.641927161123;18074;18095.909520452315;40481.797591011855;41523.58476415197;41770.85468333646;41833.79083104687;42918.35622465603;53089;53314.20028699495;53942.19086713624;54300;54834.72582637061;7944.563049032358;8009.159038300894;8080.111187769223;8218.753437396888;8410.411271210956;12452.564160254347;12991.805122923353;13499.527516536875;13731.107478013897;13785.103968242032;10594.15246780271;11521.135914806591;11587.710307242387;11634.53461861516;12212.633620991384;6152.169457123231;10467.319624224401;12046.096542759504;12241.938790305992;12250.591182013826;12434.689132771753;12527.498900043896;12805.423755930819;12964.481420743065;13039.543615973396;7803.492772969739;8012.919870801217;8063.153368896182;8575.31397488212;8974.730758077269;8876.20114189726;10822.242443028912;11357.318560886373;11390.25963312382;12218.327991960172 08:36:10 INFO - PROCESS | 6079 | |3;mootools.html;1271.4850485553354;1409.3305679802095;1421.7938398932151;1424.64383904024;1441.264954873015;7420.109586849579;8072;8336.374771892117;8360.205780450862;8537.231649151576;8384.748457546268;8432.030316513603;8446.49321040738;8453.408261421702;8454.619542120605;1926.7687877454725;1979.5348093198088;2232.866028038323;2274.431392151962;2275.16956310947;2242.607543679858;2309.688192094071;2312.4681323295654;2323.9535209295805;2330.463993281546;2238.630625946717;2245.4049676835652;2256.379495638696;2257.977420225793;2267.761885002076;2268.1040988809327;2270.886455677218;2287.9084836606517;2292.323764489471;2294.0823670531754;2149.537849362379;2210.834187435949;2216.180013395038;2217.323716266538;2221.1892659179443;8645.65417383304;8711.34664900135;8718.782030449289;8723.520206388646;8727.694530691459;4968.105740966625;5099.71951542665;5105.540501354896;5111.795528178868;5117.513836185556;3124.5938028056435;3152.133163380066;3290.1116698491514;3318.15387076294;3380.678835510623;1417.6385021819474;1440.5390275111968;1460.7443697353026;1487.3976039703937;1525.2145145250206;11823.231489953212;11923.403829808474;11929.01774556361;11931.343776092312;11950.760984780256;4533.274676051816;4616;4620.768961551909;4673.719576825401;4697.271922851964;10020;10108.090271875566;10109;10111.848322275171;10121.797564048678;5228.346456692913;5235;5239.083160446907;5250.264962905197;5251.0548101341365;4070.816813243411;4075.38869169621;4636;4686.507916668769;4788.856334309976;3803.5055442792814;3853.5761066282685;3882.7864467453996;3900.6099390060767;3952.7233093683167;1280.5838102616501;1287.2469605281015;1293.5472584595316;1297.2800095946652;1304.8499422566335;785.0008414258685;879.1911441473859;896.9775755606162;901.715959472764;915.3592485260344;5571.8885622288135;5612.354579223442;5659.43405659439;5691.715414229355;5705.343885453143;1026.2303272545591;1034.8706411698538;1039.880413752413;1045.482486169351;1050.3225419604312;3607.5129857469433;3748.044248716614;3808.333541630204;3812.275667623143;3848.826802793881;10149.441780701985;10463.215258855464;10470.581176752845;10481.633142839964;10503.47482625881;10265.640702575374;10345.224108191916;10374.118199952938;10422.843657345145;10451.895481045092;7465.365443937326;7557.735479258199;7682.231776822273;7688.9615551923;7700.691972321157;5509.146082357241;5519.172124181405;5715.199872018004;5737.454941780524;5743.798967036134;9283.535823208678;9341.159295663423;9460.479673618018;9513.524323783644;9559.474228917476;9449.338546301693;9586.376885502421;9661.13049825519;9702;9845.178641951263;6197.5351848610635;6278.968605156945;6413.903791443226;7125.1093613298335;7273.3453989141235;7752;8093.797655058671;8146.67413303485;8168.101508834143;8188.7952801180445;7278.199398066315;7329.157146928172;7410.407167426701;7545.132309784445;7558.319751222416;7156.320149585781;7238.02286691311;7252.746153884589;7268.0914885639295;7294.088238970129;6412.871742565029;6519;6519.73921043172;6520.7391704333195;6524.934750652433;5019.924701129559;5042.571381432619;5050.646454748133;5085.593152547861;5313.203019547099;4973.129702302011;5002.724850133278;5125.820596279262;5146.794128234978;5224.216367544898 08:36:10 INFO - PROCESS | 6079 | |4;prototype.html;384.1701923844495;396.9781662008588;408.0675656125753;413.14479028411193;413.51959983259934;5198.428172900978;5229.607779416545;5265.86835329117;5287.867803304915;5363.195520671901;5027.32131162293;5159.845204643857;5197.948020519793;5202.531772140506;5216.635270250696;4093.1961606299633;4106.38404239365;4109.958900411002;4110.075233072557;4124;4123.814428350732;4134.7519148851015;4136.772477513736;4146.937795933063;4189.245935731567;3876.3604005339084;4018.658414034796;4053.5338436079933;4070.7354021988476;4102.261592913274;4021.4571032910476;4034.475518182632;4038.9999999999854;4046.5751096135073;4049;3550.2012047289154;3598.352296586613;3603.3153700797025;3603.69368603669;3608.585012723544;4829.082474329901;5044.848654540369;5046.873828154289;5063.721495317756;5066.569341605968;4663.300504924255;4699.67102302839;4710.505396933341;4725.929111063337;4731.408573928259;5489.6980666063355;5496;5500.257465242181;5511.173324001432;5530.889382212374;3875.3411919973673;3968.8412463501427;3987.8803635890968;4011.618896204885;4022.839086436539;5434.212039254286;5595.580331475156;5607.299087614048;5642.7178641067785;5689.431056894319;4084.9387259191135;4085.55058943516;4085.610892296633;4085.9182816343505;4091.6522095622204;4128.587141285848;4142.316517774533;4143.6892233082035;4150.605692459211;4167.791610419466;4465.799039043251;4555.726656400627;4629.583337499641;4684.156851766715;4686.484486706459;5515.117581186991;5519.39286678465;5527.198556209327;5529.557635389159;5539.8892022160135;1355.4239448234657;1355.8136630448357;1368.3021658954005;1368.568900796246;1381.2886363522794;918.7243826851918;949.3259785552335;971.2909576009553;973.7419583810296;978.9021097890296;5093.18509038552;5102.897942041212;5106.770195341219;5112.872178195575;5122.795088196505;5369.650972686841;5390.676559406448;5398.46015398457;5448.863778405493;5462.644928079662;4727.369057675097;5011.84964451067;5021.573166280907;5037.748112594356;5130.743462826844;2860.3850172213074;2861.7853660975093;2863.2412410711177;2882.855857207131;2894.4789937811397;5458.099413596791;5615.101583746581;5636.872625474839;5670.291213598301;5681.77272909079;5532.17017447378;5537.335519737577;5589.944100559023;5643.943560564424;5648.999999999918;5655.406182350794;5674.4892959633835;5689.288838895138;5696.886062278814;5726.0817626094895;5203.427622961395;5325.9201111982575;5388.326459192601;5437.26596909428;5456.263404440349;5313.973430132824;5337.9466205339;5341.302642165681;5354.303940487712;5431.212474191141;5696.857578560403;5789.2763404574425;5795.159701843293;5827.5629327801435;5828.271466066742;4034.9596504034585;4049.716519843583;4054.5134583850127;4072.4298598195683;4081.8571350002608;5258.631895767259;5546.694931778791;5559.833205003856;5560.944390556043;5610.681489849963;5519.862003449946;5524.585656075891;5527;5527.972360138174;5529.115341545334;5503.174523821459;5506;5509.917351239655;5516.793282686797;5532.972335138298;5231.645759408206;5509.752061157177;5514.36584792754;5541.113421852484;5547.306586676666;5555.916661250165;5562.972185139049;5574.86062848432;5578.944210557843;5583.35791383996;5210.765515551885;5438.646487978269;5446.638340414896;5453.945460545344;5461.760678121951 08:36:10 INFO - PROCESS | 6079 | |5;yui.html;738.8009917059131;740.6963145110506;779.5050143159095;814.1852692959925;864.1617630898029;14547;15416.845831541681;15988.360465581363;16002.279897404616;16247.268872900719;13418.865811341908;14672.559823205294;14799.778003329959;14828.18444985528;14837.629059273524;761.364260842196;777.1063277231173;777.4324742937658;778.8870613761002;778.9415793815458;768.2778188502817;769.7806125254303;771.463832636318;771.7067514344569;771.7221800151968;809.0493669937799;810.0198759501011;810.2626609785096;810.6797814863125;810.7891948093509;806.6128258435954;812.1188510466122;812.2567850416862;812.687115460549;812.9146439623813;592.9940700592982;597.8923793717129;597.9790707325222;598.631841417525;598.7575032112002;13459.730805383935;13746.243956582384;13792.724145517133;14680.265986700622;14860.331285092198;12677.366131693378;12692.80960785589;13082.607521774362;13242.86757132426;13278;11098.667039988813;11141.275817071864;11250.493727782188;11465.828012579817;11676.532938682443;3678.834452449646;3686.870959516431;3745.62543745626;3785.5835858055593;3789.7157713171623;70502.64748676223;70957.6452117736;71680.38072766158;74013;74816;9056;9279.211267042378;9305.90694093064;9323.300752443594;9504.287178461644;18673.346432874783;18704.345347912757;18872.528186795167;18947.62104757897;19003.71494427557;7947.4039447041705;7979.800504987305;8051.114377418479;8086.474379165335;8133.146019667968;4335.848245311399;4492;4498.347739577743;4512.097580483916;4549.6360291176625;3520.4543295789194;3590.8922732318074;3592;3625.0756057205244;3630.2739452109686;563.1749487001563;564.6753116957766;565.0845630079216;565.1898483588715;579.3366595248417;748.2517482517483;756.8032311599023;766.6741634805186;791.2325044706625;793.9563324017234;9560.378575392577;9824.4105353679;10271.794564108675;10452.177204849548;10526.31578947366;629.7512482569359;654.1234745441132;654.4731491149576;654.8657525207321;664.1863716946701;4822.95177048232;5046.318746969186;5069.949300507022;5100.413452452941;5119.948800511947;71003.28996709967;76024.23975760282;77316.61341693255;77494;77946.61026694831;41002;42220.788896055936;68971.65514172397;69790.65104674545;73514;41173.588264116974;57311;59160;60110.99999999913;60162;10390.376577405379;10951.24738620326;11008;11081.39052352096;11110.444477775916;39129;39213.607863920995;39401.40897886591;39651.215695294355;40661.79669101635;49006.5099349002;50673.49326506688;50898.491015090854;50914.74542627263;51849.22226166686;13103.541376052173;13193.934030329787;13269.270190139636;13356.599302020955;13365.198088114745;14222.715545689236;14393.352299146354;14480.275986200859;14562;14617.634559136106;11424.371659558805;11496.770064598828;11649.95150436431;12203.938980305042;14357.712845742817;13528.72942541124;13635.454581816617;13789.172649641054;14215.857841421453;14763.778543322074;13467;14203.431862725376;14494.710105797614;14741.894357923413;14745.631359216106;11702.35637039971;12083.39583020863;12259.325737084546;12384.876151238372;12447.439865205906;10901.672949811518;11008.39453830047;11014.229003969645;11964.521419143137;12004.179017930954 08:36:10 INFO - PROCESS | 6079 | __end_tp_report 08:36:10 INFO - PROCESS | 6079 | __start_cc_report 08:36:10 INFO - PROCESS | 6079 | _x_x_mozilla_cycle_collect,1167 08:36:10 INFO - PROCESS | 6079 | __end_cc_report 08:36:10 INFO - PROCESS | 6079 | __startTimestamp1486571770356__endTimestamp 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | ------- Summary: start ------- 08:36:10 INFO - PROCESS | 6079 | Number of tests: 6 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#0] dojo.html Cycles:165 Average:5254.86 Median:5440.89 stddev:571.58 (10.5%) stddev-sans-first:548.66 08:36:10 INFO - PROCESS | 6079 | Values: 3137.2 3158.9 3164.5 3199.4 3221.5 5202.7 5225.4 5230.6 5231.6 5279.8 5208.1 5217.0 5222.1 5255.7 5367.6 4538.6 4706.3 4914.8 4922.9 4935.6 4625.1 4926.2 4940.8 4963.6 4967.5 4595.8 4788.3 4802.4 4841.4 4914.1 4841.9 4842.2 4847.5 4853.9 4883.6 4636.4 4792.5 4847.6 4856.4 4880.6 5048.0 5220.3 5284.4 5287.2 5291.3 5698.2 5711.9 5712.2 5717.8 5726.4 5529.7 5719.1 5766.3 5771.2 5772.1 5207.9 5276.2 5306.9 5308.2 5386.0 5774.7 5787.3 5787.5 5791.3 5795.2 5520.1 5562.9 5576.7 5577.9 5578.7 5543.5 5669.6 5670.9 5688.9 5713.9 5692.3 5723.7 5725.7 5727.5 5740.8 5537.9 5587.1 5689.2 5692.5 5695.7 4385.8 4395.6 4395.9 4404.0 4446.3 3918.6 3929.5 3933.7 3966.6 3968.9 5238.7 5411.5 5429.2 5431.7 5434.0 5587.6 5612.7 5613.9 5646.9 5652.3 5302.1 5305.2 5305.5 5334.7 5352.0 4795.3 4815.9 4818.8 4824.2 4863.6 5712.7 5747.5 5763.5 5800.7 5834.5 5587.7 5633.3 5650.7 5668.8 5702.4 5819.0 5853.4 5858.6 5860.4 5874.7 5353.9 5370.3 5560.2 5561.8 5581.0 5571.3 5592.0 5603.0 5634.7 5683.2 5489.5 5489.6 5493.5 5494.0 5497.1 5410.2 5462.1 5474.7 5511.6 5562.0 5341.5 5512.7 5520.9 5566.2 5608.0 5427.6 5471.0 5496.9 5502.5 5528.8 5421.9 5428.6 5440.9 5452.0 5467.6 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#1] ext.html Cycles:180 Average:55117.96 Median:36535.76 stddev:103725.97 (283.9%) stddev-sans-first:103936.07 08:36:10 INFO - PROCESS | 6079 | Values: 562.0 576.4 580.4 593.9 595.6 32185.5 43708.0 44584.8 44621.8 44659.3 46046.1 46539.8 46540.3 46580.1 46626.1 7736.5 9125.5 9305.4 9322.7 9330.5 7701.7 9906.3 10076.4 10082.1 10320.1 10993.3 11076.9 11084.8 11086.9 11087.1 10946.3 11001.5 11034.2 11040.2 11046.1 10830.9 10846.5 10871.6 10886.1 10900.8 40446.8 40499.4 40543.4 40758.0 40808.4 3944.6 3982.2 4009.6 4010.2 4122.8 31276.0 31582.5 31651.4 31705.7 31861.8 4280.0 4381.3 4504.5 4587.7 4604.2 328794.0 328875.0 330893.0 331877.0 332659.4 59523.4 60175.1 60201.4 60209.4 60299.7 62407.4 62431.4 62591.4 62675.9 62720.0 16214.4 16656.3 16672.7 16687.1 16695.3 10718.6 10880.5 12201.6 12411.1 12504.5 16421.3 16944.7 16952.1 17009.7 17038.7 6200.0 6329.3 6342.8 6357.6 6365.5 890.8 907.6 920.5 921.9 937.6 31196.0 32068.4 32271.8 32295.2 32824.0 963.8 1082.1 1083.3 1083.4 1099.8 15517.5 15752.7 16311.4 16502.8 16826.6 437584.0 438509.0 439619.0 440395.0 441647.0 54128.0 54273.7 54581.7 54779.7 54996.0 1329.2 1342.5 1379.0 1380.1 1382.1 27377.6 28468.3 28739.9 29677.3 29686.0 36477.6 50166.7 51283.7 51405.7 56621.7 399713.0 400406.0 401455.0 401733.0 402905.0 23098.9 23748.2 26361.0 26420.9 27013.5 42731.4 42876.8 42945.6 43059.1 43125.1 36361.6 36481.4 36800.0 36998.3 37812.0 36590.1 37122.8 37169.8 37218.3 37795.0 33296.8 33523.7 33826.2 33857.7 34406.1 30208.5 32358.5 32406.7 32530.0 33025.3 24546.6 24668.6 25134.0 25286.6 25390.1 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#2] jquery.html Cycles:180 Average:33049.63 Median:41802.32 stddev:102968.05 (246.3%) stddev-sans-first:103227.75 08:36:10 INFO - PROCESS | 6079 | Values: 421.6 429.7 434.5 439.8 441.3 18248.4 18250.2 19694.6 19814.2 19956.4 20436.9 20534.3 20889.6 21038.7 21216.6 5676.0 5907.1 5914.4 5920.5 5924.1 5772.5 5825.4 5872.3 5884.4 6000.3 5754.4 5756.0 5758.2 5772.5 5815.3 5619.3 5654.1 5698.4 5768.1 5798.4 5131.3 5144.1 5146.4 5147.1 5154.1 23821.5 24055.4 24060.3 24283.0 24302.3 2650.6 2665.5 2701.0 2705.2 2709.0 14549.3 14669.6 14688.2 14815.9 15499.0 1787.3 1846.3 1873.5 1882.4 1889.7 79750.0 82070.0 82188.0 82665.0 84039.6 11206.2 11402.8 11422.9 11423.3 11703.2 16266.1 16266.2 16270.8 16290.8 16303.6 8328.9 8428.4 8476.2 8655.0 8673.0 8019.0 8104.8 8291.2 8293.3 8317.6 7239.3 7256.4 7277.0 7371.5 7440.5 2005.9 2027.2 2053.9 2060.4 2133.6 875.5 893.6 895.5 898.8 911.7 19634.7 20680.2 20718.7 20779.9 20959.4 894.4 899.1 924.4 925.7 939.5 11048.8 11570.2 11647.7 11699.9 11874.3 614626.0 615372.0 617566.0 646747.0 649177.0 87034.6 87540.0 89350.6 90045.5 90160.1 1102.8 1125.6 1155.4 1159.5 1161.4 17396.2 17525.3 17903.6 18074.0 18095.9 40481.8 41523.6 41770.9 41833.8 42918.4 53089.0 53314.2 53942.2 54300.0 54834.7 7944.6 8009.2 8080.1 8218.8 8410.4 12452.6 12991.8 13499.5 13731.1 13785.1 10594.2 11521.1 11587.7 11634.5 12212.6 6152.2 10467.3 12046.1 12241.9 12250.6 12434.7 12527.5 12805.4 12964.5 13039.5 7803.5 8012.9 8063.2 8575.3 8974.7 8876.2 10822.2 11357.3 11390.3 12218.3 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#3] mootools.html Cycles:180 Average:5547.36 Median:4970.62 stddev:3117.54 (62.7%) stddev-sans-first:3109.72 08:36:10 INFO - PROCESS | 6079 | Values: 1271.5 1409.3 1421.8 1424.6 1441.3 7420.1 8072.0 8336.4 8360.2 8537.2 8384.7 8432.0 8446.5 8453.4 8454.6 1926.8 1979.5 2232.9 2274.4 2275.2 2242.6 2309.7 2312.5 2324.0 2330.5 2238.6 2245.4 2256.4 2258.0 2267.8 2268.1 2270.9 2287.9 2292.3 2294.1 2149.5 2210.8 2216.2 2217.3 2221.2 8645.7 8711.3 8718.8 8723.5 8727.7 4968.1 5099.7 5105.5 5111.8 5117.5 3124.6 3152.1 3290.1 3318.2 3380.7 1417.6 1440.5 1460.7 1487.4 1525.2 11823.2 11923.4 11929.0 11931.3 11950.8 4533.3 4616.0 4620.8 4673.7 4697.3 10020.0 10108.1 10109.0 10111.8 10121.8 5228.3 5235.0 5239.1 5250.3 5251.1 4070.8 4075.4 4636.0 4686.5 4788.9 3803.5 3853.6 3882.8 3900.6 3952.7 1280.6 1287.2 1293.5 1297.3 1304.8 785.0 879.2 897.0 901.7 915.4 5571.9 5612.4 5659.4 5691.7 5705.3 1026.2 1034.9 1039.9 1045.5 1050.3 3607.5 3748.0 3808.3 3812.3 3848.8 10149.4 10463.2 10470.6 10481.6 10503.5 10265.6 10345.2 10374.1 10422.8 10451.9 7465.4 7557.7 7682.2 7689.0 7700.7 5509.1 5519.2 5715.2 5737.5 5743.8 9283.5 9341.2 9460.5 9513.5 9559.5 9449.3 9586.4 9661.1 9702.0 9845.2 6197.5 6279.0 6413.9 7125.1 7273.3 7752.0 8093.8 8146.7 8168.1 8188.8 7278.2 7329.2 7410.4 7545.1 7558.3 7156.3 7238.0 7252.7 7268.1 7294.1 6412.9 6519.0 6519.7 6520.7 6524.9 5019.9 5042.6 5050.6 5085.6 5313.2 4973.1 5002.7 5125.8 5146.8 5224.2 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#4] prototype.html Cycles:180 Average:4584.60 Median:5207.10 stddev:1326.40 (25.5%) stddev-sans-first:1292.11 08:36:10 INFO - PROCESS | 6079 | Values: 384.2 397.0 408.1 413.1 413.5 5198.4 5229.6 5265.9 5287.9 5363.2 5027.3 5159.8 5197.9 5202.5 5216.6 4093.2 4106.4 4110.0 4110.1 4124.0 4123.8 4134.8 4136.8 4146.9 4189.2 3876.4 4018.7 4053.5 4070.7 4102.3 4021.5 4034.5 4039.0 4046.6 4049.0 3550.2 3598.4 3603.3 3603.7 3608.6 4829.1 5044.8 5046.9 5063.7 5066.6 4663.3 4699.7 4710.5 4725.9 4731.4 5489.7 5496.0 5500.3 5511.2 5530.9 3875.3 3968.8 3987.9 4011.6 4022.8 5434.2 5595.6 5607.3 5642.7 5689.4 4084.9 4085.6 4085.6 4085.9 4091.7 4128.6 4142.3 4143.7 4150.6 4167.8 4465.8 4555.7 4629.6 4684.2 4686.5 5515.1 5519.4 5527.2 5529.6 5539.9 1355.4 1355.8 1368.3 1368.6 1381.3 918.7 949.3 971.3 973.7 978.9 5093.2 5102.9 5106.8 5112.9 5122.8 5369.7 5390.7 5398.5 5448.9 5462.6 4727.4 5011.8 5021.6 5037.7 5130.7 2860.4 2861.8 2863.2 2882.9 2894.5 5458.1 5615.1 5636.9 5670.3 5681.8 5532.2 5537.3 5589.9 5643.9 5649.0 5655.4 5674.5 5689.3 5696.9 5726.1 5203.4 5325.9 5388.3 5437.3 5456.3 5314.0 5337.9 5341.3 5354.3 5431.2 5696.9 5789.3 5795.2 5827.6 5828.3 4035.0 4049.7 4054.5 4072.4 4081.9 5258.6 5546.7 5559.8 5560.9 5610.7 5519.9 5524.6 5527.0 5528.0 5529.1 5503.2 5506.0 5509.9 5516.8 5533.0 5231.6 5509.8 5514.4 5541.1 5547.3 5555.9 5563.0 5574.9 5578.9 5583.4 5210.8 5438.6 5446.6 5453.9 5461.8 08:36:10 INFO - PROCESS | 6079 | 08:36:10 INFO - PROCESS | 6079 | [#5] yui.html Cycles:180 Average:16508.20 Median:23278.32 stddev:20578.58 (88.4%) stddev-sans-first:20602.24 08:36:10 INFO - PROCESS | 6079 | Values: 738.8 740.7 779.5 814.2 864.2 14547.0 15416.8 15988.4 16002.3 16247.3 13418.9 14672.6 14799.8 14828.2 14837.6 761.4 777.1 777.4 778.9 778.9 768.3 769.8 771.5 771.7 771.7 809.0 810.0 810.3 810.7 810.8 806.6 812.1 812.3 812.7 812.9 593.0 597.9 598.0 598.6 598.8 13459.7 13746.2 13792.7 14680.3 14860.3 12677.4 12692.8 13082.6 13242.9 13278.0 11098.7 11141.3 11250.5 11465.8 11676.5 3678.8 3686.9 3745.6 3785.6 3789.7 70502.6 70957.6 71680.4 74013.0 74816.0 9056.0 9279.2 9305.9 9323.3 9504.3 18673.3 18704.3 18872.5 18947.6 19003.7 7947.4 7979.8 8051.1 8086.5 8133.1 4335.8 4492.0 4498.3 4512.1 4549.6 3520.5 3590.9 3592.0 3625.1 3630.3 563.2 564.7 565.1 565.2 579.3 748.3 756.8 766.7 791.2 794.0 9560.4 9824.4 10271.8 10452.2 10526.3 629.8 654.1 654.5 654.9 664.2 4823.0 5046.3 5069.9 5100.4 5119.9 71003.3 76024.2 77316.6 77494.0 77946.6 41002.0 42220.8 68971.7 69790.7 73514.0 41173.6 57311.0 59160.0 60111.0 60162.0 10390.4 10951.2 11008.0 11081.4 11110.4 39129.0 39213.6 39401.4 39651.2 40661.8 49006.5 50673.5 50898.5 50914.7 51849.2 13103.5 13193.9 13269.3 13356.6 13365.2 14222.7 14393.4 14480.3 14562.0 14617.6 11424.4 11496.8 11650.0 12203.9 14357.7 13528.7 13635.5 13789.2 14215.9 14763.8 13467.0 14203.4 14494.7 14741.9 14745.6 11702.4 12083.4 12259.3 12384.9 12447.4 10901.7 11008.4 11014.2 11964.5 12004.2 08:36:10 INFO - PROCESS | 6079 | -------- Summary: end -------- 08:36:10 INFO - PROCESS | 6079 | 08:36:11 INFO - TEST-INFO | 6079: exit 0 08:36:11 INFO - TEST-OK | dromaeo_css | took 1115583ms 08:36:11 INFO - TEST-START | kraken 08:36:11 INFO - operating with platform_type : linux_ 08:36:11 INFO - Initialising browser for kraken test... 08:36:11 INFO - TEST-INFO | started process 6382 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zLDGH/profile http://localhost:37401/getInfo.html) 08:36:14 INFO - PROCESS | 6382 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 08:36:14 INFO - PROCESS | 6382 | __metrics Screen width/height:1600/1200 08:36:14 INFO - PROCESS | 6382 | colorDepth:24 08:36:14 INFO - PROCESS | 6382 | Browser inner width/height: 1024/697 08:36:14 INFO - PROCESS | 6382 | __metrics 08:36:15 INFO - PROCESS | 6382 | 1486571775661 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 08:36:15 INFO - PROCESS | 6382 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:36:15 INFO - PROCESS | 6382 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:16 INFO - TEST-INFO | 6382: exit 0 08:36:16 INFO - Browser initialized. 08:36:16 INFO - Running cycle 1/1 for kraken test... 08:36:16 INFO - TEST-INFO | started process 6465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zLDGH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:28 INFO - PROCESS | 6465 | RSS: Main: 152285184 08:36:28 INFO - PROCESS | 6465 | 08:36:31 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37401/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:32 INFO - PROCESS | 6465 | RSS: Main: 204849152 08:36:32 INFO - PROCESS | 6465 | 08:36:34 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37401/tests/kraken/driver.html?testName=audio-dft) 08:36:35 INFO - PROCESS | 6465 | RSS: Main: 183316480 08:36:35 INFO - PROCESS | 6465 | 08:36:38 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37401/tests/kraken/driver.html?testName=audio-fft) 08:36:38 INFO - PROCESS | 6465 | RSS: Main: 265158656 08:36:38 INFO - PROCESS | 6465 | 08:36:41 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37401/tests/kraken/driver.html?testName=audio-oscillator) 08:36:41 INFO - PROCESS | 6465 | RSS: Main: 177229824 08:36:41 INFO - PROCESS | 6465 | 08:36:43 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:44 INFO - PROCESS | 6465 | RSS: Main: 180633600 08:36:44 INFO - PROCESS | 6465 | 08:36:47 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37401/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:48 INFO - PROCESS | 6465 | RSS: Main: 219348992 08:36:48 INFO - PROCESS | 6465 | 08:36:51 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37401/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:52 INFO - PROCESS | 6465 | RSS: Main: 218988544 08:36:52 INFO - PROCESS | 6465 | 08:36:54 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37401/tests/kraken/driver.html?testName=json-parse-financial) 08:36:55 INFO - PROCESS | 6465 | RSS: Main: 218415104 08:36:55 INFO - PROCESS | 6465 | 08:36:57 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:57 INFO - PROCESS | 6465 | RSS: Main: 181104640 08:36:57 INFO - PROCESS | 6465 | 08:36:59 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:37:00 INFO - PROCESS | 6465 | RSS: Main: 188309504 08:37:00 INFO - PROCESS | 6465 | 08:37:02 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:37:02 INFO - PROCESS | 6465 | RSS: Main: 196481024 08:37:02 INFO - PROCESS | 6465 | 08:37:05 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:06 INFO - PROCESS | 6465 | RSS: Main: 206311424 08:37:06 INFO - PROCESS | 6465 | 08:37:08 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:09 INFO - PROCESS | 6465 | RSS: Main: 202567680 08:37:09 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | Cycle 1(1): loaded http://localhost:37401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37401/tests/kraken/driver.html?testName=ai-astar) 08:37:11 INFO - PROCESS | 6465 | RSS: Main: 255475712 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | __start_tp_report 08:37:11 INFO - PROCESS | 6465 | _x_x_mozilla_page_load 08:37:11 INFO - PROCESS | 6465 | _x_x_mozilla_page_load_details 08:37:11 INFO - PROCESS | 6465 | |i|pagename|runs| 08:37:11 INFO - PROCESS | 6465 | |0;ai-astar;109;112;112;113;111;113;115;112;113;113 08:37:11 INFO - PROCESS | 6465 | |1;audio-beat-detection;156;121;120;179;119;120;124;120;144;122 08:37:11 INFO - PROCESS | 6465 | |2;audio-dft;162;162;163;161;163;162;165;164;163;163 08:37:11 INFO - PROCESS | 6465 | |3;audio-fft;75;79;77;112;78;78;77;78;92;78 08:37:11 INFO - PROCESS | 6465 | |4;audio-oscillator;85;83;111;84;83;82;109;82;83;109 08:37:11 INFO - PROCESS | 6465 | |5;imaging-gaussian-blur;119;119;119;118;117;118;117;118;118;118 08:37:11 INFO - PROCESS | 6465 | |6;imaging-darkroom;147;148;148;148;148;149;147;147;147;148 08:37:11 INFO - PROCESS | 6465 | |7;imaging-desaturate;96;95;95;97;95;96;95;95;97;95 08:37:11 INFO - PROCESS | 6465 | |8;json-parse-financial;56;54;54;55;55;54;56;55;55;55 08:37:11 INFO - PROCESS | 6465 | |9;json-stringify-tinderbox;64;64;64;64;64;63;64;64;63;64 08:37:11 INFO - PROCESS | 6465 | |10;stanford-crypto-aes;86;84;84;84;84;85;84;85;85;83 08:37:11 INFO - PROCESS | 6465 | |11;stanford-crypto-ccm;130;129;137;130;136;129;138;130;171;134 08:37:11 INFO - PROCESS | 6465 | |12;stanford-crypto-pbkdf2;172;169;171;171;171;169;169;173;169;170 08:37:11 INFO - PROCESS | 6465 | |13;stanford-crypto-sha256-iterative;66;63;68;63;67;63;66;64;63;64 08:37:11 INFO - PROCESS | 6465 | __end_tp_report 08:37:11 INFO - PROCESS | 6465 | __start_cc_report 08:37:11 INFO - PROCESS | 6465 | _x_x_mozilla_cycle_collect,1670 08:37:11 INFO - PROCESS | 6465 | __end_cc_report 08:37:11 INFO - PROCESS | 6465 | __startTimestamp1486571831469__endTimestamp 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | ------- Summary: start ------- 08:37:11 INFO - PROCESS | 6465 | Number of tests: 14 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.57 (1.4%) stddev-sans-first:1.12 08:37:11 INFO - PROCESS | 6465 | Values: 109.0 112.0 112.0 113.0 111.0 113.0 115.0 112.0 113.0 113.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:123.00 stddev:20.58 (16.7%) stddev-sans-first:20.00 08:37:11 INFO - PROCESS | 6465 | Values: 156.0 121.0 120.0 179.0 119.0 120.0 124.0 120.0 144.0 122.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.14 (0.7%) stddev-sans-first:1.17 08:37:11 INFO - PROCESS | 6465 | Values: 162.0 162.0 163.0 161.0 163.0 162.0 165.0 164.0 163.0 163.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#3] audio-fft Cycles:10 Average:82.40 Median:78.00 stddev:11.40 (14.6%) stddev-sans-first:11.78 08:37:11 INFO - PROCESS | 6465 | Values: 75.0 79.0 77.0 112.0 78.0 78.0 77.0 78.0 92.0 78.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:83.00 stddev:12.85 (15.5%) stddev-sans-first:13.44 08:37:11 INFO - PROCESS | 6465 | Values: 85.0 83.0 111.0 84.0 83.0 82.0 109.0 82.0 83.0 109.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 08:37:11 INFO - PROCESS | 6465 | Values: 119.0 119.0 119.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 08:37:11 INFO - PROCESS | 6465 | Values: 147.0 148.0 148.0 148.0 148.0 149.0 147.0 147.0 147.0 148.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.84 (0.9%) stddev-sans-first:0.88 08:37:11 INFO - PROCESS | 6465 | Values: 96.0 95.0 95.0 97.0 95.0 96.0 95.0 95.0 97.0 95.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 08:37:11 INFO - PROCESS | 6465 | Values: 56.0 54.0 54.0 55.0 55.0 54.0 56.0 55.0 55.0 55.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:37:11 INFO - PROCESS | 6465 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:84.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 08:37:11 INFO - PROCESS | 6465 | Values: 86.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 85.0 83.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:135.00 stddev:12.64 (9.4%) stddev-sans-first:13.20 08:37:11 INFO - PROCESS | 6465 | Values: 130.0 129.0 137.0 130.0 136.0 129.0 138.0 130.0 171.0 134.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:171.00 stddev:1.43 (0.8%) stddev-sans-first:1.39 08:37:11 INFO - PROCESS | 6465 | Values: 172.0 169.0 171.0 171.0 171.0 169.0 169.0 173.0 169.0 170.0 08:37:11 INFO - PROCESS | 6465 | 08:37:11 INFO - PROCESS | 6465 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:1.89 (2.9%) stddev-sans-first:1.94 08:37:11 INFO - PROCESS | 6465 | Values: 66.0 63.0 68.0 63.0 67.0 63.0 66.0 64.0 63.0 64.0 08:37:11 INFO - PROCESS | 6465 | -------- Summary: end -------- 08:37:11 INFO - PROCESS | 6465 | 08:37:12 INFO - TEST-INFO | 6465: exit 0 08:37:12 INFO - TEST-OK | kraken | took 61358ms 08:37:12 INFO - SUITE-END | took 1176s 08:37:12 INFO - Completed test suite (00:19:37) 08:37:12 INFO - javascript benchmark 08:37:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7104.370494179878, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.1843320736607, 3158.88943886964, 3164.52532120182, 3199.42410366134, 3221.5006673965545, 5202.661826981243, 5225.3990791059, 5230.555402790763, 5231.633785635007, 5279.788808447657, 5208.140656791625, 5216.973915130419, 5222.138347172721, 5255.684658920468, 5367.624266301361, 4538.591526762591, 4706.3411122442885, 4914.778834952418, 4922.852314430573, 4935.5804756595735, 4625.098105869357, 4926.2364333528185, 4940.802367905279, 4963.578095861856, 4967.528084831935, 4595.770211489412, 4788.28175773635, 4802.423709154924, 4841.443234028096, 4914.11545921734, 4841.9031619367415, 4842.15262329091, 4847.5394837490385, 4853.854384368475, 4883.609311255126, 4636.443626764776, 4792.472827988919, 4847.636427267969, 4856.441509226449, 4880.633952453544, 5048.015636950796, 5220.29526013987, 5284.392294886099, 5287.206918962148, 5291.3385826771655, 5698.230738850244, 5711.857203569903, 5712.200291959129, 5717.799877004285, 5726.427357264281, 5529.723513824292, 5719.14212868069, 5766.250387449647, 5771.220885180489, 5772.134179873011, 5207.921881171786, 5276.234945932857, 5306.893862122736, 5308.230306605559, 5386.0, 5774.653520788766, 5787.334456537468, 5787.5080618147085, 5791.3339965903615, 5795.217645617872, 5520.089185284383, 5562.888742225133, 5576.721163941867, 5577.9163312550345, 5578.748956296977, 5543.45182854508, 5669.603127781098, 5670.943290567042, 5688.857778555486, 5713.885722285531, 5692.316921969307, 5723.6851973141875, 5725.742341594639, 5727.4845263926445, 5740.827775166752, 5537.889242215133, 5587.106063029895, 5689.2319536862, 5692.48767610917, 5695.686737229409, 4385.824567017284, 4395.560443955579, 4395.890102747457, 4404.0, 4446.288593825037, 3918.5885482024546, 3929.5284565851707, 3933.665638420709, 3966.603339666068, 3968.900777480586, 5238.73806309683, 5411.512963833274, 5429.239906413105, 5431.67409955396, 5434.049041417736, 5587.636803607753, 5612.663240205601, 5613.915791263134, 5646.887062258732, 5652.349979752299, 5302.125149350391, 5305.204219367126, 5305.522502974673, 5334.7065911374475, 5351.983123206578, 4795.328653988445, 4815.903681926342, 4818.807247710122, 4824.179889418807, 4863.562279394871, 5712.685802280831, 5747.511461525817, 5763.510101641407, 5800.6809625471005, 5834.533237341003, 5587.664740115606, 5633.267675202197, 5650.660960342392, 5668.7732490701555, 5702.40124786908, 5819.039858423313, 5853.443922827325, 5858.5898987070495, 5860.38465961068, 5874.735636896265, 5353.892922141613, 5370.3287089113865, 5560.165975103767, 5561.833145005657, 5580.972095139661, 5571.331440227199, 5592.0, 5603.047481928001, 5634.661920284632, 5683.23276357703, 5489.505944465017, 5489.58828087887, 5493.450654934474, 5494.038543254995, 5497.065498865282, 5410.188471729272, 5462.071447853795, 5474.671519708831, 5511.614187006871, 5561.972190139023, 5341.4925582069645, 5512.6692398456225, 5520.86197845041, 5566.165075238585, 5608.0, 5427.565794736491, 5471.0, 5496.890062198813, 5502.477264659851, 5528.751206195811, 5421.891562168814, 5428.6199966002005, 5440.891182176413, 5451.972740136274, 5467.58993075513], "value": 5218.699914327852, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.9844125269364, 576.3775122867306, 580.4282781460262, 593.902006168982, 595.609875531527, 32185.51721724176, 43708.0, 44584.77707611457, 44621.77689111558, 44659.33011004834, 46046.079078418414, 46539.76730116345, 46540.301895471595, 46580.06839863201, 46626.06747865049, 7736.535807851519, 9125.49809760463, 9305.395149315307, 9322.720318390458, 9330.486823224719, 7701.6919323227, 9906.306558540906, 10076.445795481246, 10082.092611664948, 10320.122789562896, 10993.285436446646, 11076.944615276912, 11084.833727494093, 11086.889131108706, 11087.113030957504, 10946.288491248044, 11001.504932278067, 11034.172437067253, 11040.227184097157, 11046.061084807801, 10830.891691083067, 10846.457677116112, 10871.565137394495, 10886.129109671207, 10900.836487452694, 40446.79776601098, 40499.39250911239, 40543.39184912229, 40758.0, 40808.38787418191, 3944.5858184890462, 3982.2234664240486, 4009.6343157537194, 4010.1578668479656, 4122.773247471388, 31276.0, 31582.526262106087, 31651.36697266065, 31705.682943170505, 31861.84069079663, 4279.957200427987, 4381.298992161271, 4504.459464864237, 4587.7017993830295, 4604.194266003469, 328794.0, 328875.0, 330892.9999999976, 331877.0, 332659.427680125, 59523.404765952655, 60175.09737353943, 60201.397986020456, 60209.39790602038, 60299.69850150721, 62407.37592624016, 62431.37568624256, 62591.374086258555, 62675.926064805644, 62720.0, 16214.432494862858, 16656.333746649998, 16672.666546669243, 16687.08221047854, 16695.332186712396, 10718.624848130277, 10880.510377033053, 12201.633950981484, 12411.131220814455, 12504.499820007099, 16421.261043253082, 16944.745828812578, 16952.101016766213, 17009.744853827204, 17038.74441883373, 6199.969000154971, 6329.3354197809485, 6342.809715708536, 6357.586756860789, 6365.4589359904, 890.8129292848445, 907.6324088744069, 920.5305294299956, 921.8525035994343, 937.6155776131753, 31196.0, 32068.358632827214, 32271.838640807116, 32295.192620184684, 32824.0, 963.8265112279717, 1082.1342925659442, 1083.3337497439018, 1083.3716444462193, 1099.7910397024539, 15517.45688900883, 15752.68494630101, 16311.429099981444, 16502.83497165037, 16826.57933551671, 437584.0, 438509.0, 439619.0, 440395.0, 441647.0, 54128.0, 54273.72863135659, 54581.727091364286, 54779.72610136924, 54996.0, 1329.2091205732575, 1342.4563051963971, 1379.0346757269751, 1380.1167252958114, 1382.0740104130257, 27377.619580866965, 28468.29190248592, 28739.8563007192, 29677.258068548457, 29686.0, 36477.63522364743, 50166.74916625393, 51283.74358128185, 51405.7429712864, 56621.71689141528, 399713.0, 400406.0, 401455.0, 401733.0, 402905.0, 23098.884505577364, 23748.168814091423, 26361.0, 26420.867895660398, 27013.459730805665, 42731.35902961396, 42876.78561607172, 42945.570544294154, 43059.138817224106, 43125.13749724925, 36361.636383636884, 36481.4398200225, 36800.0, 36998.26003479969, 37812.0, 36590.08524786795, 37122.8143859279, 37169.81415092907, 37218.25563488769, 37795.0, 33296.833515832266, 33523.664763352055, 33826.15434614154, 33857.66142338545, 34406.13984650404, 30208.5468717965, 32358.514622281156, 32406.675933240367, 32530.0, 33025.33949321048, 24546.63180052265, 24668.629970550097, 25134.0, 25286.620700689138, 25390.111346102796], "value": 19533.70664116068, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.5531536571234, 429.70779869688636, 434.50640363511167, 439.82626862389355, 441.25207772825075, 18248.361307354262, 18250.17874195661, 19694.606107877833, 19814.207431702715, 19956.401307960765, 20436.8978155109, 20534.281300154496, 20889.582208355863, 21038.68441973368, 21216.57566848662, 5676.0, 5907.084401917709, 5914.4381283777975, 5920.4671579557835, 5924.111383292519, 5772.509336706385, 5825.359210486843, 5872.324682661484, 5884.411558844103, 6000.309964354112, 5754.367019627837, 5756.0, 5758.165066065418, 5772.509336706385, 5815.302163740336, 5619.297587801545, 5654.067078932012, 5698.373178950312, 5768.105943578752, 5798.449147330997, 5131.255967884673, 5144.125498665198, 5146.356705411824, 5147.073526765181, 5154.123798954187, 23821.523569528686, 24055.398615034588, 24060.278191654277, 24283.0, 24302.270931872074, 2650.5891586804078, 2665.4802313548867, 2700.9594856077174, 2705.242532090998, 2708.986455067712, 14549.345279462344, 14669.559913202622, 14688.192149431778, 14815.851841481555, 15499.0, 1787.2843510786788, 1846.2891786662233, 1873.5409824592925, 1882.4164509002253, 1889.6598612249788, 79750.0, 82070.0, 82188.0, 82665.0, 84039.57980210122, 11206.15953803468, 11402.828957565644, 11422.94288528552, 11423.314601123959, 11703.23928944616, 16266.105364204846, 16266.18669066542, 16270.75593866093, 16290.83709162917, 16303.59241018984, 8328.875066874001, 8428.367872409593, 8476.194761497647, 8655.0, 8672.956635216784, 8019.0, 8104.756857294291, 8291.170882911782, 8293.33653307734, 8317.625706843206, 7239.276072392719, 7256.383207427322, 7277.0, 7371.483996120327, 7440.516366436164, 2005.8867328632748, 2027.1688607671078, 2053.910156386322, 2060.3612880006945, 2133.5570771466582, 875.4747151708924, 893.6068130022769, 895.4761464543316, 898.8471959766855, 911.6763548940163, 19634.70547941782, 20680.172793088408, 20718.689219661715, 20779.8961005197, 20959.371218863154, 894.3873446689039, 899.0625202688217, 924.357571487823, 925.6528801699362, 939.492673956056, 11048.779024419466, 11570.247933884271, 11647.6505704829, 11699.88300117005, 11874.34691091981, 614626.0, 615372.0, 617566.0, 646747.0, 649177.0, 87034.56482717546, 87540.0, 89350.55324723334, 90045.54977225071, 90160.09839901517, 1102.7959827431791, 1125.5947858770835, 1155.4165146600913, 1159.5419809175328, 1161.440185830427, 17396.217170227115, 17525.31045833146, 17903.641927161123, 18074.0, 18095.909520452315, 40481.797591011855, 41523.58476415197, 41770.85468333646, 41833.79083104687, 42918.35622465603, 53089.0, 53314.20028699495, 53942.19086713624, 54300.0, 54834.72582637061, 7944.563049032358, 8009.159038300894, 8080.111187769223, 8218.753437396888, 8410.411271210956, 12452.564160254347, 12991.805122923353, 13499.527516536875, 13731.107478013897, 13785.103968242032, 10594.15246780271, 11521.135914806591, 11587.710307242387, 11634.53461861516, 12212.633620991384, 6152.169457123231, 10467.319624224401, 12046.096542759504, 12241.938790305992, 12250.591182013826, 12434.689132771753, 12527.498900043896, 12805.423755930819, 12964.481420743065, 13039.543615973396, 7803.492772969739, 8012.919870801217, 8063.153368896182, 8575.31397488212, 8974.730758077269, 8876.20114189726, 10822.242443028912, 11357.318560886373, 11390.25963312382, 12218.327991960172], "value": 9589.881068814699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1271.4850485553354, 1409.3305679802095, 1421.7938398932151, 1424.64383904024, 1441.264954873015, 7420.109586849579, 8072.0, 8336.374771892117, 8360.205780450862, 8537.231649151576, 8384.748457546268, 8432.030316513603, 8446.49321040738, 8453.408261421702, 8454.619542120605, 1926.7687877454725, 1979.5348093198088, 2232.866028038323, 2274.431392151962, 2275.16956310947, 2242.607543679858, 2309.688192094071, 2312.4681323295654, 2323.9535209295805, 2330.463993281546, 2238.630625946717, 2245.4049676835652, 2256.379495638696, 2257.977420225793, 2267.761885002076, 2268.1040988809327, 2270.886455677218, 2287.9084836606517, 2292.323764489471, 2294.0823670531754, 2149.537849362379, 2210.834187435949, 2216.180013395038, 2217.323716266538, 2221.1892659179443, 8645.65417383304, 8711.34664900135, 8718.782030449289, 8723.520206388646, 8727.694530691459, 4968.105740966625, 5099.71951542665, 5105.540501354896, 5111.795528178868, 5117.513836185556, 3124.5938028056435, 3152.133163380066, 3290.1116698491514, 3318.15387076294, 3380.678835510623, 1417.6385021819474, 1440.5390275111968, 1460.7443697353026, 1487.3976039703937, 1525.2145145250206, 11823.231489953212, 11923.403829808474, 11929.01774556361, 11931.343776092312, 11950.760984780256, 4533.274676051816, 4616.0, 4620.768961551909, 4673.719576825401, 4697.271922851964, 10020.0, 10108.090271875566, 10109.0, 10111.848322275171, 10121.797564048678, 5228.346456692913, 5235.0, 5239.083160446907, 5250.264962905197, 5251.0548101341365, 4070.816813243411, 4075.38869169621, 4636.0, 4686.507916668769, 4788.856334309976, 3803.5055442792814, 3853.5761066282685, 3882.7864467453996, 3900.6099390060767, 3952.7233093683167, 1280.5838102616501, 1287.2469605281015, 1293.5472584595316, 1297.2800095946652, 1304.8499422566335, 785.0008414258685, 879.1911441473859, 896.9775755606162, 901.715959472764, 915.3592485260344, 5571.8885622288135, 5612.354579223442, 5659.43405659439, 5691.715414229355, 5705.343885453143, 1026.2303272545591, 1034.8706411698538, 1039.880413752413, 1045.482486169351, 1050.3225419604312, 3607.5129857469433, 3748.044248716614, 3808.333541630204, 3812.275667623143, 3848.826802793881, 10149.441780701985, 10463.215258855464, 10470.581176752845, 10481.633142839964, 10503.47482625881, 10265.640702575374, 10345.224108191916, 10374.118199952938, 10422.843657345145, 10451.895481045092, 7465.365443937326, 7557.735479258199, 7682.231776822273, 7688.9615551923, 7700.691972321157, 5509.146082357241, 5519.172124181405, 5715.199872018004, 5737.454941780524, 5743.798967036134, 9283.535823208678, 9341.159295663423, 9460.479673618018, 9513.524323783644, 9559.474228917476, 9449.338546301693, 9586.376885502421, 9661.13049825519, 9702.0, 9845.178641951263, 6197.5351848610635, 6278.968605156945, 6413.903791443226, 7125.1093613298335, 7273.3453989141235, 7752.0, 8093.797655058671, 8146.67413303485, 8168.101508834143, 8188.7952801180445, 7278.199398066315, 7329.157146928172, 7410.407167426701, 7545.132309784445, 7558.319751222416, 7156.320149585781, 7238.02286691311, 7252.746153884589, 7268.0914885639295, 7294.088238970129, 6412.871742565029, 6519.0, 6519.73921043172, 6520.7391704333195, 6524.934750652433, 5019.924701129559, 5042.571381432619, 5050.646454748133, 5085.593152547861, 5313.203019547099, 4973.129702302011, 5002.724850133278, 5125.820596279262, 5146.794128234978, 5224.216367544898], "value": 4486.307807074918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1701923844495, 396.9781662008588, 408.0675656125753, 413.14479028411193, 413.51959983259934, 5198.428172900978, 5229.607779416545, 5265.86835329117, 5287.867803304915, 5363.195520671901, 5027.32131162293, 5159.845204643857, 5197.948020519793, 5202.531772140506, 5216.635270250696, 4093.1961606299633, 4106.38404239365, 4109.958900411002, 4110.075233072557, 4124.0, 4123.814428350732, 4134.7519148851015, 4136.772477513736, 4146.937795933063, 4189.245935731567, 3876.3604005339084, 4018.658414034796, 4053.5338436079933, 4070.7354021988476, 4102.261592913274, 4021.4571032910476, 4034.475518182632, 4038.9999999999854, 4046.5751096135073, 4049.0, 3550.2012047289154, 3598.352296586613, 3603.3153700797025, 3603.69368603669, 3608.585012723544, 4829.082474329901, 5044.848654540369, 5046.873828154289, 5063.721495317756, 5066.569341605968, 4663.300504924255, 4699.67102302839, 4710.505396933341, 4725.929111063337, 4731.408573928259, 5489.6980666063355, 5496.0, 5500.257465242181, 5511.173324001432, 5530.889382212374, 3875.3411919973673, 3968.8412463501427, 3987.8803635890968, 4011.618896204885, 4022.839086436539, 5434.212039254286, 5595.580331475156, 5607.299087614048, 5642.7178641067785, 5689.431056894319, 4084.9387259191135, 4085.55058943516, 4085.610892296633, 4085.9182816343505, 4091.6522095622204, 4128.587141285848, 4142.316517774533, 4143.6892233082035, 4150.605692459211, 4167.791610419466, 4465.799039043251, 4555.726656400627, 4629.583337499641, 4684.156851766715, 4686.484486706459, 5515.117581186991, 5519.39286678465, 5527.198556209327, 5529.557635389159, 5539.8892022160135, 1355.4239448234657, 1355.8136630448357, 1368.3021658954005, 1368.568900796246, 1381.2886363522794, 918.7243826851918, 949.3259785552335, 971.2909576009553, 973.7419583810296, 978.9021097890296, 5093.18509038552, 5102.897942041212, 5106.770195341219, 5112.872178195575, 5122.795088196505, 5369.650972686841, 5390.676559406448, 5398.46015398457, 5448.863778405493, 5462.644928079662, 4727.369057675097, 5011.84964451067, 5021.573166280907, 5037.748112594356, 5130.743462826844, 2860.3850172213074, 2861.7853660975093, 2863.2412410711177, 2882.855857207131, 2894.4789937811397, 5458.099413596791, 5615.101583746581, 5636.872625474839, 5670.291213598301, 5681.77272909079, 5532.17017447378, 5537.335519737577, 5589.944100559023, 5643.943560564424, 5648.999999999918, 5655.406182350794, 5674.4892959633835, 5689.288838895138, 5696.886062278814, 5726.0817626094895, 5203.427622961395, 5325.9201111982575, 5388.326459192601, 5437.26596909428, 5456.263404440349, 5313.973430132824, 5337.9466205339, 5341.302642165681, 5354.303940487712, 5431.212474191141, 5696.857578560403, 5789.2763404574425, 5795.159701843293, 5827.5629327801435, 5828.271466066742, 4034.9596504034585, 4049.716519843583, 4054.5134583850127, 4072.4298598195683, 4081.8571350002608, 5258.631895767259, 5546.694931778791, 5559.833205003856, 5560.944390556043, 5610.681489849963, 5519.862003449946, 5524.585656075891, 5527.0, 5527.972360138174, 5529.115341545334, 5503.174523821459, 5506.0, 5509.917351239655, 5516.793282686797, 5532.972335138298, 5231.645759408206, 5509.752061157177, 5514.36584792754, 5541.113421852484, 5547.306586676666, 5555.916661250165, 5562.972185139049, 5574.86062848432, 5578.944210557843, 5583.35791383996, 5210.765515551885, 5438.646487978269, 5446.638340414896, 5453.945460545344, 5461.760678121951], "value": 4182.081368314298, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.8009917059131, 740.6963145110506, 779.5050143159095, 814.1852692959925, 864.1617630898029, 14547.0, 15416.845831541681, 15988.360465581363, 16002.279897404616, 16247.268872900719, 13418.865811341908, 14672.559823205294, 14799.778003329959, 14828.18444985528, 14837.629059273524, 761.364260842196, 777.1063277231173, 777.4324742937658, 778.8870613761002, 778.9415793815458, 768.2778188502817, 769.7806125254303, 771.463832636318, 771.7067514344569, 771.7221800151968, 809.0493669937799, 810.0198759501011, 810.2626609785096, 810.6797814863125, 810.7891948093509, 806.6128258435954, 812.1188510466122, 812.2567850416862, 812.687115460549, 812.9146439623813, 592.9940700592982, 597.8923793717129, 597.9790707325222, 598.631841417525, 598.7575032112002, 13459.730805383935, 13746.243956582384, 13792.724145517133, 14680.265986700622, 14860.331285092198, 12677.366131693378, 12692.80960785589, 13082.607521774362, 13242.86757132426, 13278.0, 11098.667039988813, 11141.275817071864, 11250.493727782188, 11465.828012579817, 11676.532938682443, 3678.834452449646, 3686.870959516431, 3745.62543745626, 3785.5835858055593, 3789.7157713171623, 70502.64748676223, 70957.6452117736, 71680.38072766158, 74013.0, 74816.0, 9056.0, 9279.211267042378, 9305.90694093064, 9323.300752443594, 9504.287178461644, 18673.346432874783, 18704.345347912757, 18872.528186795167, 18947.62104757897, 19003.71494427557, 7947.4039447041705, 7979.800504987305, 8051.114377418479, 8086.474379165335, 8133.146019667968, 4335.848245311399, 4492.0, 4498.347739577743, 4512.097580483916, 4549.6360291176625, 3520.4543295789194, 3590.8922732318074, 3592.0, 3625.0756057205244, 3630.2739452109686, 563.1749487001563, 564.6753116957766, 565.0845630079216, 565.1898483588715, 579.3366595248417, 748.2517482517483, 756.8032311599023, 766.6741634805186, 791.2325044706625, 793.9563324017234, 9560.378575392577, 9824.4105353679, 10271.794564108675, 10452.177204849548, 10526.31578947366, 629.7512482569359, 654.1234745441132, 654.4731491149576, 654.8657525207321, 664.1863716946701, 4822.95177048232, 5046.318746969186, 5069.949300507022, 5100.413452452941, 5119.948800511947, 71003.28996709967, 76024.23975760282, 77316.61341693255, 77494.0, 77946.61026694831, 41002.0, 42220.788896055936, 68971.65514172397, 69790.65104674545, 73514.0, 41173.588264116974, 57311.0, 59160.0, 60110.99999999913, 60162.0, 10390.376577405379, 10951.24738620326, 11008.0, 11081.39052352096, 11110.444477775916, 39129.0, 39213.607863920995, 39401.40897886591, 39651.215695294355, 40661.79669101635, 49006.5099349002, 50673.49326506688, 50898.491015090854, 50914.74542627263, 51849.22226166686, 13103.541376052173, 13193.934030329787, 13269.270190139636, 13356.599302020955, 13365.198088114745, 14222.715545689236, 14393.352299146354, 14480.275986200859, 14562.0, 14617.634559136106, 11424.371659558805, 11496.770064598828, 11649.95150436431, 12203.938980305042, 14357.712845742817, 13528.72942541124, 13635.454581816617, 13789.172649641054, 14215.857841421453, 14763.778543322074, 13467.0, 14203.431862725376, 14494.710105797614, 14741.894357923413, 14745.631359216106, 11702.35637039971, 12083.39583020863, 12259.325737084546, 12384.876151238372, 12447.439865205906, 10901.672949811518, 11008.39453830047, 11014.229003969645, 11964.521419143137, 12004.179017930954], "value": 7009.14919105327, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.1000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 113.0, 111.0, 113.0, 115.0, 112.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 121.0, 120.0, 179.0, 119.0, 120.0, 124.0, 120.0, 144.0, 122.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 165.0, 164.0, 163.0, 163.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 77.0, 112.0, 78.0, 78.0, 77.0, 78.0, 92.0, 78.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 111.0, 84.0, 83.0, 82.0, 109.0, 82.0, 83.0, 109.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 95.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 55.0, 54.0, 56.0, 55.0, 55.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 137.0, 130.0, 136.0, 129.0, 138.0, 130.0, 171.0, 134.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 171.0, 171.0, 171.0, 169.0, 169.0, 173.0, 169.0, 170.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 68.0, 63.0, 67.0, 63.0, 66.0, 64.0, 63.0, 64.0], "value": 64.7, "unit": "score"}]}]} 08:37:12 INFO - Return code: 0 08:37:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:12 ERROR - # TBPL SUCCESS # 08:37:12 INFO - Running post-action listener: _resource_record_post_action 08:37:12 INFO - [mozharness: 2017-02-08 16:37:12.770103Z] Finished run-tests step (success) 08:37:12 INFO - Running post-run listener: _resource_record_post_run 08:37:12 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401592320; Read time: 16; Write time: 277784 08:37:12 INFO - TinderboxPrint: CPU usage
13.1% 08:37:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 08:37:12 INFO - TinderboxPrint: I/O write bytes / time
401,592,320 / 277,784 08:37:12 INFO - TinderboxPrint: CPU idle
8,287.9 (86.9%) 08:37:12 INFO - TinderboxPrint: CPU user
1,200.4 (12.6%) 08:37:12 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:12 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105664512; Read time: 0; Write time: 101232 08:37:12 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295927808; Read time: 16; Write time: 176552 08:37:13 INFO - Running post-run listener: _upload_blobber_files 08:37:13 INFO - Blob upload gear active. 08:37:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:37:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:15 INFO - (blobuploader) - INFO - Done attempting. 08:37:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:18 INFO - (blobuploader) - INFO - Done attempting. 08:37:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:37:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:37:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:19 INFO - (blobuploader) - INFO - Done attempting. 08:37:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:37:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:37:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:20 INFO - (blobuploader) - INFO - Done attempting. 08:37:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:20 INFO - Return code: 0 08:37:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:20 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22b1fd5017d8380038e99a1c4b883f69835ee3e0fcd2090632680298a24eb717eb69648d980568490a916595bb9b608c903efbb6920a75c24633dab9988b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d444552187dc5b2af22965f353fbc1ea41aa20deeafaa784984e087db1c0cd7d186ad89f4f0ed21728112b5316bcdaa9b77c7011facababc4adf907d9ff3b9", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9077a6ceb7c28e9501b86a0e12fc1e749fd2a61baa85e1628ab2cf1157c08b2a64e87487e5baf502bb158a57ee498b1062bc2773eeeda04164915355f28739b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4c3772a9711c10a50b9d3a64a954b8116e4beaf1510ce8c5d0f234fda507d7f7cd3a0f7734f60667d18fc2110c75577bd86d9e0c94bd427e94b386e1feb39c"} 08:37:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:20 INFO - Contents: 08:37:20 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22b1fd5017d8380038e99a1c4b883f69835ee3e0fcd2090632680298a24eb717eb69648d980568490a916595bb9b608c903efbb6920a75c24633dab9988b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d444552187dc5b2af22965f353fbc1ea41aa20deeafaa784984e087db1c0cd7d186ad89f4f0ed21728112b5316bcdaa9b77c7011facababc4adf907d9ff3b9", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9077a6ceb7c28e9501b86a0e12fc1e749fd2a61baa85e1628ab2cf1157c08b2a64e87487e5baf502bb158a57ee498b1062bc2773eeeda04164915355f28739b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4c3772a9711c10a50b9d3a64a954b8116e4beaf1510ce8c5d0f234fda507d7f7cd3a0f7734f60667d18fc2110c75577bd86d9e0c94bd427e94b386e1feb39c"} 08:37:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:20 INFO - Copying logs to upload dir... 08:37:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.776642 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2017-02-08 08:37:19.233258) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 08:37:19.237090) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22b1fd5017d8380038e99a1c4b883f69835ee3e0fcd2090632680298a24eb717eb69648d980568490a916595bb9b608c903efbb6920a75c24633dab9988b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d444552187dc5b2af22965f353fbc1ea41aa20deeafaa784984e087db1c0cd7d186ad89f4f0ed21728112b5316bcdaa9b77c7011facababc4adf907d9ff3b9", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9077a6ceb7c28e9501b86a0e12fc1e749fd2a61baa85e1628ab2cf1157c08b2a64e87487e5baf502bb158a57ee498b1062bc2773eeeda04164915355f28739b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4c3772a9711c10a50b9d3a64a954b8116e4beaf1510ce8c5d0f234fda507d7f7cd3a0f7734f60667d18fc2110c75577bd86d9e0c94bd427e94b386e1feb39c"} build_url:https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/ahiRiLMvRo6roo8vRbjexg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f22b1fd5017d8380038e99a1c4b883f69835ee3e0fcd2090632680298a24eb717eb69648d980568490a916595bb9b608c903efbb6920a75c24633dab9988b01e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d444552187dc5b2af22965f353fbc1ea41aa20deeafaa784984e087db1c0cd7d186ad89f4f0ed21728112b5316bcdaa9b77c7011facababc4adf907d9ff3b9", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9077a6ceb7c28e9501b86a0e12fc1e749fd2a61baa85e1628ab2cf1157c08b2a64e87487e5baf502bb158a57ee498b1062bc2773eeeda04164915355f28739b7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac4c3772a9711c10a50b9d3a64a954b8116e4beaf1510ce8c5d0f234fda507d7f7cd3a0f7734f60667d18fc2110c75577bd86d9e0c94bd427e94b386e1feb39c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-08 08:37:19.261587) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:37:19.261913) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486570594.664595-235509190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004447 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-08 08:37:19.344473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 08:37:19.344830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-08 08:37:19.345168) ========= ========= Total master_lag: 0.14 =========