builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1486649609.49 results: success (0) revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.493093) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.493584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.493940) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.507025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.507407) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 06:13:29-- 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% 42.8M=0s 2017-02-09 06:13:29 (42.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123910 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.643278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.643627) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016813 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.693887) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:29.694337) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1419fa7ee013b44501b90487bf8f8873dbaf3727 --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=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 06:13:29,766 truncating revision to first 12 chars 2017-02-09 06:13:29,766 Setting DEBUG logging. 2017-02-09 06:13:29,766 attempt 1/10 2017-02-09 06:13:29,766 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1419fa7ee013?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 06:13:30,401 unpacking tar archive at: mozilla-aurora-1419fa7ee013/testing/mozharness/ program finished with exit code 0 elapsedTime=0.961373 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:30.672264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:30.672842) ========= script_repo_revision: 1419fa7ee013b44501b90487bf8f8873dbaf3727 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:30.673474) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:30.673959) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 06:13:30.684695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:13:30.685046) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:13:30 INFO - MultiFileLogger online at 20170209 06:13:30 in /builds/slave/test 06:13:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 06:13:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:13:30 INFO - {'append_to_log': False, 06:13:30 INFO - 'base_work_dir': '/builds/slave/test', 06:13:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 06:13:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:13:30 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 06:13:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:13:30 INFO - 'config_files': ('talos/linux_config.py',), 06:13:30 INFO - 'default_actions': ('clobber', 06:13:30 INFO - 'read-buildbot-config', 06:13:30 INFO - 'download-and-extract', 06:13:30 INFO - 'populate-webroot', 06:13:30 INFO - 'create-virtualenv', 06:13:30 INFO - 'install', 06:13:30 INFO - 'run-tests'), 06:13:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:13:30 INFO - 'download_minidump_stackwalk': True, 06:13:30 INFO - 'download_symbols': 'ondemand', 06:13:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:13:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:13:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:13:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:13:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:13:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:13:30 INFO - 'installer_path': 'installer.exe', 06:13:30 INFO - 'log_level': 'info', 06:13:30 INFO - 'log_name': 'talos', 06:13:30 INFO - 'log_to_console': True, 06:13:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:13:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:13:30 INFO - 'opt_config_files': (), 06:13:30 INFO - 'pip_index': False, 06:13:30 INFO - 'sps_profile': False, 06:13:30 INFO - 'sps_profile_interval': 0, 06:13:30 INFO - 'suite': 'dromaeojs', 06:13:30 INFO - 'system_bits': '32', 06:13:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:13:30 INFO - 'title': 'talos-linux64-ix-019', 06:13:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:13:30 INFO - 'use_talos_json': True, 06:13:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:13:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:13:30 INFO - 'work_dir': 'build'} 06:13:30 INFO - [mozharness: 2017-02-09 14:13:30.852345Z] Running clobber step. 06:13:30 INFO - Running pre-action listener: _resource_record_pre_action 06:13:30 INFO - Running main action method: clobber 06:13:30 INFO - rmtree: /builds/slave/test/build 06:13:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:13:31 INFO - Running post-action listener: _resource_record_post_action 06:13:31 INFO - [mozharness: 2017-02-09 14:13:31.318834Z] Finished clobber step (success) 06:13:31 INFO - [mozharness: 2017-02-09 14:13:31.318935Z] Running read-buildbot-config step. 06:13:31 INFO - Running pre-action listener: _resource_record_pre_action 06:13:31 INFO - Running main action method: read_buildbot_config 06:13:31 INFO - Using buildbot properties: 06:13:31 INFO - { 06:13:31 INFO - "project": "", 06:13:31 INFO - "product": "firefox", 06:13:31 INFO - "who": "cbook@mozilla.com", 06:13:31 INFO - "installer_path": "public/build/target.tar.bz2", 06:13:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 06:13:31 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 06:13:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 06:13:31 INFO - "stage_platform": "linux64", 06:13:31 INFO - "basedir": "/builds/slave/test", 06:13:31 INFO - "buildnumber": 20, 06:13:31 INFO - "platform": "ubuntu64_hw", 06:13:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:13:31 INFO - "slavebuilddir": "test", 06:13:31 INFO - "taskId": "dc0iQB-pR-KXkasroOSSfA", 06:13:31 INFO - "branch": "mozilla-aurora", 06:13:31 INFO - "script_repo_revision": "production", 06:13:31 INFO - "revision": "1419fa7ee013b44501b90487bf8f8873dbaf3727", 06:13:31 INFO - "slavename": "talos-linux64-ix-019", 06:13:31 INFO - "repo_path": "releases/mozilla-aurora" 06:13:31 INFO - } 06:13:31 INFO - Finding installer, test and symbols from parent task. 06:13:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc0iQB-pR-KXkasroOSSfA'}, attempt #1 06:13:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dc0iQB-pR-KXkasroOSSfA'}, attempt #1 06:13:32 INFO - Task dependencies: UG8Ra0dbSf2E8U_X24Zojw 06:13:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw'}, attempt #1 06:13:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:13:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/test_packages.json 06:13:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip 06:13:32 INFO - Running post-action listener: _resource_record_post_action 06:13:32 INFO - [mozharness: 2017-02-09 14:13:32.910032Z] Finished read-buildbot-config step (success) 06:13:32 INFO - [mozharness: 2017-02-09 14:13:32.910250Z] Running download-and-extract step. 06:13:32 INFO - Running pre-action listener: _resource_record_pre_action 06:13:32 INFO - Running main action method: download_and_extract 06:13:32 INFO - mkdir: /builds/slave/test/build/tests 06:13:32 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')]} 06:13:32 INFO - trying https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json 06:13:32 INFO - Downloading https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:13:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:13:33 INFO - Downloaded 896 bytes. 06:13:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:13:33 INFO - Using the following test package requirements: 06:13:33 INFO - {u'common': [u'target.common.tests.zip'], 06:13:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:13:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:13:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:13:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:13:33 INFO - u'mozbase': [u'target.common.tests.zip'], 06:13:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:13:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:13:33 INFO - u'web-platform': [u'target.common.tests.zip', 06:13:33 INFO - u'target.web-platform.tests.zip'], 06:13:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:13:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:13:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip 06:13:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:13:33 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip into memory 06:13:34 INFO - Expected file size: 21858312 06:13:34 INFO - Obtained file size: 21858312 06:13:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:13:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip 06:13:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:13:38 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.common.tests.zip into memory 06:13:39 INFO - Expected file size: 21858312 06:13:39 INFO - Obtained file size: 21858312 06:13:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip 06:13:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:13:43 INFO - Fetch https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.talos.tests.zip into memory 06:13:44 INFO - Expected file size: 14403485 06:13:44 INFO - Obtained file size: 14403485 06:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:44 INFO - trying https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:13:44 INFO - Downloading https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:13:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:13:45 INFO - Downloaded 66041066 bytes. 06:13:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:13:45 INFO - mkdir: /builds/slave/test/properties 06:13:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:13:45 INFO - Writing to file /builds/slave/test/properties/build_url 06:13:45 INFO - Contents: 06:13:45 INFO - build_url:https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 06:13:45 INFO - Running post-action listener: _resource_record_post_action 06:13:45 INFO - Running post-action listener: set_extra_try_arguments 06:13:45 INFO - [mozharness: 2017-02-09 14:13:45.791425Z] Finished download-and-extract step (success) 06:13:45 INFO - [mozharness: 2017-02-09 14:13:45.791522Z] Running populate-webroot step. 06:13:45 INFO - Running pre-action listener: _resource_record_pre_action 06:13:45 INFO - Running main action method: populate_webroot 06:13:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:13:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:13:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:13:45 INFO - '--tppagecycles', 06:13:45 INFO - '7'], 06:13:45 INFO - 'tests': ['tsvgm']}}, 06:13:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:13:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:13:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:13:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:13:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:13:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['damp', 'tps']}, 06:13:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'tests': ['damp', 'tps']}, 06:13:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['dromaeo_dom']}, 06:13:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:13:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['basic_compositor_video']}, 06:13:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:13:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'other-e10s': {'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['a11yr', 06:13:45 INFO - 'ts_paint', 06:13:45 INFO - 'tpaint', 06:13:45 INFO - 'sessionrestore', 06:13:45 INFO - 'sessionrestore_no_auto_restore', 06:13:45 INFO - 'tabpaint']}, 06:13:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['tsvgx', 06:13:45 INFO - 'tsvgr_opacity', 06:13:45 INFO - 'tart', 06:13:45 INFO - 'tscrollx', 06:13:45 INFO - 'cart', 06:13:45 INFO - 'tsvg_static']}, 06:13:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:13:45 INFO - 'tsvgr_opacity', 06:13:45 INFO - 'tart', 06:13:45 INFO - 'tscrollx', 06:13:45 INFO - 'cart', 06:13:45 INFO - 'tsvg_static']}, 06:13:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'talos_options': ['--disable-e10s'], 06:13:45 INFO - 'tests': ['tp5o']}, 06:13:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:13:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'talos_options': ['--disable-e10s', 06:13:45 INFO - '--xperf_path', 06:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:45 INFO - 'tests': ['tp5n']}, 06:13:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:13:45 INFO - 'talos_options': ['--xperf_path', 06:13:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:13:45 INFO - 'tests': ['tp5n']}}, 06:13:45 INFO - 'talos.zip': {'path': '', 06:13:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:13:45 INFO - Running post-action listener: _resource_record_post_action 06:13:45 INFO - [mozharness: 2017-02-09 14:13:45.804647Z] Finished populate-webroot step (success) 06:13:45 INFO - [mozharness: 2017-02-09 14:13:45.804738Z] Running create-virtualenv step. 06:13:45 INFO - Running pre-action listener: _resource_record_pre_action 06:13:45 INFO - Running main action method: create_virtualenv 06:13:45 INFO - Creating virtualenv /builds/slave/test/build/venv 06:13:45 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 06:13:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:13:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:13:45 INFO - Using real prefix '/usr' 06:13:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:13:46 INFO - Installing distribute.............................................................................................................................................................................................done. 06:13:48 INFO - Installing pip.................done. 06:13:48 INFO - Return code: 0 06:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:13:48 INFO - Reading from file tmpfile_stdout 06:13:48 INFO - Output received: 06:13:48 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) 06:13:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:13:48 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')]} 06:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:48 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')]} 06:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:48 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13:48 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 06:13:48 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 06:13:48 INFO - Using env: {'DISPLAY': ':0', 06:13:48 INFO - 'HOME': '/home/cltbld', 06:13:48 INFO - 'LANG': 'en_US.UTF-8', 06:13:48 INFO - 'LANGUAGE': 'en_US:en', 06:13:48 INFO - 'LOGNAME': 'cltbld', 06:13:48 INFO - 'MAIL': '/var/mail/cltbld', 06:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:48 INFO - 'MOZ_NO_REMOTE': '1', 06:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:48 INFO - 'NO_EM_RESTART': '1', 06:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:48 INFO - 'PWD': '/builds/slave/test', 06:13:48 INFO - 'SHELL': '/bin/bash', 06:13:48 INFO - 'SHLVL': '1', 06:13:48 INFO - 'TERM': 'linux', 06:13:48 INFO - 'TMOUT': '86400', 06:13:48 INFO - 'USER': 'cltbld', 06:13:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:48 INFO - '_': '/tools/buildbot/bin/python'} 06:13:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:48 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 06:13:48 INFO - Cleaning up... 06:13:48 INFO - Return code: 0 06:13:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:13:48 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')]} 06:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:48 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')]} 06:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:48 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13:48 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 06:13:48 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 06:13:48 INFO - Using env: {'DISPLAY': ':0', 06:13:48 INFO - 'HOME': '/home/cltbld', 06:13:48 INFO - 'LANG': 'en_US.UTF-8', 06:13:48 INFO - 'LANGUAGE': 'en_US:en', 06:13:48 INFO - 'LOGNAME': 'cltbld', 06:13:48 INFO - 'MAIL': '/var/mail/cltbld', 06:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:48 INFO - 'MOZ_NO_REMOTE': '1', 06:13:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:48 INFO - 'NO_EM_RESTART': '1', 06:13:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:48 INFO - 'PWD': '/builds/slave/test', 06:13:48 INFO - 'SHELL': '/bin/bash', 06:13:48 INFO - 'SHLVL': '1', 06:13:48 INFO - 'TERM': 'linux', 06:13:48 INFO - 'TMOUT': '86400', 06:13:48 INFO - 'USER': 'cltbld', 06:13:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:48 INFO - '_': '/tools/buildbot/bin/python'} 06:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:49 INFO - Downloading/unpacking psutil>=3.1.1 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:49 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 06:13:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:51 INFO - Installing collected packages: psutil 06:13:51 INFO - Running setup.py install for psutil 06:13:51 INFO - building 'psutil._psutil_linux' extension 06:13:51 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 06:13:51 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 06:13:51 INFO - building 'psutil._psutil_posix' extension 06:13:51 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 06:13:51 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 06:13:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:13:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:13:51 INFO - Successfully installed psutil 06:13:51 INFO - Cleaning up... 06:13:51 INFO - Return code: 0 06:13:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:13:51 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')]} 06:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 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')]} 06:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:51 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13:51 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 06:13:51 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 06:13:51 INFO - Using env: {'DISPLAY': ':0', 06:13:51 INFO - 'HOME': '/home/cltbld', 06:13:51 INFO - 'LANG': 'en_US.UTF-8', 06:13:51 INFO - 'LANGUAGE': 'en_US:en', 06:13:51 INFO - 'LOGNAME': 'cltbld', 06:13:51 INFO - 'MAIL': '/var/mail/cltbld', 06:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:51 INFO - 'MOZ_NO_REMOTE': '1', 06:13:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:51 INFO - 'NO_EM_RESTART': '1', 06:13:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:51 INFO - 'PWD': '/builds/slave/test', 06:13:51 INFO - 'SHELL': '/bin/bash', 06:13:51 INFO - 'SHLVL': '1', 06:13:51 INFO - 'TERM': 'linux', 06:13:51 INFO - 'TMOUT': '86400', 06:13:51 INFO - 'USER': 'cltbld', 06:13:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:51 INFO - '_': '/tools/buildbot/bin/python'} 06:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:13:51 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 06:13:51 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 06:13:51 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 06:13:51 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 06:13:51 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 06:13:51 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 06:13:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:13:54 INFO - Installing collected packages: mozsystemmonitor 06:13:54 INFO - Running setup.py install for mozsystemmonitor 06:13:54 INFO - Successfully installed mozsystemmonitor 06:13:54 INFO - Cleaning up... 06:13:54 INFO - Return code: 0 06:13:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:54 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13:54 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 06:13:54 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 06:13:54 INFO - Using env: {'DISPLAY': ':0', 06:13:54 INFO - 'HOME': '/home/cltbld', 06:13:54 INFO - 'LANG': 'en_US.UTF-8', 06:13:54 INFO - 'LANGUAGE': 'en_US:en', 06:13:54 INFO - 'LOGNAME': 'cltbld', 06:13:54 INFO - 'MAIL': '/var/mail/cltbld', 06:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:54 INFO - 'MOZ_NO_REMOTE': '1', 06:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:54 INFO - 'NO_EM_RESTART': '1', 06:13:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:54 INFO - 'PWD': '/builds/slave/test', 06:13:54 INFO - 'SHELL': '/bin/bash', 06:13:54 INFO - 'SHLVL': '1', 06:13:54 INFO - 'TERM': 'linux', 06:13:54 INFO - 'TMOUT': '86400', 06:13:54 INFO - 'USER': 'cltbld', 06:13:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:54 INFO - '_': '/tools/buildbot/bin/python'} 06:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:54 INFO - Downloading/unpacking jsonschema==2.5.1 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:54 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 06:13:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:13:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:56 INFO - Downloading functools32-3.2.3-2.tar.gz 06:13:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:13:56 INFO - warning: no files found matching '*.txt' 06:13:56 INFO - no previously-included directories found matching 'build' 06:13:56 INFO - no previously-included directories found matching 'dist' 06:13:56 INFO - no previously-included directories found matching '.git*' 06:13:56 INFO - Installing collected packages: jsonschema, functools32 06:13:56 INFO - Running setup.py install for functools32 06:13:56 INFO - warning: no files found matching '*.txt' 06:13:56 INFO - no previously-included directories found matching 'build' 06:13:56 INFO - no previously-included directories found matching 'dist' 06:13:56 INFO - no previously-included directories found matching '.git*' 06:13:56 INFO - Successfully installed jsonschema functools32 06:13:56 INFO - Cleaning up... 06:13:56 INFO - Return code: 0 06:13:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:13:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:13:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:13:56 INFO - Using env: {'DISPLAY': ':0', 06:13:56 INFO - 'HOME': '/home/cltbld', 06:13:56 INFO - 'LANG': 'en_US.UTF-8', 06:13:56 INFO - 'LANGUAGE': 'en_US:en', 06:13:56 INFO - 'LOGNAME': 'cltbld', 06:13:56 INFO - 'MAIL': '/var/mail/cltbld', 06:13:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:56 INFO - 'MOZ_NO_REMOTE': '1', 06:13:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:56 INFO - 'NO_EM_RESTART': '1', 06:13:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:56 INFO - 'PWD': '/builds/slave/test', 06:13:56 INFO - 'SHELL': '/bin/bash', 06:13:56 INFO - 'SHLVL': '1', 06:13:56 INFO - 'TERM': 'linux', 06:13:56 INFO - 'TMOUT': '86400', 06:13:56 INFO - 'USER': 'cltbld', 06:13:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:56 INFO - '_': '/tools/buildbot/bin/python'} 06:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:13:57 INFO - Cleaning up... 06:13:57 INFO - Return code: 0 06:13:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:13: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')]} 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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')]} 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:13: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', '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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:13: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:13: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 blobuploader==1.2.4 06:13:57 INFO - Using env: {'DISPLAY': ':0', 06:13:57 INFO - 'HOME': '/home/cltbld', 06:13:57 INFO - 'LANG': 'en_US.UTF-8', 06:13:57 INFO - 'LANGUAGE': 'en_US:en', 06:13:57 INFO - 'LOGNAME': 'cltbld', 06:13:57 INFO - 'MAIL': '/var/mail/cltbld', 06:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:13:57 INFO - 'MOZ_NO_REMOTE': '1', 06:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:13:57 INFO - 'NO_EM_RESTART': '1', 06:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:13:57 INFO - 'PWD': '/builds/slave/test', 06:13:57 INFO - 'SHELL': '/bin/bash', 06:13:57 INFO - 'SHLVL': '1', 06:13:57 INFO - 'TERM': 'linux', 06:13:57 INFO - 'TMOUT': '86400', 06:13:57 INFO - 'USER': 'cltbld', 06:13:57 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:13:57 INFO - '_': '/tools/buildbot/bin/python'} 06:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:13:57 INFO - Downloading/unpacking blobuploader==1.2.4 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:59 INFO - Downloading blobuploader-1.2.4.tar.gz 06:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:13:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:13:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:13:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:14:00 INFO - Downloading docopt-0.6.1.tar.gz 06:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:14:00 INFO - Installing collected packages: blobuploader, requests, docopt 06:14:00 INFO - Running setup.py install for blobuploader 06:14:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:14:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:14:00 INFO - Running setup.py install for requests 06:14:00 INFO - Running setup.py install for docopt 06:14:00 INFO - Successfully installed blobuploader requests docopt 06:14:00 INFO - Cleaning up... 06:14:00 INFO - Return code: 0 06:14:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:00 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:14:00 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 06:14:00 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 06:14:00 INFO - Using env: {'DISPLAY': ':0', 06:14:00 INFO - 'HOME': '/home/cltbld', 06:14:00 INFO - 'LANG': 'en_US.UTF-8', 06:14:00 INFO - 'LANGUAGE': 'en_US:en', 06:14:00 INFO - 'LOGNAME': 'cltbld', 06:14:00 INFO - 'MAIL': '/var/mail/cltbld', 06:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:00 INFO - 'MOZ_NO_REMOTE': '1', 06:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:00 INFO - 'NO_EM_RESTART': '1', 06:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:00 INFO - 'PWD': '/builds/slave/test', 06:14:00 INFO - 'SHELL': '/bin/bash', 06:14:00 INFO - 'SHLVL': '1', 06:14:00 INFO - 'TERM': 'linux', 06:14:00 INFO - 'TMOUT': '86400', 06:14:00 INFO - 'USER': 'cltbld', 06:14:00 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:00 INFO - '_': '/tools/buildbot/bin/python'} 06:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:00 INFO - Running setup.py (path:/tmp/pip-TSWCfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:01 INFO - Running setup.py (path:/tmp/pip-Jr4VM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:01 INFO - Running setup.py (path:/tmp/pip-paOYvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:01 INFO - Running setup.py (path:/tmp/pip-Nm0UdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:01 INFO - Running setup.py (path:/tmp/pip-ZGOHJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:01 INFO - Running setup.py (path:/tmp/pip-d3zCwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:01 INFO - Running setup.py (path:/tmp/pip-gj59NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:01 INFO - Running setup.py (path:/tmp/pip-hrfSoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:01 INFO - Running setup.py (path:/tmp/pip-7LjsuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:01 INFO - Running setup.py (path:/tmp/pip-kFveaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:01 INFO - Running setup.py (path:/tmp/pip-d27HYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:01 INFO - Running setup.py (path:/tmp/pip-VCFhAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:01 INFO - Running setup.py (path:/tmp/pip-6tID1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:01 INFO - Running setup.py (path:/tmp/pip-FDOwyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:01 INFO - Running setup.py (path:/tmp/pip-BxcDtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:02 INFO - Running setup.py (path:/tmp/pip-QDp13q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:02 INFO - Running setup.py (path:/tmp/pip-miPjA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:14:02 INFO - Running setup.py install for manifestparser 06:14:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Running setup.py install for mozcrash 06:14:02 INFO - Running setup.py install for mozdebug 06:14:02 INFO - Running setup.py install for mozdevice 06:14:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Running setup.py install for mozfile 06:14:02 INFO - Running setup.py install for mozhttpd 06:14:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Running setup.py install for mozinfo 06:14:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Running setup.py install for mozInstall 06:14:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:14:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozleak 06:14:03 INFO - Running setup.py install for mozlog 06:14:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for moznetwork 06:14:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozprocess 06:14:03 INFO - Running setup.py install for mozprofile 06:14:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozrunner 06:14:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Running setup.py install for mozscreenshot 06:14:03 INFO - Running setup.py install for moztest 06:14:03 INFO - Running setup.py install for mozversion 06:14:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:14:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:14:03 INFO - Cleaning up... 06:14:03 INFO - Return code: 0 06:14:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14: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')]} 06:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14: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')]} 06:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:04 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:14:04 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 06:14:04 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 06:14:04 INFO - Using env: {'DISPLAY': ':0', 06:14:04 INFO - 'HOME': '/home/cltbld', 06:14:04 INFO - 'LANG': 'en_US.UTF-8', 06:14:04 INFO - 'LANGUAGE': 'en_US:en', 06:14:04 INFO - 'LOGNAME': 'cltbld', 06:14:04 INFO - 'MAIL': '/var/mail/cltbld', 06:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:04 INFO - 'MOZ_NO_REMOTE': '1', 06:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:04 INFO - 'NO_EM_RESTART': '1', 06:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:04 INFO - 'PWD': '/builds/slave/test', 06:14:04 INFO - 'SHELL': '/bin/bash', 06:14:04 INFO - 'SHLVL': '1', 06:14:04 INFO - 'TERM': 'linux', 06:14:04 INFO - 'TMOUT': '86400', 06:14:04 INFO - 'USER': 'cltbld', 06:14:04 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:04 INFO - '_': '/tools/buildbot/bin/python'} 06:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:14:04 INFO - Running setup.py (path:/tmp/pip-6EOQfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:14:04 INFO - Running setup.py (path:/tmp/pip-28UrOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:14:04 INFO - Running setup.py (path:/tmp/pip-Zd0bSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:14:04 INFO - Running setup.py (path:/tmp/pip-Nh1cNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:14:04 INFO - Running setup.py (path:/tmp/pip-9fAaXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:14:04 INFO - Running setup.py (path:/tmp/pip-HGwMEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:14:04 INFO - Running setup.py (path:/tmp/pip-ln333u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:14:04 INFO - Running setup.py (path:/tmp/pip-riQsR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:14:04 INFO - Running setup.py (path:/tmp/pip-Avapfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:14:04 INFO - Running setup.py (path:/tmp/pip-A3oiS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:14:04 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)) 06:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:14:04 INFO - Running setup.py (path:/tmp/pip-H0_3aJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:14:05 INFO - Running setup.py (path:/tmp/pip-bO7Piy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:14:05 INFO - Running setup.py (path:/tmp/pip-gWxJ17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:14:05 INFO - Running setup.py (path:/tmp/pip-A8Qbtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:05 INFO - Running setup.py (path:/tmp/pip-HROSFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:14:05 INFO - Running setup.py (path:/tmp/pip-LHlLGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:14:05 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)) 06:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:14:05 INFO - Running setup.py (path:/tmp/pip-l1Dnhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:14:05 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)) 06:14:05 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)) 06:14:05 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)) 06:14:05 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)) 06:14:05 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)) 06:14:05 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)) 06:14:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14: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 06:14:07 INFO - Downloading blessings-1.6.tar.gz 06:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:14:07 INFO - Installing collected packages: blessings 06:14:07 INFO - Running setup.py install for blessings 06:14:07 INFO - Successfully installed blessings 06:14:07 INFO - Cleaning up... 06:14:07 INFO - Return code: 0 06:14:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:14:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:07 INFO - Reading from file tmpfile_stdout 06:14:07 INFO - Current package versions: 06:14:07 INFO - argparse == 1.2.1 06:14:07 INFO - blessings == 1.6 06:14:07 INFO - blobuploader == 1.2.4 06:14:07 INFO - docopt == 0.6.1 06:14:07 INFO - functools32 == 3.2.3-2 06:14:07 INFO - jsonschema == 2.5.1 06:14:07 INFO - manifestparser == 1.1 06:14:07 INFO - mozInstall == 1.12 06:14:07 INFO - mozcrash == 1.0 06:14:07 INFO - mozdebug == 0.1 06:14:07 INFO - mozdevice == 0.49 06:14:07 INFO - mozfile == 1.2 06:14:07 INFO - mozhttpd == 0.7 06:14:07 INFO - mozinfo == 0.9 06:14:07 INFO - mozleak == 0.1 06:14:07 INFO - mozlog == 3.4 06:14:07 INFO - moznetwork == 0.27 06:14:07 INFO - mozprocess == 0.24 06:14:07 INFO - mozprofile == 0.28 06:14:07 INFO - mozrunner == 6.13 06:14:07 INFO - mozscreenshot == 0.1 06:14:07 INFO - mozsystemmonitor == 0.3 06:14:07 INFO - moztest == 0.8 06:14:07 INFO - mozversion == 1.4 06:14:07 INFO - psutil == 3.1.1 06:14:07 INFO - requests == 1.2.3 06:14:07 INFO - wsgiref == 0.1.2 06:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:07 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:14:07 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 06:14:07 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 06:14:07 INFO - Using env: {'DISPLAY': ':0', 06:14:07 INFO - 'HOME': '/home/cltbld', 06:14:07 INFO - 'LANG': 'en_US.UTF-8', 06:14:07 INFO - 'LANGUAGE': 'en_US:en', 06:14:07 INFO - 'LOGNAME': 'cltbld', 06:14:07 INFO - 'MAIL': '/var/mail/cltbld', 06:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:07 INFO - 'MOZ_NO_REMOTE': '1', 06:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:07 INFO - 'NO_EM_RESTART': '1', 06:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:07 INFO - 'PWD': '/builds/slave/test', 06:14:07 INFO - 'SHELL': '/bin/bash', 06:14:07 INFO - 'SHLVL': '1', 06:14:07 INFO - 'TERM': 'linux', 06:14:07 INFO - 'TMOUT': '86400', 06:14:07 INFO - 'USER': 'cltbld', 06:14:07 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:07 INFO - '_': '/tools/buildbot/bin/python'} 06:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 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)) 06:14:08 INFO - Cleaning up... 06:14:08 INFO - Return code: 0 06:14:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:08 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 0x1beb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1db8a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f5d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', '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 06:14:08 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 06:14:08 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 06:14:08 INFO - Using env: {'DISPLAY': ':0', 06:14:08 INFO - 'HOME': '/home/cltbld', 06:14:08 INFO - 'LANG': 'en_US.UTF-8', 06:14:08 INFO - 'LANGUAGE': 'en_US:en', 06:14:08 INFO - 'LOGNAME': 'cltbld', 06:14:08 INFO - 'MAIL': '/var/mail/cltbld', 06:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:08 INFO - 'MOZ_NO_REMOTE': '1', 06:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:08 INFO - 'NO_EM_RESTART': '1', 06:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:08 INFO - 'PWD': '/builds/slave/test', 06:14:08 INFO - 'SHELL': '/bin/bash', 06:14:08 INFO - 'SHLVL': '1', 06:14:08 INFO - 'TERM': 'linux', 06:14:08 INFO - 'TMOUT': '86400', 06:14:08 INFO - 'USER': 'cltbld', 06:14:08 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:08 INFO - '_': '/tools/buildbot/bin/python'} 06:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:14:08 INFO - Cleaning up... 06:14:08 INFO - Return code: 0 06:14:08 INFO - Running post-action listener: _resource_record_post_action 06:14:08 INFO - Running post-action listener: _start_resource_monitoring 06:14:08 INFO - Starting resource monitoring. 06:14:08 INFO - [mozharness: 2017-02-09 14:14:08.441614Z] Finished create-virtualenv step (success) 06:14:08 INFO - [mozharness: 2017-02-09 14:14:08.442105Z] Running install step. 06:14:08 INFO - Running pre-action listener: _resource_record_pre_action 06:14:08 INFO - Running main action method: install 06:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:14:08 INFO - Reading from file tmpfile_stdout 06:14:08 INFO - Detecting whether we're running mozinstall >=1.0... 06:14:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:14:08 INFO - Reading from file tmpfile_stdout 06:14:08 INFO - Output received: 06:14:08 INFO - Usage: mozinstall [options] installer 06:14:08 INFO - Options: 06:14:08 INFO - -h, --help show this help message and exit 06:14:08 INFO - -d DEST, --destination=DEST 06:14:08 INFO - Directory to install application into. [default: 06:14:08 INFO - "/builds/slave/test"] 06:14:08 INFO - --app=APP Application being installed. [default: firefox] 06:14:08 INFO - mkdir: /builds/slave/test/build/application 06:14:08 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'] 06:14:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:14:25 INFO - Reading from file tmpfile_stdout 06:14:25 INFO - Output received: 06:14:25 INFO - /builds/slave/test/build/application/firefox/firefox 06:14:25 INFO - Running post-action listener: _resource_record_post_action 06:14:25 INFO - [mozharness: 2017-02-09 14:14:25.150820Z] Finished install step (success) 06:14:25 INFO - [mozharness: 2017-02-09 14:14:25.150945Z] Running run-tests step. 06:14:25 INFO - Running pre-action listener: _resource_record_pre_action 06:14:25 INFO - Running main action method: run_tests 06:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:14:25 INFO - Python 2.7.3 06:14:25 INFO - Return code: 0 06:14:25 INFO - grabbing minidump binary from tooltool 06:14:25 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')]} 06:14:25 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 0x1f5ad00>, '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 0x1f5ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f5beb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:14:25 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 06:14:25 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 06:14:25 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 06:14:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:14:25 INFO - Return code: 0 06:14:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:14:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:14:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:14:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:14:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 06:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 06:14:25 INFO - Using env: {'DISPLAY': ':0', 06:14:25 INFO - 'HOME': '/home/cltbld', 06:14:25 INFO - 'LANG': 'en_US.UTF-8', 06:14:25 INFO - 'LANGUAGE': 'en_US:en', 06:14:25 INFO - 'LOGNAME': 'cltbld', 06:14:25 INFO - 'MAIL': '/var/mail/cltbld', 06:14:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:14:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:25 INFO - 'MOZ_NO_REMOTE': '1', 06:14:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:25 INFO - 'NO_EM_RESTART': '1', 06:14:25 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:25 INFO - 'PWD': '/builds/slave/test', 06:14:25 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:14:25 INFO - 'SHELL': '/bin/bash', 06:14:25 INFO - 'SHLVL': '1', 06:14:25 INFO - 'TERM': 'linux', 06:14:25 INFO - 'TMOUT': '86400', 06:14:25 INFO - 'USER': 'cltbld', 06:14:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211', 06:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:25 INFO - '_': '/tools/buildbot/bin/python'} 06:14:25 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 06:14:25 INFO - mozversion application_buildid: 20170209131207 06:14:25 INFO - mozversion application_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:14:25 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:14:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:14:25 INFO - mozversion application_name: Firefox 06:14:25 INFO - mozversion application_remotingname: firefox-dev 06:14:25 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:14:25 INFO - mozversion application_vendor: Mozilla 06:14:25 INFO - mozversion application_version: 53.0a2 06:14:25 INFO - mozversion platform_buildid: 20170209131207 06:14:25 INFO - mozversion platform_changeset: 1419fa7ee013b44501b90487bf8f8873dbaf3727 06:14:25 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 06:14:25 INFO - mozversion platform_version: 53.0a2 06:14:25 INFO - using testdate: 1486649665 06:14:25 INFO - actual date: 1486649665 06:14:25 INFO - starting webserver on 'localhost:32768' 06:14:25 INFO - SUITE-START | Running 2 tests 06:14:25 INFO - TEST-START | dromaeo_css 06:14:25 INFO - operating with platform_type : linux_ 06:14:25 INFO - Initialising browser for dromaeo_css test... 06:14:25 INFO - TEST-INFO | started process 3953 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8HF5f/profile http://localhost:32768/getInfo.html) 06:14:29 INFO - PROCESS | 3953 | __metrics Screen width/height:1600/1200 06:14:29 INFO - PROCESS | 3953 | colorDepth:24 06:14:29 INFO - PROCESS | 3953 | Browser inner width/height: 1024/697 06:14:29 INFO - PROCESS | 3953 | __metrics 06:14:30 INFO - PROCESS | 3953 | 1486649670166 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 06:14:30 INFO - PROCESS | 3953 | 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" 06:14:30 INFO - PROCESS | 3953 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:14:30 INFO - PROCESS | 3953 | console.error: PushService: 06:14:30 INFO - PROCESS | 3953 | stateChangeProcessEnqueue: Error transitioning state 06:14:30 INFO - PROCESS | 3953 | UnknownError 06:14:31 INFO - TEST-INFO | 3953: exit 0 06:14:31 INFO - Browser initialized. 06:14:31 INFO - Running cycle 1/1 for dromaeo_css test... 06:14:31 INFO - TEST-INFO | started process 4048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpx8HF5f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:14:43 INFO - PROCESS | 4048 | RSS: Main: 137949184 06:14:43 INFO - PROCESS | 4048 | 06:17:43 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32768/tests/dromaeo/cssquery-ext.html) 06:17:44 INFO - PROCESS | 4048 | RSS: Main: 238317568 06:17:44 INFO - PROCESS | 4048 | 06:19:33 INFO - PROCESS | 4048 | ************************* 06:19:33 INFO - PROCESS | 4048 | A coding exception was thrown and uncaught in a Task. 06:19:33 INFO - PROCESS | 4048 | 06:19:33 ERROR - PROCESS | 4048 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:19:33 INFO - PROCESS | 4048 | Full stack: 06:19:33 INFO - PROCESS | 4048 | ************************* 06:20:46 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-ext.html (next: http://localhost:32768/tests/dromaeo/cssquery-jquery.html) 06:20:47 INFO - PROCESS | 4048 | RSS: Main: 232558592 06:20:47 INFO - PROCESS | 4048 | 06:23:49 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32768/tests/dromaeo/cssquery-mootools.html) 06:23:50 INFO - PROCESS | 4048 | RSS: Main: 199946240 06:23:50 INFO - PROCESS | 4048 | 06:26:51 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32768/tests/dromaeo/cssquery-prototype.html) 06:26:52 INFO - PROCESS | 4048 | RSS: Main: 225050624 06:26:52 INFO - PROCESS | 4048 | 06:29:55 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32768/tests/dromaeo/cssquery-yui.html) 06:29:55 INFO - PROCESS | 4048 | RSS: Main: 172957696 06:29:55 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | Cycle 1(1): loaded http://localhost:32768/tests/dromaeo/cssquery-yui.html (next: http://localhost:32768/tests/dromaeo/cssquery-dojo.html) 06:32:58 INFO - PROCESS | 4048 | RSS: Main: 246452224 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | __start_tp_report 06:32:58 INFO - PROCESS | 4048 | _x_x_mozilla_page_load 06:32:58 INFO - PROCESS | 4048 | _x_x_mozilla_page_load_details 06:32:58 INFO - PROCESS | 4048 | |i|pagename|runs| 06:32:58 INFO - PROCESS | 4048 | |0;dojo.html;3266.7549933754967;3301.1417031571814;3313.668633136685;3321.1697075731067;3325.3515564464924;5367.007103685816;5391.110466772982;5439.265699130616;5452.536534394571;5468.507834294913;5516.7517461714315;5593.916091258634;5598.552115830734;5609.382967873531;5609.831705048845;5066.493350664931;5110.744462776865;5116.923246151311;5141.640085194019;5147.562457191143;4950.925736113961;4955.603551715854;5120.103981803189;5154.252633368159;5211.609129315298;5004.824831130911;5018.121828679985;5054.924176137342;5116.309298244727;5133.512316329943;5136.563392111675;5139.588832893378;5140.871478213037;5141.074606570815;5164.612654050924;4860.781264843055;4894;5032.572231360302;5037.798488060474;5125.794968201268;5371.919421208685;5385.461453854583;5410.3507579090365;5496.5053145217125;5504.256925315071;5903.704814759288;5917.20117784098;5922.703864806743;5925.585209035326;5929.64422134669;5904.261967254093;5960.284765828128;5962.373950735154;5962.940370596325;5966.642001479881;5325.174597937326;5375.059364611217;5503.9174412384245;5537.612367134262;5558.249636299048;6059.121427393004;6070.180525629072;6076.3316035236085;6078.179445774764;6096.573239873255;5805.767769289266;5834.299884013945;5837.532997360201;5857.912131318034;5868.647881127146;5688.772449102073;5722.513586345207;5803.88392232153;5804.100364443518;5955.106733989936;5851.590388672752;5891.086881533369;5901.085331773582;5932.377100404482;5939.792107276225;5895.469407753323;5916.822495325147;5922.526197904157;5924.496417804535;5929.792457264061;4374.365716971021;4413.7351758894565;4417.712848664826;4427.048184640254;4437.511873693891;4047.9797601011805;4100.528439229467;4102.2410853992105;4132.214879172948;4135.29699951009;5815.82552523425;5827.067669172912;5832.562557808182;5833.912491312633;5865.296164460292;5659.773609055674;5811.912821307684;5848.941510584925;5905.055191169392;5993.430624090704;5750.654960702372;5802.187693722883;5812.44781745742;5843.3864444233595;5859.501942334864;5072.5688316493515;5087.262346959744;5116.079105760924;5126.231065340229;5131.435542090367;5941.821745347646;6268.341824108494;6274.215723034621;6278.183836101369;6278.748850046039;5716;5739.885202295847;5788.710564471676;5794.304683438015;5845.210896528914;6069.423404776716;6069.544784141119;6095.359987201457;6111.083337499411;6112.32764395925;5711.086226203787;5779.566532509994;5785.045467497984;5788.102844059177;5793.449622285876;5781.219535362672;5784.855378615568;5830.47525722687;5833;5843.2695913010875;5768.1636162757;5770.884582308414;5783.624064435799;5785.595008349544;5786.450287222707;5751.9424805751405;5760.366359700513;5761.5102716269585;5764.538836892954;5765.91351129725;5588.944110558842;5591.18927755465;5682.886342273048;5728.484436400744;5745.339285982165;5851.707414629337;5858.297004359334;5870.735816888336;5871.1486834409625;5893.145493903446;5738.053221218453;5785.450382213683;5793.102069179284;5798.159266906359;5804.332501762351 06:32:58 INFO - PROCESS | 4048 | |1;ext.html;577.3879687531218;584.7047241143223;624.5815303746491;638.1671918146819;683.9179298484182;36930.81534592326;47702;49004.75497622516;49104.50895491044;54206;52058.21912671313;52743.736281318634;52987.205191922054;53045.999999999905;53088.73455632717;8789.560521973908;9447.71656850294;9655;9673.95163024184;9694.515274236295;8763.211310982011;11115.11079113673;11342.43287835609;11344.376059316734;11723.237989530697;11508.42457877107;11584.884151158465;11585.36280504572;11590.942045289805;11612.70968225797;11598.130140239517;11602.419879006058;11668.766624667544;11677.2409793364;11695.5906543271;11352.14858885587;11397.373144477051;11430.314181149075;11459.598914038052;11540.942295288554;48076.27885581684;48421;48493;48523;48525;4300.505441874193;4476.306172543261;4482.7982740776415;4493.955060449386;4680.461746899082;32719;32815.6718432815;32874.342513149604;32922;34160;4450.666200034978;4688.906221875543;4761.952380476186;4805.471398146201;4828.879278018043;271459;373282;373355;373964.99999999726;374839;61980;62363.6881815588;62645;62657.373426266066;62736.37263627397;65774.34225657777;66111.33888661148;66160.6691966537;66215;66404;18792.71810922837;19315.130819112892;19350.225990960203;19353.322633707754;19355.903220483808;13765.449382024806;14086.366113524917;14719;14879.47921822731;15107.093574385572;19246.903765481362;19781.60436791256;19913.402597922086;19953.301634442723;20014.69977950332;7402.925970740332;7444.925550744531;7505.136909255396;7577.242275772489;7746.728864489716;973.5862258540092;975.2149519636619;976.4043933200742;983.6606370802061;998.6354980432235;34955.650443495746;35113.824430877685;35151.14206708902;35516.28967420689;35542.64457355445;1106.8212353843132;1165.9650210493699;1173.4191575170346;1185.4843143232722;1208.4320369426355;18284.54288642768;18395.448136555926;18422.35521756732;18516.722249166272;18569.44291671252;561589;565067;565124;565711;567239;70992.64503677552;71430;71468;71512.64243678749;71722.64138679273;1474.366022610288;1501.4744839306375;1501.6546194375355;1534.5703203103149;1538.2923855026813;33424.66575334215;34766.30467390689;35059.29881402307;35188;35218.64781352256;59595.70202149135;60264.397356027635;60266.69866650639;60304;60312.09531857113;418235;421736;422999;423334;425591;27299.454010920068;31380.215494612818;31780.205494862814;47600.523994759606;48723.5127648719;54982;55067.17399239095;55380;55507.444925550226;56659.150112749165;45155;45869;45886.77056614696;46831;47355.211583073964;45298.32052519149;45967;46821;46845.53154468548;48157.75921120372;46547.30179047249;46596;46819.76590117164;46883.53116468928;46959.53040469688;40949.1810163801;43850.342244865715;44035;44088.55911440845;44211.7759731849;31591.772449692075;31715.20711982219;31844.52233216457;32001.839990799897;32406.351872961935 06:32:58 INFO - PROCESS | 4048 | |2;jquery.html;425.17343904856295;436.11033491676983;437.3265171635681;442.9148585964388;448.7077217613273;20219.292324768638;21281.148754049857;21419.464513387135;21786.564268714617;22006.44983875404;21675.674864877;22591.774082259213;22635.320940371814;22692.88653556734;22817.77182228177;5913.793017244398;6078.787242446527;6258.968705156491;6269.090981807635;6273.435390814826;6919.204291506466;7074.257202993663;7110.182329032175;7114;7119.608421536814;6861.656917154147;6947.930520694779;6989.091418115638;6994.58032518048;7055.365017148456;6897.896531552031;6907.861842763167;6957;7032.331928466813;7046.365827075588;6179.073139029137;6180.412860778219;6185.907211391833;6186.443220110212;6187.969060154671;25393.365165870815;25514.617280740804;25545.361365965815;25558.10546630859;25752.613710794354;2778.9305267368277;3358.9496157557655;3376.324735052999;3413.0955296846355;3434.862605495777;11235.606753763579;11487.540498380054;11681.591144309908;11684.298942063504;11886.346250956194;2048.4059622709547;2075.0973326602975;2084.5622419291967;2085.614161380134;2123.2993112273066;74656.25343746548;75592.1000079881;90996.54501727516;92042.5397873013;94931;12484.81272780909;12572.30852303132;12626.621201363974;12823.935880320725;13016.934915325362;18220.63558728818;18344;18347;18370.448886533424;18401.63196736058;9301.116393942564;9311.813763724687;9364.204042656314;9470.431774093438;9585.760355991157;8803.251723603438;8814.162654547808;8815.294776417872;9071.909280907239;9097.226735727405;5365.490278423622;5373.892522149613;5409.56723462122;5522.116461366162;5564.137558678412;2154.310620601424;2192.6382146945575;2218.7226596675414;2223.12186686258;2239.0595949701164;1057.39728354837;1060.4273692206277;1084.6095405653957;1087.3693257910393;1128.8814674459227;20204.39386818398;20428.591428171352;20979.685304720442;22096.668549971764;22957.655635165487;1052.147760314148;1064.5848119233506;1070.29895418501;1079.9460026998618;1100.5707773968159;11408.693572019616;11473.196876218752;11715.707107322385;11738.06095512357;11852.340672305883;690687;703887;721514;722378;731229;82249.17750822415;92494;103598.48200758948;113489.4325528367;114371.42814285876;1197.383347575999;1204.3556697167148;1214.2168301445517;1215.1858254969193;1218.8354572132648;18985.24059037623;19483.123259453074;19786.505337366107;19801.405957821287;19826.50433739168;47301.52698472971;47660.285095724284;47807;49127.508724912295;49249.75375123245;67867;68158.65920670365;68340.31659683339;68754;68967.65516172387;9604.75988100303;9765.511724413893;9769.951150244488;9921.156701680438;9945.254105941938;11944.522219111139;14400.567982960529;14664.266786660412;14873.256337182882;15022.549323520312;12303.507859685513;12384.318862462651;12404.937975310066;12497.500099995897;12551.748965020832;12165.574204902787;12196.57311994076;12426.378681066091;12577.182483138567;12953.417096230503;12379.442925068213;12698.174618649758;12935.288559129338;12948.15836970594;13028.804567931298;9471.47906865129;9711.56297966579;9746;9859.605615775288;9940.204783617148;11841.467133979164;12569.685757856127;12600.936995314965;12648.810267845805;12692.17500862441 06:32:58 INFO - PROCESS | 4048 | |3;mootools.html;1499.182945294815;1504.811898512686;1508.6228442889278;1527.1058800059845;1537.223702030475;8326.250637442628;8982.371234013606;8989.820203595924;8992.235659968894;9011.188992990637;7768.495047821888;7934.365250779938;7948.920510794905;8217.46586471879;8722.127787221274;2311.433698743806;2401.087586717054;2404.086447150089;2413.0589070262613;2426.9514609707794;2370.9407264818346;2393.102586530051;2433.0267892842917;2454.8895299711467;2459.225344016638;2399.784019438259;2399.7960173385195;2417.0815090265673;2428.4778772563895;2428.9149879754214;2399;2408.421978725093;2414.0464516515967;2415.2754173747803;2421.994872128065;2334.498082912182;2406.855588664686;2409.2531315292317;2410.7468715784767;2411.963820542693;8916.242119419858;8920.197182253563;8942.687005954826;8946.418482798597;8962.193402593797;5133.948660513384;5254.579633629301;5254.632175747699;5254.789808407659;5255.842324730264;3332.933341333184;3384;3503.2468019375956;3506.1234691327168;3530.894073177809;1461.897667163299;1500.2573726005587;1524.3369134426448;1556.922153892301;1578.723723348421;12035.879641203652;12102.273863568214;12112.81830772539;12132;12154.817677734842;4713.95286047142;4843.903121937541;4902.093112774148;4911.631627627942;4930.654854160174;10024.498775061218;10048.497575121215;10066.647667331608;10077.59689612422;10083.344582602107;5535.086710692771;5536.197251398525;5543.52880005204;5543.584231182677;5553.333599967949;4529.977350113294;4646.605038571692;4891.1685013547785;5002.924956125661;5065.088284108822;3893.474380958591;3910.9413358799643;4017.979910100489;4021.1354558770004;4021.7184797063924;1206.324458303353;1211.1037832004254;1211.7697637448857;1221.462556475166;1221.9327936963375;1031.1905154453718;1037.9636712715019;1039.1790485516358;1046.6336782126195;1052.55792567122;6042.667653279112;6062;6112.235970503687;6115.143879856823;6277.466415354655;1065.8454524094118;1071.983920241197;1075.2204651627508;1099.6041425086962;1106.4301884529473;3957.782321972319;4181.874543763692;4185.24665560196;4185.602367775056;4202.579742025834;10534.420606866695;10817.242793004572;10817.891821081847;10835.349879007284;10872.728181795519;10533.631322903815;10564.10205132557;10629.362238265729;10664.78670426587;10723.410212438392;8155.959220203861;8250.752477425687;8260.463069900437;8290.834183316421;8310.293625041819;5697.601167918372;5967.134765458897;6051.939480605138;6065.120557519047;6190.542669671483;8999.865002024844;9105.77235569116;9140.63437462494;9154.40496367734;9471.952640236756;9690.148714648423;9806.85289720669;9996.950015249877;10032.949835250776;10138.188944884245;7232.276772322725;7884.802879927818;8256.752297431087;8400.243978042006;8434.789130271793;8261.545614991233;8609.139086091342;8612.052674205706;8616.35377346689;8617.569121543773;7557.659905304385;7621.923780762121;7656.157822639617;7679.385649147943;7725.49784264021;7586.279303466162;7622.504537205064;7701.653425595974;7730.7680769577;7760.068791745027;6873.553219040747;6891.414229790524;6892.931070689229;6898.448124150156;6903.5167538273845;5269.604779641466;5336.412994570672;5364.731763411892;5474.069408200536;5496.80761173357;5376.516113549643;5420.566354691694;5432.266644003167;5484.588655850907;5489.039418101736 06:32:58 INFO - PROCESS | 4048 | |4;prototype.html;407.8205589540604;412.6595558664101;412.71151465125877;426.4882141430284;428.76417970116427;5225.7861415229645;5274.5780337573;5284.6300758946845;5299.675081229692;5308.416074231836;5022.1167062351615;5147;5166.4575219601875;5179.404368497624;5289.629725919187;4169.62473377396;4260.31834906415;4272.530021697611;4281.165172791307;4285.742855428669;4268.445102136718;4284.143171365724;4302.505211900624;4316.654667626598;4317.525072242051;3977.7613343199355;4134.111166099288;4174.436451079096;4262.124665147326;4286;4135.669146468275;4136.73111247768;4154.584541545852;4165.396017577449;4172.916541669165;3694.685951694109;3700.777953322809;3704.481372607837;3707.703383729295;3721.106934335767;5022.84931452057;5032.547070763649;5123.180291153398;5138.3833939927445;5140.383154021504;4778.856634300942;4787.8563643090765;4788.9521104788855;4809.711417314972;4828.830990915301;5497.725113744297;5515.365732940723;5520.641158324696;5527.585431092644;5546.500814926636;3898.401655321333;4125.452955141822;4126.360414135814;4138.689598280141;4140.792960352001;5670.716464176816;5695;5707.942920570783;5709.914351284734;5724.799632012901;4199.9550326014005;4209.137126888981;4213.199492096492;4216.072464057902;4221.113566151082;4194.895127621773;4266.679999000087;4287.421198138211;4288.699791014599;4290.978545107255;4756.286557016475;4761.738104404221;4773.76131193439;4784.856454306377;4787.305840653085;5460.532561823192;5542.198785394682;5579.609427340129;5597.496225339739;5600.887982240332;1342.4764341906664;1348.3932230496316;1354.952576659832;1359.714459963399;1362.6048445950762;927.1192367251003;950.0594411532533;952.3333666433385;975.9024097590184;989.8666027398732;5191.195364718475;5200.2979597754575;5201.323827902348;5206.453322401093;5215.24378965048;5443.775150591086;5446.945530544723;5450.454954504517;5474.616776825584;5551.278333816578;5203.401608815035;5463.890722185534;5492.286002819687;5527.53015993637;5549.694766787785;2917.5040243158714;2925.429541239438;2928.813830398692;2945.749611283022;2960.564126398695;5617.21359009739;5725.198472213893;5806.44838740319;5839.854003649943;5873.676947767828;5584.944150558524;5588.497035266845;5599.580031497654;5603.8599035023635;5631.7184140793615;5756.186801157622;5763.971180144073;5776.711164441761;5782.450667186695;5785.161151633074;5312.707801070824;5447.945520544744;5467.835964921059;5483.314585676791;5535.806246781343;5428.918566221589;5432.782688692408;5440.619156658996;5459.235707001102;5461.590380721541;5448.065936592453;5738.311402631711;5744.540436764965;5789.33422656383;5812.622179558315;4033.8939016957365;4047.2917239483563;4059.959400405958;4079.5920407958965;4082.3672330788777;5488.890222195454;5498.185598752322;5504.669719816824;5508.44915508446;5519.448055194448;5166.819161329336;5249.7375131242525;5330.120530112488;5347.171188465794;5376.59675524345;5350.117230657053;5360.3299587551555;5364.275822764033;5396.622236443412;5415.187721841755;5287.10119279731;5332.253484512094;5385.27298814655;5404.702741349263;5456.945430545644;5441.591880609049;5460.3618914326335;5465.988792073479;5470.288862448016;5473.425290344457;5351.491608297206;5371.140617501181;5400.297961265011;5414.945850541444;5428.37573679032 06:32:58 INFO - PROCESS | 4048 | |5;yui.html;862.133555776445;873.7990262239684;877.6357811508225;930.8743319651848;944.1266828183931;15769.21153942304;16324.265408056637;16550.7517387239;16577.005379677226;16831.410900618466;15450.5364839055;15597.376104955816;15859;16283.104429256386;16418.83581164188;703.7501686901153;825.8637324841409;840.684743221292;843.7257891185359;843.8143608406141;738.3023043224156;823.7158180427742;840.9621567029468;849.8980122385323;851.3146916732028;867.9566021698921;868.917452841979;869.5695630662831;870.0255713600776;870.4037734152095;748.5695724958116;870.8388948044632;870.9303255739526;871.1941454154913;871.3900269811157;564.8672561947939;631.3181763695198;641.4034947498824;649.3701109923367;649.399305642279;14835.629109272246;14864.925675371662;14910.776338354934;14918;15159.24203789806;15481.762127627895;15573.221338933121;15870;15906;15984.680306393924;14011.159330440207;14200;14281.500147494891;14283.428662853474;14440.711185776225;4548.795304211285;4636.281376386665;4656.092062047902;4701.7414042227665;4780.641451891122;82577.17422825754;83308.58345708293;84824.57587712022;86890.13109868947;87057;11380.317180969168;11461.255018423775;11491.942540287246;11518.251313664585;11677.240979336317;22940.88529557375;23149.189778357675;23277.650835237484;23376.181833635743;23534.64698029531;8422.115677853737;8440.366972477088;8498.277646400002;8524.957375213084;8669.046404895456;4778.354922085544;4802;4838.95161048385;4896.143174944371;4925.605951523869;3677.485152078711;3788.886333410002;3795.16506368604;3815.2178803345246;3819.8731374244667;625.4464798653133;633.87956288306;636.3509220594967;637.8469167399884;638.5211091681239;773.6866569039436;775.2015424113173;776.1888826176659;782.2881178127876;801.2428255298687;10406.635767748092;10933.234673572773;11105.888941110647;11613.76772464563;11652.592159274385;772.7527191298731;775.848709501653;781.5857595474407;782.6556315221285;792.4492477727923;5206.261868094096;5231.3199284092825;5294.470552944675;5302.734863256822;5346.866328341823;67816.66091669608;69708.30291697018;71231.6438417815;80245;87831.1692856899;59145.40854591485;59794.402055978884;63997.36002640007;68454.65772671204;69433.65283173551;64646.67676661586;64774.352256477774;64829.67585162044;65281.02078468827;65883;10665.200109991627;10941.835872461761;11028.28316159447;11104.167187460811;11212.775744484901;37881.431778523896;37993;38486;42138.78930605327;43869.341959871264;52152.21771673504;52740.736296318275;52874.942501148995;57816.421835782785;59758.701206493686;14468.204248766418;14616.488422905148;14708.043977141451;14711.852881471048;14931.701365972836;15606.21968901573;15880.682386352439;16295.51113466598;16608.667826643643;17802.37691680785;15391.153486558347;15478.690426191188;15852.603684907508;15903.681926361176;16597.668046639243;15151.469698560939;15476.226188690296;15711.607209819846;15967.281472334005;16660.41688540895;15117.244137793286;15214.847851521343;15327.770083448535;15824;16301.59246018859;11551.595694150665;11638.301701897914;11770.82343764827;11890.940545297219;12145.514179433078;13023.739525209632;13287.678743202545;13294.800577991531;13364;13461.461541538229 06:32:58 INFO - PROCESS | 4048 | __end_tp_report 06:32:58 INFO - PROCESS | 4048 | __start_cc_report 06:32:58 INFO - PROCESS | 4048 | _x_x_mozilla_cycle_collect,942 06:32:58 INFO - PROCESS | 4048 | __end_cc_report 06:32:58 INFO - PROCESS | 4048 | __startTimestamp1486650778822__endTimestamp 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | ------- Summary: start ------- 06:32:58 INFO - PROCESS | 4048 | Number of tests: 6 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#0] dojo.html Cycles:165 Average:5504.47 Median:5765.91 stddev:609.44 (10.6%) stddev-sans-first:585.48 06:32:58 INFO - PROCESS | 4048 | Values: 3266.8 3301.1 3313.7 3321.2 3325.4 5367.0 5391.1 5439.3 5452.5 5468.5 5516.8 5593.9 5598.6 5609.4 5609.8 5066.5 5110.7 5116.9 5141.6 5147.6 4950.9 4955.6 5120.1 5154.3 5211.6 5004.8 5018.1 5054.9 5116.3 5133.5 5136.6 5139.6 5140.9 5141.1 5164.6 4860.8 4894.0 5032.6 5037.8 5125.8 5371.9 5385.5 5410.4 5496.5 5504.3 5903.7 5917.2 5922.7 5925.6 5929.6 5904.3 5960.3 5962.4 5962.9 5966.6 5325.2 5375.1 5503.9 5537.6 5558.2 6059.1 6070.2 6076.3 6078.2 6096.6 5805.8 5834.3 5837.5 5857.9 5868.6 5688.8 5722.5 5803.9 5804.1 5955.1 5851.6 5891.1 5901.1 5932.4 5939.8 5895.5 5916.8 5922.5 5924.5 5929.8 4374.4 4413.7 4417.7 4427.0 4437.5 4048.0 4100.5 4102.2 4132.2 4135.3 5815.8 5827.1 5832.6 5833.9 5865.3 5659.8 5811.9 5848.9 5905.1 5993.4 5750.7 5802.2 5812.4 5843.4 5859.5 5072.6 5087.3 5116.1 5126.2 5131.4 5941.8 6268.3 6274.2 6278.2 6278.7 5716.0 5739.9 5788.7 5794.3 5845.2 6069.4 6069.5 6095.4 6111.1 6112.3 5711.1 5779.6 5785.0 5788.1 5793.4 5781.2 5784.9 5830.5 5833.0 5843.3 5768.2 5770.9 5783.6 5785.6 5786.5 5751.9 5760.4 5761.5 5764.5 5765.9 5588.9 5591.2 5682.9 5728.5 5745.3 5851.7 5858.3 5870.7 5871.1 5893.1 5738.1 5785.5 5793.1 5798.2 5804.3 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#1] ext.html Cycles:180 Average:64119.87 Median:4479.55 stddev:120527.39 (2690.6%) stddev-sans-first:120771.07 06:32:58 INFO - PROCESS | 4048 | Values: 577.4 584.7 624.6 638.2 683.9 36930.8 47702.0 49004.8 49104.5 54206.0 52058.2 52743.7 52987.2 53046.0 53088.7 8789.6 9447.7 9655.0 9674.0 9694.5 8763.2 11115.1 11342.4 11344.4 11723.2 11508.4 11584.9 11585.4 11590.9 11612.7 11598.1 11602.4 11668.8 11677.2 11695.6 11352.1 11397.4 11430.3 11459.6 11540.9 48076.3 48421.0 48493.0 48523.0 48525.0 4300.5 4476.3 4482.8 4494.0 4680.5 32719.0 32815.7 32874.3 32922.0 34160.0 4450.7 4688.9 4762.0 4805.5 4828.9 271459.0 373282.0 373355.0 373965.0 374839.0 61980.0 62363.7 62645.0 62657.4 62736.4 65774.3 66111.3 66160.7 66215.0 66404.0 18792.7 19315.1 19350.2 19353.3 19355.9 13765.4 14086.4 14719.0 14879.5 15107.1 19246.9 19781.6 19913.4 19953.3 20014.7 7402.9 7444.9 7505.1 7577.2 7746.7 973.6 975.2 976.4 983.7 998.6 34955.7 35113.8 35151.1 35516.3 35542.6 1106.8 1166.0 1173.4 1185.5 1208.4 18284.5 18395.4 18422.4 18516.7 18569.4 561589.0 565067.0 565124.0 565711.0 567239.0 70992.6 71430.0 71468.0 71512.6 71722.6 1474.4 1501.5 1501.7 1534.6 1538.3 33424.7 34766.3 35059.3 35188.0 35218.6 59595.7 60264.4 60266.7 60304.0 60312.1 418235.0 421736.0 422999.0 423334.0 425591.0 27299.5 31380.2 31780.2 47600.5 48723.5 54982.0 55067.2 55380.0 55507.4 56659.2 45155.0 45869.0 45886.8 46831.0 47355.2 45298.3 45967.0 46821.0 46845.5 48157.8 46547.3 46596.0 46819.8 46883.5 46959.5 40949.2 43850.3 44035.0 44088.6 44211.8 31591.8 31715.2 31844.5 32001.8 32406.4 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#2] jquery.html Cycles:180 Average:37066.95 Median:22755.33 stddev:116988.59 (514.1%) stddev-sans-first:117284.42 06:32:58 INFO - PROCESS | 4048 | Values: 425.2 436.1 437.3 442.9 448.7 20219.3 21281.1 21419.5 21786.6 22006.4 21675.7 22591.8 22635.3 22692.9 22817.8 5913.8 6078.8 6259.0 6269.1 6273.4 6919.2 7074.3 7110.2 7114.0 7119.6 6861.7 6947.9 6989.1 6994.6 7055.4 6897.9 6907.9 6957.0 7032.3 7046.4 6179.1 6180.4 6185.9 6186.4 6188.0 25393.4 25514.6 25545.4 25558.1 25752.6 2778.9 3358.9 3376.3 3413.1 3434.9 11235.6 11487.5 11681.6 11684.3 11886.3 2048.4 2075.1 2084.6 2085.6 2123.3 74656.3 75592.1 90996.5 92042.5 94931.0 12484.8 12572.3 12626.6 12823.9 13016.9 18220.6 18344.0 18347.0 18370.4 18401.6 9301.1 9311.8 9364.2 9470.4 9585.8 8803.3 8814.2 8815.3 9071.9 9097.2 5365.5 5373.9 5409.6 5522.1 5564.1 2154.3 2192.6 2218.7 2223.1 2239.1 1057.4 1060.4 1084.6 1087.4 1128.9 20204.4 20428.6 20979.7 22096.7 22957.7 1052.1 1064.6 1070.3 1079.9 1100.6 11408.7 11473.2 11715.7 11738.1 11852.3 690687.0 703887.0 721514.0 722378.0 731229.0 82249.2 92494.0 103598.5 113489.4 114371.4 1197.4 1204.4 1214.2 1215.2 1218.8 18985.2 19483.1 19786.5 19801.4 19826.5 47301.5 47660.3 47807.0 49127.5 49249.8 67867.0 68158.7 68340.3 68754.0 68967.7 9604.8 9765.5 9770.0 9921.2 9945.3 11944.5 14400.6 14664.3 14873.3 15022.5 12303.5 12384.3 12404.9 12497.5 12551.7 12165.6 12196.6 12426.4 12577.2 12953.4 12379.4 12698.2 12935.3 12948.2 13028.8 9471.5 9711.6 9746.0 9859.6 9940.2 11841.5 12569.7 12600.9 12648.8 12692.2 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#3] mootools.html Cycles:180 Average:5806.57 Median:4867.54 stddev:3174.19 (65.2%) stddev-sans-first:3166.58 06:32:58 INFO - PROCESS | 4048 | Values: 1499.2 1504.8 1508.6 1527.1 1537.2 8326.3 8982.4 8989.8 8992.2 9011.2 7768.5 7934.4 7948.9 8217.5 8722.1 2311.4 2401.1 2404.1 2413.1 2427.0 2370.9 2393.1 2433.0 2454.9 2459.2 2399.8 2399.8 2417.1 2428.5 2428.9 2399.0 2408.4 2414.0 2415.3 2422.0 2334.5 2406.9 2409.3 2410.7 2412.0 8916.2 8920.2 8942.7 8946.4 8962.2 5133.9 5254.6 5254.6 5254.8 5255.8 3332.9 3384.0 3503.2 3506.1 3530.9 1461.9 1500.3 1524.3 1556.9 1578.7 12035.9 12102.3 12112.8 12132.0 12154.8 4714.0 4843.9 4902.1 4911.6 4930.7 10024.5 10048.5 10066.6 10077.6 10083.3 5535.1 5536.2 5543.5 5543.6 5553.3 4530.0 4646.6 4891.2 5002.9 5065.1 3893.5 3910.9 4018.0 4021.1 4021.7 1206.3 1211.1 1211.8 1221.5 1221.9 1031.2 1038.0 1039.2 1046.6 1052.6 6042.7 6062.0 6112.2 6115.1 6277.5 1065.8 1072.0 1075.2 1099.6 1106.4 3957.8 4181.9 4185.2 4185.6 4202.6 10534.4 10817.2 10817.9 10835.3 10872.7 10533.6 10564.1 10629.4 10664.8 10723.4 8156.0 8250.8 8260.5 8290.8 8310.3 5697.6 5967.1 6051.9 6065.1 6190.5 8999.9 9105.8 9140.6 9154.4 9472.0 9690.1 9806.9 9997.0 10032.9 10138.2 7232.3 7884.8 8256.8 8400.2 8434.8 8261.5 8609.1 8612.1 8616.4 8617.6 7557.7 7621.9 7656.2 7679.4 7725.5 7586.3 7622.5 7701.7 7730.8 7760.1 6873.6 6891.4 6892.9 6898.4 6903.5 5269.6 5336.4 5364.7 5474.1 5496.8 5376.5 5420.6 5432.3 5484.6 5489.0 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#4] prototype.html Cycles:180 Average:4639.59 Median:5288.37 stddev:1321.42 (25.0%) stddev-sans-first:1286.39 06:32:58 INFO - PROCESS | 4048 | Values: 407.8 412.7 412.7 426.5 428.8 5225.8 5274.6 5284.6 5299.7 5308.4 5022.1 5147.0 5166.5 5179.4 5289.6 4169.6 4260.3 4272.5 4281.2 4285.7 4268.4 4284.1 4302.5 4316.7 4317.5 3977.8 4134.1 4174.4 4262.1 4286.0 4135.7 4136.7 4154.6 4165.4 4172.9 3694.7 3700.8 3704.5 3707.7 3721.1 5022.8 5032.5 5123.2 5138.4 5140.4 4778.9 4787.9 4789.0 4809.7 4828.8 5497.7 5515.4 5520.6 5527.6 5546.5 3898.4 4125.5 4126.4 4138.7 4140.8 5670.7 5695.0 5707.9 5709.9 5724.8 4200.0 4209.1 4213.2 4216.1 4221.1 4194.9 4266.7 4287.4 4288.7 4291.0 4756.3 4761.7 4773.8 4784.9 4787.3 5460.5 5542.2 5579.6 5597.5 5600.9 1342.5 1348.4 1355.0 1359.7 1362.6 927.1 950.1 952.3 975.9 989.9 5191.2 5200.3 5201.3 5206.5 5215.2 5443.8 5446.9 5450.5 5474.6 5551.3 5203.4 5463.9 5492.3 5527.5 5549.7 2917.5 2925.4 2928.8 2945.7 2960.6 5617.2 5725.2 5806.4 5839.9 5873.7 5584.9 5588.5 5599.6 5603.9 5631.7 5756.2 5764.0 5776.7 5782.5 5785.2 5312.7 5447.9 5467.8 5483.3 5535.8 5428.9 5432.8 5440.6 5459.2 5461.6 5448.1 5738.3 5744.5 5789.3 5812.6 4033.9 4047.3 4060.0 4079.6 4082.4 5488.9 5498.2 5504.7 5508.4 5519.4 5166.8 5249.7 5330.1 5347.2 5376.6 5350.1 5360.3 5364.3 5396.6 5415.2 5287.1 5332.3 5385.3 5404.7 5456.9 5441.6 5460.4 5466.0 5470.3 5473.4 5351.5 5371.1 5400.3 5414.9 5428.4 06:32:58 INFO - PROCESS | 4048 | 06:32:58 INFO - PROCESS | 4048 | [#5] yui.html Cycles:180 Average:18233.79 Median:4592.54 stddev:22321.55 (486.0%) stddev-sans-first:22346.05 06:32:58 INFO - PROCESS | 4048 | Values: 862.1 873.8 877.6 930.9 944.1 15769.2 16324.3 16550.8 16577.0 16831.4 15450.5 15597.4 15859.0 16283.1 16418.8 703.8 825.9 840.7 843.7 843.8 738.3 823.7 841.0 849.9 851.3 868.0 868.9 869.6 870.0 870.4 748.6 870.8 870.9 871.2 871.4 564.9 631.3 641.4 649.4 649.4 14835.6 14864.9 14910.8 14918.0 15159.2 15481.8 15573.2 15870.0 15906.0 15984.7 14011.2 14200.0 14281.5 14283.4 14440.7 4548.8 4636.3 4656.1 4701.7 4780.6 82577.2 83308.6 84824.6 86890.1 87057.0 11380.3 11461.3 11491.9 11518.3 11677.2 22940.9 23149.2 23277.7 23376.2 23534.6 8422.1 8440.4 8498.3 8525.0 8669.0 4778.4 4802.0 4839.0 4896.1 4925.6 3677.5 3788.9 3795.2 3815.2 3819.9 625.4 633.9 636.4 637.8 638.5 773.7 775.2 776.2 782.3 801.2 10406.6 10933.2 11105.9 11613.8 11652.6 772.8 775.8 781.6 782.7 792.4 5206.3 5231.3 5294.5 5302.7 5346.9 67816.7 69708.3 71231.6 80245.0 87831.2 59145.4 59794.4 63997.4 68454.7 69433.7 64646.7 64774.4 64829.7 65281.0 65883.0 10665.2 10941.8 11028.3 11104.2 11212.8 37881.4 37993.0 38486.0 42138.8 43869.3 52152.2 52740.7 52874.9 57816.4 59758.7 14468.2 14616.5 14708.0 14711.9 14931.7 15606.2 15880.7 16295.5 16608.7 17802.4 15391.2 15478.7 15852.6 15903.7 16597.7 15151.5 15476.2 15711.6 15967.3 16660.4 15117.2 15214.8 15327.8 15824.0 16301.6 11551.6 11638.3 11770.8 11890.9 12145.5 13023.7 13287.7 13294.8 13364.0 13461.5 06:32:58 INFO - PROCESS | 4048 | -------- Summary: end -------- 06:32:58 INFO - PROCESS | 4048 | 06:32:59 INFO - TEST-INFO | 4048: exit 0 06:32:59 INFO - TEST-OK | dromaeo_css | took 1114136ms 06:32:59 INFO - TEST-START | kraken 06:32:59 INFO - operating with platform_type : linux_ 06:32:59 INFO - Initialising browser for kraken test... 06:32:59 INFO - TEST-INFO | started process 4375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCUlEM/profile http://localhost:32768/getInfo.html) 06:33:03 INFO - PROCESS | 4375 | __metrics Screen width/height:1600/1200 06:33:03 INFO - PROCESS | 4375 | colorDepth:24 06:33:03 INFO - PROCESS | 4375 | Browser inner width/height: 1024/697 06:33:03 INFO - PROCESS | 4375 | __metrics 06:33:04 INFO - PROCESS | 4375 | 1486650784710 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 06:33:04 INFO - PROCESS | 4375 | 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" 06:33:04 INFO - PROCESS | 4375 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:33:05 INFO - TEST-INFO | 4375: exit 0 06:33:05 INFO - Browser initialized. 06:33:05 INFO - Running cycle 1/1 for kraken test... 06:33:05 INFO - TEST-INFO | started process 4469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfCUlEM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:33:17 INFO - PROCESS | 4469 | RSS: Main: 138059776 06:33:17 INFO - PROCESS | 4469 | 06:33:20 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32768/tests/kraken/driver.html?testName=audio-beat-detection) 06:33:20 INFO - PROCESS | 4469 | RSS: Main: 182333440 06:33:20 INFO - PROCESS | 4469 | 06:33:23 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32768/tests/kraken/driver.html?testName=audio-dft) 06:33:24 INFO - PROCESS | 4469 | RSS: Main: 172277760 06:33:24 INFO - PROCESS | 4469 | 06:33:26 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32768/tests/kraken/driver.html?testName=audio-fft) 06:33:27 INFO - PROCESS | 4469 | RSS: Main: 263270400 06:33:27 INFO - PROCESS | 4469 | 06:33:29 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32768/tests/kraken/driver.html?testName=audio-oscillator) 06:33:30 INFO - PROCESS | 4469 | RSS: Main: 170389504 06:33:30 INFO - PROCESS | 4469 | 06:33:32 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32768/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:33:32 INFO - PROCESS | 4469 | RSS: Main: 172900352 06:33:32 INFO - PROCESS | 4469 | 06:33:35 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32768/tests/kraken/driver.html?testName=imaging-darkroom) 06:33:36 INFO - PROCESS | 4469 | RSS: Main: 212434944 06:33:36 INFO - PROCESS | 4469 | 06:33:39 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32768/tests/kraken/driver.html?testName=imaging-desaturate) 06:33:40 INFO - PROCESS | 4469 | RSS: Main: 210186240 06:33:40 INFO - PROCESS | 4469 | 06:33:42 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32768/tests/kraken/driver.html?testName=json-parse-financial) 06:33:43 INFO - PROCESS | 4469 | RSS: Main: 208044032 06:33:43 INFO - PROCESS | 4469 | 06:33:45 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32768/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:33:45 INFO - PROCESS | 4469 | RSS: Main: 171200512 06:33:45 INFO - PROCESS | 4469 | 06:33:47 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:33:48 INFO - PROCESS | 4469 | RSS: Main: 177942528 06:33:48 INFO - PROCESS | 4469 | 06:33:49 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:33:50 INFO - PROCESS | 4469 | RSS: Main: 187248640 06:33:50 INFO - PROCESS | 4469 | 06:33:53 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:33:53 INFO - PROCESS | 4469 | RSS: Main: 196861952 06:33:53 INFO - PROCESS | 4469 | 06:33:56 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:33:57 INFO - PROCESS | 4469 | RSS: Main: 193130496 06:33:57 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | Cycle 1(1): loaded http://localhost:32768/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32768/tests/kraken/driver.html?testName=ai-astar) 06:33:58 INFO - PROCESS | 4469 | RSS: Main: 244584448 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | __start_tp_report 06:33:58 INFO - PROCESS | 4469 | _x_x_mozilla_page_load 06:33:58 INFO - PROCESS | 4469 | _x_x_mozilla_page_load_details 06:33:58 INFO - PROCESS | 4469 | |i|pagename|runs| 06:33:58 INFO - PROCESS | 4469 | |0;ai-astar;111;114;112;112;112;113;114;113;111;115 06:33:58 INFO - PROCESS | 4469 | |1;audio-beat-detection;142;118;118;160;119;118;123;119;137;130 06:33:58 INFO - PROCESS | 4469 | |2;audio-dft;161;159;160;160;160;160;160;160;162;159 06:33:58 INFO - PROCESS | 4469 | |3;audio-fft;75;75;75;107;76;75;76;76;98;76 06:33:58 INFO - PROCESS | 4469 | |4;audio-oscillator;83;81;111;84;82;82;91;82;82;107 06:33:58 INFO - PROCESS | 4469 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;117;117;117 06:33:58 INFO - PROCESS | 4469 | |6;imaging-darkroom;146;146;147;147;148;146;146;145;146;145 06:33:58 INFO - PROCESS | 4469 | |7;imaging-desaturate;96;96;96;97;95;95;95;96;95;96 06:33:58 INFO - PROCESS | 4469 | |8;json-parse-financial;49;50;49;49;49;59;49;50;49;53 06:33:58 INFO - PROCESS | 4469 | |9;json-stringify-tinderbox;65;65;65;67;65;64;64;65;64;65 06:33:58 INFO - PROCESS | 4469 | |10;stanford-crypto-aes;76;75;76;75;75;83;75;78;80;75 06:33:58 INFO - PROCESS | 4469 | |11;stanford-crypto-ccm;125;128;121;124;124;122;131;129;159;121 06:33:58 INFO - PROCESS | 4469 | |12;stanford-crypto-pbkdf2;156;156;156;162;158;155;159;157;160;156 06:33:58 INFO - PROCESS | 4469 | |13;stanford-crypto-sha256-iterative;62;61;60;61;60;60;61;59;58;60 06:33:58 INFO - PROCESS | 4469 | __end_tp_report 06:33:58 INFO - PROCESS | 4469 | __start_cc_report 06:33:58 INFO - PROCESS | 4469 | _x_x_mozilla_cycle_collect,1539 06:33:58 INFO - PROCESS | 4469 | __end_cc_report 06:33:58 INFO - PROCESS | 4469 | __startTimestamp1486650838907__endTimestamp 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | ------- Summary: start ------- 06:33:58 INFO - PROCESS | 4469 | Number of tests: 14 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.34 (1.2%) stddev-sans-first:1.27 06:33:58 INFO - PROCESS | 4469 | Values: 111.0 114.0 112.0 112.0 112.0 113.0 114.0 113.0 111.0 115.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:126.50 stddev:14.10 (11.1%) stddev-sans-first:14.08 06:33:58 INFO - PROCESS | 4469 | Values: 142.0 118.0 118.0 160.0 119.0 118.0 123.0 119.0 137.0 130.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 06:33:58 INFO - PROCESS | 4469 | Values: 161.0 159.0 160.0 160.0 160.0 160.0 160.0 160.0 162.0 159.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.59 (15.2%) stddev-sans-first:12.09 06:33:58 INFO - PROCESS | 4469 | Values: 75.0 75.0 75.0 107.0 76.0 75.0 76.0 76.0 98.0 76.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#4] audio-oscillator Cycles:10 Average:88.50 Median:82.00 stddev:11.21 (13.7%) stddev-sans-first:11.71 06:33:58 INFO - PROCESS | 4469 | Values: 83.0 81.0 111.0 84.0 82.0 82.0 91.0 82.0 82.0 107.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 06:33:58 INFO - PROCESS | 4469 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 06:33:58 INFO - PROCESS | 4469 | Values: 146.0 146.0 147.0 147.0 148.0 146.0 146.0 145.0 146.0 145.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 06:33:58 INFO - PROCESS | 4469 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:49.50 stddev:3.20 (6.5%) stddev-sans-first:3.35 06:33:58 INFO - PROCESS | 4469 | Values: 49.0 50.0 49.0 49.0 49.0 59.0 49.0 50.0 49.0 53.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 06:33:58 INFO - PROCESS | 4469 | Values: 65.0 65.0 65.0 67.0 65.0 64.0 64.0 65.0 64.0 65.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:2.74 (3.6%) stddev-sans-first:2.89 06:33:58 INFO - PROCESS | 4469 | Values: 76.0 75.0 76.0 75.0 75.0 83.0 75.0 78.0 80.0 75.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:126.50 stddev:11.28 (8.9%) stddev-sans-first:11.89 06:33:58 INFO - PROCESS | 4469 | Values: 125.0 128.0 121.0 124.0 124.0 122.0 131.0 129.0 159.0 121.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.50 Median:157.50 stddev:2.22 (1.4%) stddev-sans-first:2.29 06:33:58 INFO - PROCESS | 4469 | Values: 156.0 156.0 156.0 162.0 158.0 155.0 159.0 157.0 160.0 156.0 06:33:58 INFO - PROCESS | 4469 | 06:33:58 INFO - PROCESS | 4469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.20 Median:60.50 stddev:1.14 (1.9%) stddev-sans-first:1.00 06:33:58 INFO - PROCESS | 4469 | Values: 62.0 61.0 60.0 61.0 60.0 60.0 61.0 59.0 58.0 60.0 06:33:58 INFO - PROCESS | 4469 | -------- Summary: end -------- 06:33:58 INFO - PROCESS | 4469 | 06:33:59 INFO - TEST-INFO | 4469: exit 0 06:33:59 INFO - TEST-OK | kraken | took 60390ms 06:33:59 INFO - SUITE-END | took 1174s 06:34:00 INFO - Completed test suite (00:19:34) 06:34:00 INFO - javascript benchmark 06:34:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3266.7549933754967, 3301.1417031571814, 3313.668633136685, 3321.1697075731067, 3325.3515564464924, 5367.007103685816, 5391.110466772982, 5439.265699130616, 5452.536534394571, 5468.507834294913, 5516.7517461714315, 5593.916091258634, 5598.552115830734, 5609.382967873531, 5609.831705048845, 5066.493350664931, 5110.744462776865, 5116.923246151311, 5141.640085194019, 5147.562457191143, 4950.925736113961, 4955.603551715854, 5120.103981803189, 5154.252633368159, 5211.609129315298, 5004.824831130911, 5018.121828679985, 5054.924176137342, 5116.309298244727, 5133.512316329943, 5136.563392111675, 5139.588832893378, 5140.871478213037, 5141.074606570815, 5164.612654050924, 4860.781264843055, 4894.0, 5032.572231360302, 5037.798488060474, 5125.794968201268, 5371.919421208685, 5385.461453854583, 5410.3507579090365, 5496.5053145217125, 5504.256925315071, 5903.704814759288, 5917.20117784098, 5922.703864806743, 5925.585209035326, 5929.64422134669, 5904.261967254093, 5960.284765828128, 5962.373950735154, 5962.940370596325, 5966.642001479881, 5325.174597937326, 5375.059364611217, 5503.9174412384245, 5537.612367134262, 5558.249636299048, 6059.121427393004, 6070.180525629072, 6076.3316035236085, 6078.179445774764, 6096.573239873255, 5805.767769289266, 5834.299884013945, 5837.532997360201, 5857.912131318034, 5868.647881127146, 5688.772449102073, 5722.513586345207, 5803.88392232153, 5804.100364443518, 5955.106733989936, 5851.590388672752, 5891.086881533369, 5901.085331773582, 5932.377100404482, 5939.792107276225, 5895.469407753323, 5916.822495325147, 5922.526197904157, 5924.496417804535, 5929.792457264061, 4374.365716971021, 4413.7351758894565, 4417.712848664826, 4427.048184640254, 4437.511873693891, 4047.9797601011805, 4100.528439229467, 4102.2410853992105, 4132.214879172948, 4135.29699951009, 5815.82552523425, 5827.067669172912, 5832.562557808182, 5833.912491312633, 5865.296164460292, 5659.773609055674, 5811.912821307684, 5848.941510584925, 5905.055191169392, 5993.430624090704, 5750.654960702372, 5802.187693722883, 5812.44781745742, 5843.3864444233595, 5859.501942334864, 5072.5688316493515, 5087.262346959744, 5116.079105760924, 5126.231065340229, 5131.435542090367, 5941.821745347646, 6268.341824108494, 6274.215723034621, 6278.183836101369, 6278.748850046039, 5716.0, 5739.885202295847, 5788.710564471676, 5794.304683438015, 5845.210896528914, 6069.423404776716, 6069.544784141119, 6095.359987201457, 6111.083337499411, 6112.32764395925, 5711.086226203787, 5779.566532509994, 5785.045467497984, 5788.102844059177, 5793.449622285876, 5781.219535362672, 5784.855378615568, 5830.47525722687, 5833.0, 5843.2695913010875, 5768.1636162757, 5770.884582308414, 5783.624064435799, 5785.595008349544, 5786.450287222707, 5751.9424805751405, 5760.366359700513, 5761.5102716269585, 5764.538836892954, 5765.91351129725, 5588.944110558842, 5591.18927755465, 5682.886342273048, 5728.484436400744, 5745.339285982165, 5851.707414629337, 5858.297004359334, 5870.735816888336, 5871.1486834409625, 5893.145493903446, 5738.053221218453, 5785.450382213683, 5793.102069179284, 5798.159266906359, 5804.332501762351], "value": 5464.846222881753, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3879687531218, 584.7047241143223, 624.5815303746491, 638.1671918146819, 683.9179298484182, 36930.81534592326, 47702.0, 49004.75497622516, 49104.50895491044, 54206.0, 52058.21912671313, 52743.736281318634, 52987.205191922054, 53045.999999999905, 53088.73455632717, 8789.560521973908, 9447.71656850294, 9655.0, 9673.95163024184, 9694.515274236295, 8763.211310982011, 11115.11079113673, 11342.43287835609, 11344.376059316734, 11723.237989530697, 11508.42457877107, 11584.884151158465, 11585.36280504572, 11590.942045289805, 11612.70968225797, 11598.130140239517, 11602.419879006058, 11668.766624667544, 11677.2409793364, 11695.5906543271, 11352.14858885587, 11397.373144477051, 11430.314181149075, 11459.598914038052, 11540.942295288554, 48076.27885581684, 48421.0, 48493.0, 48523.0, 48525.0, 4300.505441874193, 4476.306172543261, 4482.7982740776415, 4493.955060449386, 4680.461746899082, 32719.0, 32815.6718432815, 32874.342513149604, 32922.0, 34160.0, 4450.666200034978, 4688.906221875543, 4761.952380476186, 4805.471398146201, 4828.879278018043, 271459.0, 373282.0, 373355.0, 373964.99999999726, 374839.0, 61980.0, 62363.6881815588, 62645.0, 62657.373426266066, 62736.37263627397, 65774.34225657777, 66111.33888661148, 66160.6691966537, 66215.0, 66404.0, 18792.71810922837, 19315.130819112892, 19350.225990960203, 19353.322633707754, 19355.903220483808, 13765.449382024806, 14086.366113524917, 14719.0, 14879.47921822731, 15107.093574385572, 19246.903765481362, 19781.60436791256, 19913.402597922086, 19953.301634442723, 20014.69977950332, 7402.925970740332, 7444.925550744531, 7505.136909255396, 7577.242275772489, 7746.728864489716, 973.5862258540092, 975.2149519636619, 976.4043933200742, 983.6606370802061, 998.6354980432235, 34955.650443495746, 35113.824430877685, 35151.14206708902, 35516.28967420689, 35542.64457355445, 1106.8212353843132, 1165.9650210493699, 1173.4191575170346, 1185.4843143232722, 1208.4320369426355, 18284.54288642768, 18395.448136555926, 18422.35521756732, 18516.722249166272, 18569.44291671252, 561589.0, 565067.0, 565124.0, 565711.0, 567239.0, 70992.64503677552, 71430.0, 71468.0, 71512.64243678749, 71722.64138679273, 1474.366022610288, 1501.4744839306375, 1501.6546194375355, 1534.5703203103149, 1538.2923855026813, 33424.66575334215, 34766.30467390689, 35059.29881402307, 35188.0, 35218.64781352256, 59595.70202149135, 60264.397356027635, 60266.69866650639, 60304.0, 60312.09531857113, 418235.0, 421736.0, 422999.0, 423334.0, 425591.0, 27299.454010920068, 31380.215494612818, 31780.205494862814, 47600.523994759606, 48723.5127648719, 54982.0, 55067.17399239095, 55380.0, 55507.444925550226, 56659.150112749165, 45155.0, 45869.0, 45886.77056614696, 46831.0, 47355.211583073964, 45298.32052519149, 45967.0, 46821.0, 46845.53154468548, 48157.75921120372, 46547.30179047249, 46596.0, 46819.76590117164, 46883.53116468928, 46959.53040469688, 40949.1810163801, 43850.342244865715, 44035.0, 44088.55911440845, 44211.7759731849, 31591.772449692075, 31715.20711982219, 31844.52233216457, 32001.839990799897, 32406.351872961935], "value": 22632.72528694138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.17343904856295, 436.11033491676983, 437.3265171635681, 442.9148585964388, 448.7077217613273, 20219.292324768638, 21281.148754049857, 21419.464513387135, 21786.564268714617, 22006.44983875404, 21675.674864877, 22591.774082259213, 22635.320940371814, 22692.88653556734, 22817.77182228177, 5913.793017244398, 6078.787242446527, 6258.968705156491, 6269.090981807635, 6273.435390814826, 6919.204291506466, 7074.257202993663, 7110.182329032175, 7114.0, 7119.608421536814, 6861.656917154147, 6947.930520694779, 6989.091418115638, 6994.58032518048, 7055.365017148456, 6897.896531552031, 6907.861842763167, 6957.0, 7032.331928466813, 7046.365827075588, 6179.073139029137, 6180.412860778219, 6185.907211391833, 6186.443220110212, 6187.969060154671, 25393.365165870815, 25514.617280740804, 25545.361365965815, 25558.10546630859, 25752.613710794354, 2778.9305267368277, 3358.9496157557655, 3376.324735052999, 3413.0955296846355, 3434.862605495777, 11235.606753763579, 11487.540498380054, 11681.591144309908, 11684.298942063504, 11886.346250956194, 2048.4059622709547, 2075.0973326602975, 2084.5622419291967, 2085.614161380134, 2123.2993112273066, 74656.25343746548, 75592.1000079881, 90996.54501727516, 92042.5397873013, 94931.0, 12484.81272780909, 12572.30852303132, 12626.621201363974, 12823.935880320725, 13016.934915325362, 18220.63558728818, 18344.0, 18347.0, 18370.448886533424, 18401.63196736058, 9301.116393942564, 9311.813763724687, 9364.204042656314, 9470.431774093438, 9585.760355991157, 8803.251723603438, 8814.162654547808, 8815.294776417872, 9071.909280907239, 9097.226735727405, 5365.490278423622, 5373.892522149613, 5409.56723462122, 5522.116461366162, 5564.137558678412, 2154.310620601424, 2192.6382146945575, 2218.7226596675414, 2223.12186686258, 2239.0595949701164, 1057.39728354837, 1060.4273692206277, 1084.6095405653957, 1087.3693257910393, 1128.8814674459227, 20204.39386818398, 20428.591428171352, 20979.685304720442, 22096.668549971764, 22957.655635165487, 1052.147760314148, 1064.5848119233506, 1070.29895418501, 1079.9460026998618, 1100.5707773968159, 11408.693572019616, 11473.196876218752, 11715.707107322385, 11738.06095512357, 11852.340672305883, 690687.0, 703887.0, 721514.0, 722378.0, 731229.0, 82249.17750822415, 92494.0, 103598.48200758948, 113489.4325528367, 114371.42814285876, 1197.383347575999, 1204.3556697167148, 1214.2168301445517, 1215.1858254969193, 1218.8354572132648, 18985.24059037623, 19483.123259453074, 19786.505337366107, 19801.405957821287, 19826.50433739168, 47301.52698472971, 47660.285095724284, 47807.0, 49127.508724912295, 49249.75375123245, 67867.0, 68158.65920670365, 68340.31659683339, 68754.0, 68967.65516172387, 9604.75988100303, 9765.511724413893, 9769.951150244488, 9921.156701680438, 9945.254105941938, 11944.522219111139, 14400.567982960529, 14664.266786660412, 14873.256337182882, 15022.549323520312, 12303.507859685513, 12384.318862462651, 12404.937975310066, 12497.500099995897, 12551.748965020832, 12165.574204902787, 12196.57311994076, 12426.378681066091, 12577.182483138567, 12953.417096230503, 12379.442925068213, 12698.174618649758, 12935.288559129338, 12948.15836970594, 13028.804567931298, 9471.47906865129, 9711.56297966579, 9746.0, 9859.605615775288, 9940.204783617148, 11841.467133979164, 12569.685757856127, 12600.936995314965, 12648.810267845805, 12692.17500862441], "value": 10516.673131838717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1499.182945294815, 1504.811898512686, 1508.6228442889278, 1527.1058800059845, 1537.223702030475, 8326.250637442628, 8982.371234013606, 8989.820203595924, 8992.235659968894, 9011.188992990637, 7768.495047821888, 7934.365250779938, 7948.920510794905, 8217.46586471879, 8722.127787221274, 2311.433698743806, 2401.087586717054, 2404.086447150089, 2413.0589070262613, 2426.9514609707794, 2370.9407264818346, 2393.102586530051, 2433.0267892842917, 2454.8895299711467, 2459.225344016638, 2399.784019438259, 2399.7960173385195, 2417.0815090265673, 2428.4778772563895, 2428.9149879754214, 2399.0, 2408.421978725093, 2414.0464516515967, 2415.2754173747803, 2421.994872128065, 2334.498082912182, 2406.855588664686, 2409.2531315292317, 2410.7468715784767, 2411.963820542693, 8916.242119419858, 8920.197182253563, 8942.687005954826, 8946.418482798597, 8962.193402593797, 5133.948660513384, 5254.579633629301, 5254.632175747699, 5254.789808407659, 5255.842324730264, 3332.933341333184, 3384.0, 3503.2468019375956, 3506.1234691327168, 3530.894073177809, 1461.897667163299, 1500.2573726005587, 1524.3369134426448, 1556.922153892301, 1578.723723348421, 12035.879641203652, 12102.273863568214, 12112.81830772539, 12132.0, 12154.817677734842, 4713.95286047142, 4843.903121937541, 4902.093112774148, 4911.631627627942, 4930.654854160174, 10024.498775061218, 10048.497575121215, 10066.647667331608, 10077.59689612422, 10083.344582602107, 5535.086710692771, 5536.197251398525, 5543.52880005204, 5543.584231182677, 5553.333599967949, 4529.977350113294, 4646.605038571692, 4891.1685013547785, 5002.924956125661, 5065.088284108822, 3893.474380958591, 3910.9413358799643, 4017.979910100489, 4021.1354558770004, 4021.7184797063924, 1206.324458303353, 1211.1037832004254, 1211.7697637448857, 1221.462556475166, 1221.9327936963375, 1031.1905154453718, 1037.9636712715019, 1039.1790485516358, 1046.6336782126195, 1052.55792567122, 6042.667653279112, 6062.0, 6112.235970503687, 6115.143879856823, 6277.466415354655, 1065.8454524094118, 1071.983920241197, 1075.2204651627508, 1099.6041425086962, 1106.4301884529473, 3957.782321972319, 4181.874543763692, 4185.24665560196, 4185.602367775056, 4202.579742025834, 10534.420606866695, 10817.242793004572, 10817.891821081847, 10835.349879007284, 10872.728181795519, 10533.631322903815, 10564.10205132557, 10629.362238265729, 10664.78670426587, 10723.410212438392, 8155.959220203861, 8250.752477425687, 8260.463069900437, 8290.834183316421, 8310.293625041819, 5697.601167918372, 5967.134765458897, 6051.939480605138, 6065.120557519047, 6190.542669671483, 8999.865002024844, 9105.77235569116, 9140.63437462494, 9154.40496367734, 9471.952640236756, 9690.148714648423, 9806.85289720669, 9996.950015249877, 10032.949835250776, 10138.188944884245, 7232.276772322725, 7884.802879927818, 8256.752297431087, 8400.243978042006, 8434.789130271793, 8261.545614991233, 8609.139086091342, 8612.052674205706, 8616.35377346689, 8617.569121543773, 7557.659905304385, 7621.923780762121, 7656.157822639617, 7679.385649147943, 7725.49784264021, 7586.279303466162, 7622.504537205064, 7701.653425595974, 7730.7680769577, 7760.068791745027, 6873.553219040747, 6891.414229790524, 6892.931070689229, 6898.448124150156, 6903.5167538273845, 5269.604779641466, 5336.412994570672, 5364.731763411892, 5474.069408200536, 5496.80761173357, 5376.516113549643, 5420.566354691694, 5432.266644003167, 5484.588655850907, 5489.039418101736], "value": 4731.766872956841, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.8205589540604, 412.6595558664101, 412.71151465125877, 426.4882141430284, 428.76417970116427, 5225.7861415229645, 5274.5780337573, 5284.6300758946845, 5299.675081229692, 5308.416074231836, 5022.1167062351615, 5147.0, 5166.4575219601875, 5179.404368497624, 5289.629725919187, 4169.62473377396, 4260.31834906415, 4272.530021697611, 4281.165172791307, 4285.742855428669, 4268.445102136718, 4284.143171365724, 4302.505211900624, 4316.654667626598, 4317.525072242051, 3977.7613343199355, 4134.111166099288, 4174.436451079096, 4262.124665147326, 4286.0, 4135.669146468275, 4136.73111247768, 4154.584541545852, 4165.396017577449, 4172.916541669165, 3694.685951694109, 3700.777953322809, 3704.481372607837, 3707.703383729295, 3721.106934335767, 5022.84931452057, 5032.547070763649, 5123.180291153398, 5138.3833939927445, 5140.383154021504, 4778.856634300942, 4787.8563643090765, 4788.9521104788855, 4809.711417314972, 4828.830990915301, 5497.725113744297, 5515.365732940723, 5520.641158324696, 5527.585431092644, 5546.500814926636, 3898.401655321333, 4125.452955141822, 4126.360414135814, 4138.689598280141, 4140.792960352001, 5670.716464176816, 5695.0, 5707.942920570783, 5709.914351284734, 5724.799632012901, 4199.9550326014005, 4209.137126888981, 4213.199492096492, 4216.072464057902, 4221.113566151082, 4194.895127621773, 4266.679999000087, 4287.421198138211, 4288.699791014599, 4290.978545107255, 4756.286557016475, 4761.738104404221, 4773.76131193439, 4784.856454306377, 4787.305840653085, 5460.532561823192, 5542.198785394682, 5579.609427340129, 5597.496225339739, 5600.887982240332, 1342.4764341906664, 1348.3932230496316, 1354.952576659832, 1359.714459963399, 1362.6048445950762, 927.1192367251003, 950.0594411532533, 952.3333666433385, 975.9024097590184, 989.8666027398732, 5191.195364718475, 5200.2979597754575, 5201.323827902348, 5206.453322401093, 5215.24378965048, 5443.775150591086, 5446.945530544723, 5450.454954504517, 5474.616776825584, 5551.278333816578, 5203.401608815035, 5463.890722185534, 5492.286002819687, 5527.53015993637, 5549.694766787785, 2917.5040243158714, 2925.429541239438, 2928.813830398692, 2945.749611283022, 2960.564126398695, 5617.21359009739, 5725.198472213893, 5806.44838740319, 5839.854003649943, 5873.676947767828, 5584.944150558524, 5588.497035266845, 5599.580031497654, 5603.8599035023635, 5631.7184140793615, 5756.186801157622, 5763.971180144073, 5776.711164441761, 5782.450667186695, 5785.161151633074, 5312.707801070824, 5447.945520544744, 5467.835964921059, 5483.314585676791, 5535.806246781343, 5428.918566221589, 5432.782688692408, 5440.619156658996, 5459.235707001102, 5461.590380721541, 5448.065936592453, 5738.311402631711, 5744.540436764965, 5789.33422656383, 5812.622179558315, 4033.8939016957365, 4047.2917239483563, 4059.959400405958, 4079.5920407958965, 4082.3672330788777, 5488.890222195454, 5498.185598752322, 5504.669719816824, 5508.44915508446, 5519.448055194448, 5166.819161329336, 5249.7375131242525, 5330.120530112488, 5347.171188465794, 5376.59675524345, 5350.117230657053, 5360.3299587551555, 5364.275822764033, 5396.622236443412, 5415.187721841755, 5287.10119279731, 5332.253484512094, 5385.27298814655, 5404.702741349263, 5456.945430545644, 5441.591880609049, 5460.3618914326335, 5465.988792073479, 5470.288862448016, 5473.425290344457, 5351.491608297206, 5371.140617501181, 5400.297961265011, 5414.945850541444, 5428.37573679032], "value": 4237.572773128822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [862.133555776445, 873.7990262239684, 877.6357811508225, 930.8743319651848, 944.1266828183931, 15769.21153942304, 16324.265408056637, 16550.7517387239, 16577.005379677226, 16831.410900618466, 15450.5364839055, 15597.376104955816, 15859.0, 16283.104429256386, 16418.83581164188, 703.7501686901153, 825.8637324841409, 840.684743221292, 843.7257891185359, 843.8143608406141, 738.3023043224156, 823.7158180427742, 840.9621567029468, 849.8980122385323, 851.3146916732028, 867.9566021698921, 868.917452841979, 869.5695630662831, 870.0255713600776, 870.4037734152095, 748.5695724958116, 870.8388948044632, 870.9303255739526, 871.1941454154913, 871.3900269811157, 564.8672561947939, 631.3181763695198, 641.4034947498824, 649.3701109923367, 649.399305642279, 14835.629109272246, 14864.925675371662, 14910.776338354934, 14918.0, 15159.24203789806, 15481.762127627895, 15573.221338933121, 15870.0, 15906.0, 15984.680306393924, 14011.159330440207, 14200.0, 14281.500147494891, 14283.428662853474, 14440.711185776225, 4548.795304211285, 4636.281376386665, 4656.092062047902, 4701.7414042227665, 4780.641451891122, 82577.17422825754, 83308.58345708293, 84824.57587712022, 86890.13109868947, 87057.0, 11380.317180969168, 11461.255018423775, 11491.942540287246, 11518.251313664585, 11677.240979336317, 22940.88529557375, 23149.189778357675, 23277.650835237484, 23376.181833635743, 23534.64698029531, 8422.115677853737, 8440.366972477088, 8498.277646400002, 8524.957375213084, 8669.046404895456, 4778.354922085544, 4802.0, 4838.95161048385, 4896.143174944371, 4925.605951523869, 3677.485152078711, 3788.886333410002, 3795.16506368604, 3815.2178803345246, 3819.8731374244667, 625.4464798653133, 633.87956288306, 636.3509220594967, 637.8469167399884, 638.5211091681239, 773.6866569039436, 775.2015424113173, 776.1888826176659, 782.2881178127876, 801.2428255298687, 10406.635767748092, 10933.234673572773, 11105.888941110647, 11613.76772464563, 11652.592159274385, 772.7527191298731, 775.848709501653, 781.5857595474407, 782.6556315221285, 792.4492477727923, 5206.261868094096, 5231.3199284092825, 5294.470552944675, 5302.734863256822, 5346.866328341823, 67816.66091669608, 69708.30291697018, 71231.6438417815, 80245.0, 87831.1692856899, 59145.40854591485, 59794.402055978884, 63997.36002640007, 68454.65772671204, 69433.65283173551, 64646.67676661586, 64774.352256477774, 64829.67585162044, 65281.02078468827, 65883.0, 10665.200109991627, 10941.835872461761, 11028.28316159447, 11104.167187460811, 11212.775744484901, 37881.431778523896, 37993.0, 38486.0, 42138.78930605327, 43869.341959871264, 52152.21771673504, 52740.736296318275, 52874.942501148995, 57816.421835782785, 59758.701206493686, 14468.204248766418, 14616.488422905148, 14708.043977141451, 14711.852881471048, 14931.701365972836, 15606.21968901573, 15880.682386352439, 16295.51113466598, 16608.667826643643, 17802.37691680785, 15391.153486558347, 15478.690426191188, 15852.603684907508, 15903.681926361176, 16597.668046639243, 15151.469698560939, 15476.226188690296, 15711.607209819846, 15967.281472334005, 16660.41688540895, 15117.244137793286, 15214.847851521343, 15327.770083448535, 15824.0, 16301.59246018859, 11551.595694150665, 11638.301701897914, 11770.82343764827, 11890.940545297219, 12145.514179433078, 13023.739525209632, 13287.678743202545, 13294.800577991531, 13364.0, 13461.461541538229], "value": 7749.826673130064, "unit": "score"}], "name": "dromaeo_css", "value": 7660.891249772101, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 112.0, 112.0, 113.0, 114.0, 113.0, 111.0, 115.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 118.0, 118.0, 160.0, 119.0, 118.0, 123.0, 119.0, 137.0, 130.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 159.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 107.0, 76.0, 75.0, 76.0, 76.0, 98.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 111.0, 84.0, 82.0, 82.0, 91.0, 82.0, 82.0, 107.0], "value": 88.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 145.0, 146.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 49.0, 49.0, 59.0, 49.0, 50.0, 49.0, 53.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 67.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 75.0, 75.0, 83.0, 75.0, 78.0, 80.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 121.0, 124.0, 124.0, 122.0, 131.0, 129.0, 159.0, 121.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 156.0, 156.0, 162.0, 158.0, 155.0, 159.0, 157.0, 160.0, 156.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 61.0, 60.0, 60.0, 61.0, 59.0, 58.0, 60.0], "value": 60.2, "unit": "score"}], "name": "kraken", "value": 1467.7, "alertThreshold": 2.0}]} 06:34:00 INFO - Return code: 0 06:34:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:34:00 ERROR - # TBPL SUCCESS # 06:34:00 INFO - Running post-action listener: _resource_record_post_action 06:34:00 INFO - [mozharness: 2017-02-09 14:34:00.240987Z] Finished run-tests step (success) 06:34:00 INFO - Running post-run listener: _resource_record_post_run 06:34:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 724992; Write bytes: 363769856; Read time: 220; Write time: 251140 06:34:00 INFO - TinderboxPrint: CPU usage
13.1% 06:34:00 INFO - TinderboxPrint: I/O read bytes / time
724,992 / 220 06:34:00 INFO - TinderboxPrint: I/O write bytes / time
363,769,856 / 251,140 06:34:00 INFO - TinderboxPrint: CPU idle
8,263.9 (86.9%) 06:34:00 INFO - TinderboxPrint: CPU user
1,194.8 (12.6%) 06:34:00 INFO - TinderboxPrint: Swap in / out
0 / 0 06:34:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109363200; Read time: 0; Write time: 106140 06:34:00 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 724992; Write bytes: 253513728; Read time: 220; Write time: 144972 06:34:00 INFO - Running post-run listener: _upload_blobber_files 06:34:00 INFO - Blob upload gear active. 06:34:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:34:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:34:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:34:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:34:01 INFO - (blobuploader) - INFO - Open directory for files ... 06:34:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:34:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:34:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:02 INFO - (blobuploader) - INFO - Done attempting. 06:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:34:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:02 INFO - (blobuploader) - INFO - Done attempting. 06:34:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:34:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:34:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:03 INFO - (blobuploader) - INFO - Done attempting. 06:34:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:34:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:34:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:34:06 INFO - (blobuploader) - INFO - Done attempting. 06:34:06 INFO - (blobuploader) - INFO - Iteration through files over. 06:34:06 INFO - Return code: 0 06:34:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:34:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:34:06 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4807ef08db86e32d8ef55eb82a47bdb5b6529691e0a8e56d499e7cd5869ab7181d5c4130af2449819fa1e51e32110f220d30b805c8244bfa223fd3ad0fadde4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9914edbd6a4f4673a990488c7bdbdb442b993a88abfdd8b91fd84f27d32b34c6085ead2f5dc4c30f90c388929e8e9ed4f60645f0fdf0eb91a4baebcae93ac4da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f22bfcdeefd220c92fa5bee7dc5014c00ae488f53890ebe59741293bf8d6c2a5474be234c46239a5fdef40973ba19063e538d9025f6e2e517f7dbde7a8c6d0ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2cfd6b3af060797aaf44ff35bf42798eec666975495b229ca4673181ca530d3fd5415b585fb964f55abb11940ceba4ca48e0a6fbb9d8a59e493ac5af7af2a409"} 06:34:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:34:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:34:06 INFO - Contents: 06:34:06 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4807ef08db86e32d8ef55eb82a47bdb5b6529691e0a8e56d499e7cd5869ab7181d5c4130af2449819fa1e51e32110f220d30b805c8244bfa223fd3ad0fadde4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9914edbd6a4f4673a990488c7bdbdb442b993a88abfdd8b91fd84f27d32b34c6085ead2f5dc4c30f90c388929e8e9ed4f60645f0fdf0eb91a4baebcae93ac4da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f22bfcdeefd220c92fa5bee7dc5014c00ae488f53890ebe59741293bf8d6c2a5474be234c46239a5fdef40973ba19063e538d9025f6e2e517f7dbde7a8c6d0ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2cfd6b3af060797aaf44ff35bf42798eec666975495b229ca4673181ca530d3fd5415b585fb964f55abb11940ceba4ca48e0a6fbb9d8a59e493ac5af7af2a409"} 06:34:06 INFO - Running post-run listener: copy_logs_to_upload_dir 06:34:06 INFO - Copying logs to upload dir... 06:34:06 INFO - mkdir: /builds/slave/test/build/upload/logs 06:34:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.974687 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 06:34:06.746783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:34:06.750067) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4807ef08db86e32d8ef55eb82a47bdb5b6529691e0a8e56d499e7cd5869ab7181d5c4130af2449819fa1e51e32110f220d30b805c8244bfa223fd3ad0fadde4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9914edbd6a4f4673a990488c7bdbdb442b993a88abfdd8b91fd84f27d32b34c6085ead2f5dc4c30f90c388929e8e9ed4f60645f0fdf0eb91a4baebcae93ac4da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f22bfcdeefd220c92fa5bee7dc5014c00ae488f53890ebe59741293bf8d6c2a5474be234c46239a5fdef40973ba19063e538d9025f6e2e517f7dbde7a8c6d0ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2cfd6b3af060797aaf44ff35bf42798eec666975495b229ca4673181ca530d3fd5415b585fb964f55abb11940ceba4ca48e0a6fbb9d8a59e493ac5af7af2a409"} build_url:https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/UG8Ra0dbSf2E8U_X24Zojw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/4807ef08db86e32d8ef55eb82a47bdb5b6529691e0a8e56d499e7cd5869ab7181d5c4130af2449819fa1e51e32110f220d30b805c8244bfa223fd3ad0fadde4b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/9914edbd6a4f4673a990488c7bdbdb442b993a88abfdd8b91fd84f27d32b34c6085ead2f5dc4c30f90c388929e8e9ed4f60645f0fdf0eb91a4baebcae93ac4da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/f22bfcdeefd220c92fa5bee7dc5014c00ae488f53890ebe59741293bf8d6c2a5474be234c46239a5fdef40973ba19063e538d9025f6e2e517f7dbde7a8c6d0ae", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2cfd6b3af060797aaf44ff35bf42798eec666975495b229ca4673181ca530d3fd5415b585fb964f55abb11940ceba4ca48e0a6fbb9d8a59e493ac5af7af2a409"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 06:34:06.774658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:34:06.774976) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1486649608.903969-84820211 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 06:34:06.858759) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:34:06.859069) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 06:34:06.859390) ========= ========= Total master_lag: 0.24 =========