builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1492525958.18 results: success (0) revision: 4dae386f2c331851b192a3ef493cc139fd562a44 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.184591) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.185067) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.185369) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.200505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.200824) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-18 07:32:38-- 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% 43.0M=0s 2017-04-18 07:32:39 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.339824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.340145) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015309 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:38.389105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 07:32:38.389511) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4dae386f2c331851b192a3ef493cc139fd562a44 --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 4dae386f2c331851b192a3ef493cc139fd562a44 --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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-18 07:32:39,232 truncating revision to first 12 chars 2017-04-18 07:32:39,232 Setting DEBUG logging. 2017-04-18 07:32:39,232 attempt 1/10 2017-04-18 07:32:39,232 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4dae386f2c33?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-18 07:32:40,589 unpacking tar archive at: mozilla-aurora-4dae386f2c33/testing/mozharness/ program finished with exit code 0 elapsedTime=2.449313 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-18 07:32:40.852359) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:40.852689) ========= script_repo_revision: 4dae386f2c331851b192a3ef493cc139fd562a44 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:40.853057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:40.853323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-18 07:32:40.862943) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-18 07:32:40.863295) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:41 INFO - MultiFileLogger online at 20170418 07:32:41 in /builds/slave/test 07:32:41 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 07:32:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:41 INFO - {'append_to_log': False, 07:32:41 INFO - 'base_work_dir': '/builds/slave/test', 07:32:41 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 07:32:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:41 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 07:32:41 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:41 INFO - 'config_files': ('talos/linux_config.py',), 07:32:41 INFO - 'default_actions': ('clobber', 07:32:41 INFO - 'read-buildbot-config', 07:32:41 INFO - 'download-and-extract', 07:32:41 INFO - 'populate-webroot', 07:32:41 INFO - 'create-virtualenv', 07:32:41 INFO - 'install', 07:32:41 INFO - 'run-tests'), 07:32:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:41 INFO - 'download_minidump_stackwalk': True, 07:32:41 INFO - 'download_symbols': 'ondemand', 07:32:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:41 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:41 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:41 INFO - 'gecko_profile': False, 07:32:41 INFO - 'gecko_profile_interval': 0, 07:32:41 INFO - 'installer_path': 'installer.exe', 07:32:41 INFO - 'log_level': 'info', 07:32:41 INFO - 'log_name': 'talos', 07:32:41 INFO - 'log_to_console': True, 07:32:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:41 INFO - 'opt_config_files': (), 07:32:41 INFO - 'pip_index': False, 07:32:41 INFO - 'suite': 'dromaeojs', 07:32:41 INFO - 'system_bits': '32', 07:32:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:41 INFO - 'title': 'talos-linux64-ix-061', 07:32:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:41 INFO - 'use_talos_json': True, 07:32:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:41 INFO - 'work_dir': 'build'} 07:32:41 INFO - [mozharness: 2017-04-18 14:32:41.806077Z] Running clobber step. 07:32:41 INFO - Running pre-action listener: _resource_record_pre_action 07:32:41 INFO - Running main action method: clobber 07:32:41 INFO - rmtree: /builds/slave/test/build 07:32:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:42 INFO - Running post-action listener: _resource_record_post_action 07:32:42 INFO - [mozharness: 2017-04-18 14:32:42.744909Z] Finished clobber step (success) 07:32:42 INFO - [mozharness: 2017-04-18 14:32:42.745008Z] Running read-buildbot-config step. 07:32:42 INFO - Running pre-action listener: _resource_record_pre_action 07:32:42 INFO - Running main action method: read_buildbot_config 07:32:42 INFO - Using buildbot properties: 07:32:42 INFO - { 07:32:42 INFO - "project": "", 07:32:42 INFO - "product": "firefox", 07:32:42 INFO - "who": "jlorenzo@mozilla.com", 07:32:42 INFO - "installer_path": "public/build/target.tar.bz2", 07:32:42 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:32:42 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 07:32:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 07:32:42 INFO - "stage_platform": "linux64", 07:32:42 INFO - "basedir": "/builds/slave/test", 07:32:42 INFO - "buildnumber": 136, 07:32:42 INFO - "platform": "ubuntu64_hw", 07:32:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:32:42 INFO - "slavebuilddir": "test", 07:32:42 INFO - "taskId": "Ol1GrHNcTqei02x296QzQA", 07:32:42 INFO - "branch": "mozilla-aurora", 07:32:42 INFO - "script_repo_revision": "production", 07:32:42 INFO - "revision": "4dae386f2c331851b192a3ef493cc139fd562a44", 07:32:42 INFO - "slavename": "talos-linux64-ix-061", 07:32:42 INFO - "repo_path": "releases/mozilla-aurora" 07:32:42 INFO - } 07:32:42 INFO - Finding installer, test and symbols from parent task. 07:32:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ol1GrHNcTqei02x296QzQA'}, attempt #1 07:32:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ol1GrHNcTqei02x296QzQA'}, attempt #1 07:32:43 INFO - Task dependencies: ZVCbm0xfTEGg2SKhag-RSQ 07:32:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ'}, attempt #1 07:32:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 07:32:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/test_packages.json 07:32:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.crashreporter-symbols.zip 07:32:44 INFO - Running post-action listener: _resource_record_post_action 07:32:44 INFO - [mozharness: 2017-04-18 14:32:44.117704Z] Finished read-buildbot-config step (success) 07:32:44 INFO - [mozharness: 2017-04-18 14:32:44.117922Z] Running download-and-extract step. 07:32:44 INFO - Running pre-action listener: _resource_record_pre_action 07:32:44 INFO - Running main action method: download_and_extract 07:32:44 INFO - mkdir: /builds/slave/test/build/tests 07:32: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')]} 07:32:44 INFO - trying https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.test_packages.json 07:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:32:44 INFO - Downloaded 896 bytes. 07:32:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:32:44 INFO - Using the following test package requirements: 07:32:44 INFO - {u'common': [u'target.common.tests.zip'], 07:32:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:32:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:32:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:32:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:32:44 INFO - u'mozbase': [u'target.common.tests.zip'], 07:32:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:32:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:32:44 INFO - u'web-platform': [u'target.common.tests.zip', 07:32:44 INFO - u'target.web-platform.tests.zip'], 07:32:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:32:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:32:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip 07:32:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:32:44 INFO - Fetch https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip into memory 07:32:45 INFO - Expected file size: 59540216 07:32:45 INFO - Obtained file size: 59540216 07:32:55 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:32:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip 07:32:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:32:55 INFO - Fetch https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.common.tests.zip into memory 07:32:56 INFO - Expected file size: 59540216 07:32:56 INFO - Obtained file size: 59540216 07:33:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.talos.tests.zip 07:33:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:33:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.talos.tests.zip into memory 07:33:08 INFO - Expected file size: 14404424 07:33:08 INFO - Obtained file size: 14404424 07:33: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')]} 07:33:08 INFO - trying https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 07:33:08 INFO - Downloading https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:33:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:33:09 INFO - Downloaded 66827583 bytes. 07:33:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 07:33:09 INFO - mkdir: /builds/slave/test/properties 07:33:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:33:09 INFO - Writing to file /builds/slave/test/properties/build_url 07:33:09 INFO - Contents: 07:33:09 INFO - build_url:https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 07:33:09 INFO - Running post-action listener: _resource_record_post_action 07:33:09 INFO - Running post-action listener: set_extra_try_arguments 07:33:09 INFO - [mozharness: 2017-04-18 14:33:09.436735Z] Finished download-and-extract step (success) 07:33:09 INFO - [mozharness: 2017-04-18 14:33:09.436832Z] Running populate-webroot step. 07:33:09 INFO - Running pre-action listener: _resource_record_pre_action 07:33:09 INFO - Running main action method: populate_webroot 07:33:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:33:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:33:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:33:09 INFO - '--tppagecycles', 07:33:09 INFO - '7'], 07:33:09 INFO - 'tests': ['tsvgm']}}, 07:33:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:33:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:33:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:33:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:33:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:33:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['damp', 'tps']}, 07:33:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'tests': ['damp', 'tps']}, 07:33:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['dromaeo_dom']}, 07:33:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:33:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['basic_compositor_video']}, 07:33:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:33:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'other-e10s': {'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['a11yr', 07:33:09 INFO - 'ts_paint', 07:33:09 INFO - 'tpaint', 07:33:09 INFO - 'sessionrestore', 07:33:09 INFO - 'sessionrestore_no_auto_restore', 07:33:09 INFO - 'tabpaint']}, 07:33:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['tsvgx', 07:33:09 INFO - 'tsvgr_opacity', 07:33:09 INFO - 'tart', 07:33:09 INFO - 'tscrollx', 07:33:09 INFO - 'cart', 07:33:09 INFO - 'tsvg_static']}, 07:33:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:33:09 INFO - 'tsvgr_opacity', 07:33:09 INFO - 'tart', 07:33:09 INFO - 'tscrollx', 07:33:09 INFO - 'cart', 07:33:09 INFO - 'tsvg_static']}, 07:33:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'talos_options': ['--disable-e10s'], 07:33:09 INFO - 'tests': ['tp5o']}, 07:33:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:33:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'talos_options': ['--disable-e10s', 07:33:09 INFO - '--xperf_path', 07:33:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:09 INFO - 'tests': ['tp5n']}, 07:33:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:33:09 INFO - 'talos_options': ['--xperf_path', 07:33:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:33:09 INFO - 'tests': ['tp5n']}}, 07:33:09 INFO - 'talos.zip': {'path': '', 07:33:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:33:09 INFO - Running post-action listener: _resource_record_post_action 07:33:09 INFO - [mozharness: 2017-04-18 14:33:09.450015Z] Finished populate-webroot step (success) 07:33:09 INFO - [mozharness: 2017-04-18 14:33:09.450105Z] Running create-virtualenv step. 07:33:09 INFO - Running pre-action listener: _resource_record_pre_action 07:33:09 INFO - Running main action method: create_virtualenv 07:33:09 INFO - Creating virtualenv /builds/slave/test/build/venv 07:33:09 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 07:33:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:33:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:33:09 INFO - Using real prefix '/usr' 07:33:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:33:10 INFO - Installing distribute.............................................................................................................................................................................................done. 07:33:12 INFO - Installing pip.................done. 07:33:12 INFO - Return code: 0 07:33:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:33:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:33:12 INFO - Reading from file tmpfile_stdout 07:33:12 INFO - Output received: 07:33:12 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) 07:33:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:33:12 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')]} 07:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 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')]} 07:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:12 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 07:33:12 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 07:33:12 INFO - Using env: {'DISPLAY': ':0', 07:33:12 INFO - 'HOME': '/home/cltbld', 07:33:12 INFO - 'LANG': 'en_US.UTF-8', 07:33:12 INFO - 'LANGUAGE': 'en_US:en', 07:33:12 INFO - 'LOGNAME': 'cltbld', 07:33:12 INFO - 'MAIL': '/var/mail/cltbld', 07:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:12 INFO - 'MOZ_NO_REMOTE': '1', 07:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:12 INFO - 'NO_EM_RESTART': '1', 07:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:12 INFO - 'PWD': '/builds/slave/test', 07:33:12 INFO - 'SHELL': '/bin/bash', 07:33:12 INFO - 'SHLVL': '1', 07:33:12 INFO - 'TERM': 'linux', 07:33:12 INFO - 'TMOUT': '86400', 07:33:12 INFO - 'USER': 'cltbld', 07:33:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:12 INFO - '_': '/tools/buildbot/bin/python'} 07:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:12 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 07:33:12 INFO - Cleaning up... 07:33:12 INFO - Return code: 0 07:33:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:33:12 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')]} 07:33:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 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')]} 07:33:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:12 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:12 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 07:33:12 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 07:33:12 INFO - Using env: {'DISPLAY': ':0', 07:33:12 INFO - 'HOME': '/home/cltbld', 07:33:12 INFO - 'LANG': 'en_US.UTF-8', 07:33:12 INFO - 'LANGUAGE': 'en_US:en', 07:33:12 INFO - 'LOGNAME': 'cltbld', 07:33:12 INFO - 'MAIL': '/var/mail/cltbld', 07:33:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:12 INFO - 'MOZ_NO_REMOTE': '1', 07:33:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:12 INFO - 'NO_EM_RESTART': '1', 07:33:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:12 INFO - 'PWD': '/builds/slave/test', 07:33:12 INFO - 'SHELL': '/bin/bash', 07:33:12 INFO - 'SHLVL': '1', 07:33:12 INFO - 'TERM': 'linux', 07:33:12 INFO - 'TMOUT': '86400', 07:33:12 INFO - 'USER': 'cltbld', 07:33:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:12 INFO - '_': '/tools/buildbot/bin/python'} 07:33:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:12 INFO - Downloading/unpacking psutil>=3.1.1 07:33:12 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 07:33:12 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 07:33:12 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 07:33:12 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 07:33:12 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 07:33:12 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 07:33:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:33:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:15 INFO - Installing collected packages: psutil 07:33:15 INFO - Running setup.py install for psutil 07:33:15 INFO - building 'psutil._psutil_linux' extension 07:33:15 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 07:33:16 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 07:33:16 INFO - building 'psutil._psutil_posix' extension 07:33:16 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 07:33:16 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 07:33:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:33:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:33:16 INFO - Successfully installed psutil 07:33:16 INFO - Cleaning up... 07:33:16 INFO - Return code: 0 07:33:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:33:16 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')]} 07:33:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:16 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')]} 07:33:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:16 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:16 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 07:33:16 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 07:33:16 INFO - Using env: {'DISPLAY': ':0', 07:33:16 INFO - 'HOME': '/home/cltbld', 07:33:16 INFO - 'LANG': 'en_US.UTF-8', 07:33:16 INFO - 'LANGUAGE': 'en_US:en', 07:33:16 INFO - 'LOGNAME': 'cltbld', 07:33:16 INFO - 'MAIL': '/var/mail/cltbld', 07:33:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:16 INFO - 'MOZ_NO_REMOTE': '1', 07:33:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:16 INFO - 'NO_EM_RESTART': '1', 07:33:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:16 INFO - 'PWD': '/builds/slave/test', 07:33:16 INFO - 'SHELL': '/bin/bash', 07:33:16 INFO - 'SHLVL': '1', 07:33:16 INFO - 'TERM': 'linux', 07:33:16 INFO - 'TMOUT': '86400', 07:33:16 INFO - 'USER': 'cltbld', 07:33:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:16 INFO - '_': '/tools/buildbot/bin/python'} 07:33:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:33:16 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 07:33:16 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 07:33:16 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 07:33:16 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 07:33:16 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 07:33:16 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 07:33:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:33:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:33:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:33:18 INFO - Installing collected packages: mozsystemmonitor 07:33:18 INFO - Running setup.py install for mozsystemmonitor 07:33:18 INFO - Successfully installed mozsystemmonitor 07:33:18 INFO - Cleaning up... 07:33:18 INFO - Return code: 0 07:33:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:18 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:18 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 07:33:18 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 07:33:18 INFO - Using env: {'DISPLAY': ':0', 07:33:18 INFO - 'HOME': '/home/cltbld', 07:33:18 INFO - 'LANG': 'en_US.UTF-8', 07:33:18 INFO - 'LANGUAGE': 'en_US:en', 07:33:18 INFO - 'LOGNAME': 'cltbld', 07:33:18 INFO - 'MAIL': '/var/mail/cltbld', 07:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:18 INFO - 'MOZ_NO_REMOTE': '1', 07:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:18 INFO - 'NO_EM_RESTART': '1', 07:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:18 INFO - 'PWD': '/builds/slave/test', 07:33:18 INFO - 'SHELL': '/bin/bash', 07:33:18 INFO - 'SHLVL': '1', 07:33:18 INFO - 'TERM': 'linux', 07:33:18 INFO - 'TMOUT': '86400', 07:33:18 INFO - 'USER': 'cltbld', 07:33:18 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:18 INFO - '_': '/tools/buildbot/bin/python'} 07:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:19 INFO - Downloading/unpacking jsonschema==2.5.1 07:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:33:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:33:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 INFO - Downloading functools32-3.2.3-2.tar.gz 07:33:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:33:21 INFO - warning: no files found matching '*.txt' 07:33:21 INFO - no previously-included directories found matching 'build' 07:33:21 INFO - no previously-included directories found matching 'dist' 07:33:21 INFO - no previously-included directories found matching '.git*' 07:33:21 INFO - Installing collected packages: jsonschema, functools32 07:33:21 INFO - Running setup.py install for functools32 07:33:21 INFO - warning: no files found matching '*.txt' 07:33:21 INFO - no previously-included directories found matching 'build' 07:33:21 INFO - no previously-included directories found matching 'dist' 07:33:21 INFO - no previously-included directories found matching '.git*' 07:33:21 INFO - Successfully installed jsonschema functools32 07:33:21 INFO - Cleaning up... 07:33:21 INFO - Return code: 0 07:33:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:33:21 INFO - Using env: {'DISPLAY': ':0', 07:33:21 INFO - 'HOME': '/home/cltbld', 07:33:21 INFO - 'LANG': 'en_US.UTF-8', 07:33:21 INFO - 'LANGUAGE': 'en_US:en', 07:33:21 INFO - 'LOGNAME': 'cltbld', 07:33:21 INFO - 'MAIL': '/var/mail/cltbld', 07:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:21 INFO - 'MOZ_NO_REMOTE': '1', 07:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:21 INFO - 'NO_EM_RESTART': '1', 07:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:21 INFO - 'PWD': '/builds/slave/test', 07:33:21 INFO - 'SHELL': '/bin/bash', 07:33:21 INFO - 'SHLVL': '1', 07:33:21 INFO - 'TERM': 'linux', 07:33:21 INFO - 'TMOUT': '86400', 07:33:21 INFO - 'USER': 'cltbld', 07:33:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:21 INFO - '_': '/tools/buildbot/bin/python'} 07:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:33:21 INFO - Cleaning up... 07:33:21 INFO - Return code: 0 07:33:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:33:21 INFO - Using env: {'DISPLAY': ':0', 07:33:21 INFO - 'HOME': '/home/cltbld', 07:33:21 INFO - 'LANG': 'en_US.UTF-8', 07:33:21 INFO - 'LANGUAGE': 'en_US:en', 07:33:21 INFO - 'LOGNAME': 'cltbld', 07:33:21 INFO - 'MAIL': '/var/mail/cltbld', 07:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:21 INFO - 'MOZ_NO_REMOTE': '1', 07:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:21 INFO - 'NO_EM_RESTART': '1', 07:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:21 INFO - 'PWD': '/builds/slave/test', 07:33:21 INFO - 'SHELL': '/bin/bash', 07:33:21 INFO - 'SHLVL': '1', 07:33:21 INFO - 'TERM': 'linux', 07:33:21 INFO - 'TMOUT': '86400', 07:33:21 INFO - 'USER': 'cltbld', 07:33:21 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:21 INFO - '_': '/tools/buildbot/bin/python'} 07:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:21 INFO - Downloading/unpacking blobuploader==1.2.4 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:21 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 07:33:23 INFO - Downloading blobuploader-1.2.4.tar.gz 07:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:33:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:33:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 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 07:33:24 INFO - Downloading docopt-0.6.1.tar.gz 07:33:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:33:24 INFO - Installing collected packages: blobuploader, requests, docopt 07:33:24 INFO - Running setup.py install for blobuploader 07:33:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:33:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:33:24 INFO - Running setup.py install for requests 07:33:25 INFO - Running setup.py install for docopt 07:33:25 INFO - Successfully installed blobuploader requests docopt 07:33:25 INFO - Cleaning up... 07:33:25 INFO - Return code: 0 07:33:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:25 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:25 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 07:33:25 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 07:33:25 INFO - Using env: {'DISPLAY': ':0', 07:33:25 INFO - 'HOME': '/home/cltbld', 07:33:25 INFO - 'LANG': 'en_US.UTF-8', 07:33:25 INFO - 'LANGUAGE': 'en_US:en', 07:33:25 INFO - 'LOGNAME': 'cltbld', 07:33:25 INFO - 'MAIL': '/var/mail/cltbld', 07:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:25 INFO - 'MOZ_NO_REMOTE': '1', 07:33:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:25 INFO - 'NO_EM_RESTART': '1', 07:33:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:25 INFO - 'PWD': '/builds/slave/test', 07:33:25 INFO - 'SHELL': '/bin/bash', 07:33:25 INFO - 'SHLVL': '1', 07:33:25 INFO - 'TERM': 'linux', 07:33:25 INFO - 'TMOUT': '86400', 07:33:25 INFO - 'USER': 'cltbld', 07:33:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:25 INFO - '_': '/tools/buildbot/bin/python'} 07:33:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:25 INFO - Running setup.py (path:/tmp/pip-tRQeYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:25 INFO - Running setup.py (path:/tmp/pip-UEsvLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:25 INFO - Running setup.py (path:/tmp/pip-GKNT0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:25 INFO - Running setup.py (path:/tmp/pip-O5K8Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:25 INFO - Running setup.py (path:/tmp/pip-vQaQgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:25 INFO - Running setup.py (path:/tmp/pip-munoAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:25 INFO - Running setup.py (path:/tmp/pip-rynFj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:26 INFO - Running setup.py (path:/tmp/pip-oixlM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:26 INFO - Running setup.py (path:/tmp/pip-VcW3Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:26 INFO - Running setup.py (path:/tmp/pip-kkYHmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:26 INFO - Running setup.py (path:/tmp/pip-pcgtxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:26 INFO - Running setup.py (path:/tmp/pip-JQcC63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:26 INFO - Running setup.py (path:/tmp/pip-6lilwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:26 INFO - Running setup.py (path:/tmp/pip-0KU6ME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:26 INFO - Running setup.py (path:/tmp/pip-IfKUt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:26 INFO - Running setup.py (path:/tmp/pip-LVlIAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:26 INFO - Running setup.py (path:/tmp/pip-IjgXU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:33:26 INFO - Running setup.py install for manifestparser 07:33:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:33:26 INFO - Running setup.py install for mozcrash 07:33:26 INFO - Running setup.py install for mozdebug 07:33:27 INFO - Running setup.py install for mozdevice 07:33:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for mozfile 07:33:27 INFO - Running setup.py install for mozhttpd 07:33:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for mozinfo 07:33:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for mozInstall 07:33:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for mozleak 07:33:27 INFO - Running setup.py install for mozlog 07:33:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for moznetwork 07:33:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:33:27 INFO - Running setup.py install for mozprocess 07:33:28 INFO - Running setup.py install for mozprofile 07:33:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:33:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:33:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:33:28 INFO - Running setup.py install for mozrunner 07:33:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:33:28 INFO - Running setup.py install for mozscreenshot 07:33:28 INFO - Running setup.py install for moztest 07:33:28 INFO - Running setup.py install for mozversion 07:33:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:33:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:33:28 INFO - Cleaning up... 07:33:28 INFO - Return code: 0 07:33:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:28 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')]} 07:33:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:28 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')]} 07:33:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:28 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:28 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 07:33:28 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 07:33:28 INFO - Using env: {'DISPLAY': ':0', 07:33:28 INFO - 'HOME': '/home/cltbld', 07:33:28 INFO - 'LANG': 'en_US.UTF-8', 07:33:28 INFO - 'LANGUAGE': 'en_US:en', 07:33:28 INFO - 'LOGNAME': 'cltbld', 07:33:28 INFO - 'MAIL': '/var/mail/cltbld', 07:33:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:28 INFO - 'MOZ_NO_REMOTE': '1', 07:33:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:28 INFO - 'NO_EM_RESTART': '1', 07:33:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:28 INFO - 'PWD': '/builds/slave/test', 07:33:28 INFO - 'SHELL': '/bin/bash', 07:33:28 INFO - 'SHLVL': '1', 07:33:28 INFO - 'TERM': 'linux', 07:33:28 INFO - 'TMOUT': '86400', 07:33:28 INFO - 'USER': 'cltbld', 07:33:28 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:28 INFO - '_': '/tools/buildbot/bin/python'} 07:33:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:33:28 INFO - Running setup.py (path:/tmp/pip-P5Dk_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:33:28 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)) 07:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:33:28 INFO - Running setup.py (path:/tmp/pip-OuL5ZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:33:28 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)) 07:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:33:28 INFO - Running setup.py (path:/tmp/pip-17CQw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:33:29 INFO - Running setup.py (path:/tmp/pip-PdPHwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:33:29 INFO - Running setup.py (path:/tmp/pip-aFhs9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:33:29 INFO - Running setup.py (path:/tmp/pip-Zvpgvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:33:29 INFO - Running setup.py (path:/tmp/pip-GuxP1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:33:29 INFO - Running setup.py (path:/tmp/pip-dJLiZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:33:29 INFO - Running setup.py (path:/tmp/pip-aoISMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:33:29 INFO - Running setup.py (path:/tmp/pip-Wn1eYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:33:29 INFO - Running setup.py (path:/tmp/pip-7CWtAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:33:29 INFO - Running setup.py (path:/tmp/pip-LWXJ5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:33:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:33:29 INFO - Running setup.py (path:/tmp/pip-6z2Zbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:33:29 INFO - Running setup.py (path:/tmp/pip-k9GUtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:29 INFO - Running setup.py (path:/tmp/pip-kZEPWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:33:29 INFO - Running setup.py (path:/tmp/pip-3xCoUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:33:29 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)) 07:33:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:33:29 INFO - Running setup.py (path:/tmp/pip-QY1U57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:33:30 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)) 07:33:30 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)) 07:33:30 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)) 07:33:30 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)) 07:33:30 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)) 07:33:30 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)) 07:33:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:33:30 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 07:33:30 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 07:33:30 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 07:33:30 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 07:33:30 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 07:33:30 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 07:33:32 INFO - Downloading blessings-1.6.tar.gz 07:33:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:33:32 INFO - Installing collected packages: blessings 07:33:32 INFO - Running setup.py install for blessings 07:33:32 INFO - Successfully installed blessings 07:33:32 INFO - Cleaning up... 07:33:32 INFO - Return code: 0 07:33:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:33:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:32 INFO - Reading from file tmpfile_stdout 07:33:32 INFO - Current package versions: 07:33:32 INFO - argparse == 1.2.1 07:33:32 INFO - blessings == 1.6 07:33:32 INFO - blobuploader == 1.2.4 07:33:32 INFO - docopt == 0.6.1 07:33:32 INFO - functools32 == 3.2.3-2 07:33:32 INFO - jsonschema == 2.5.1 07:33:32 INFO - manifestparser == 1.1 07:33:32 INFO - mozInstall == 1.12 07:33:32 INFO - mozcrash == 1.0 07:33:32 INFO - mozdebug == 0.1 07:33:32 INFO - mozdevice == 0.49 07:33:32 INFO - mozfile == 1.2 07:33:32 INFO - mozhttpd == 0.7 07:33:32 INFO - mozinfo == 0.9 07:33:32 INFO - mozleak == 0.1 07:33:32 INFO - mozlog == 3.4 07:33:32 INFO - moznetwork == 0.27 07:33:32 INFO - mozprocess == 0.25 07:33:32 INFO - mozprofile == 0.28 07:33:32 INFO - mozrunner == 6.13 07:33:32 INFO - mozscreenshot == 0.1 07:33:32 INFO - mozsystemmonitor == 0.3 07:33:32 INFO - moztest == 0.8 07:33:32 INFO - mozversion == 1.4 07:33:32 INFO - psutil == 3.1.1 07:33:32 INFO - requests == 1.2.3 07:33:32 INFO - wsgiref == 0.1.2 07:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:32 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:32 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 07:33:32 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 07:33:32 INFO - Using env: {'DISPLAY': ':0', 07:33:32 INFO - 'HOME': '/home/cltbld', 07:33:32 INFO - 'LANG': 'en_US.UTF-8', 07:33:32 INFO - 'LANGUAGE': 'en_US:en', 07:33:32 INFO - 'LOGNAME': 'cltbld', 07:33:32 INFO - 'MAIL': '/var/mail/cltbld', 07:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:32 INFO - 'MOZ_NO_REMOTE': '1', 07:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:32 INFO - 'NO_EM_RESTART': '1', 07:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:32 INFO - 'PWD': '/builds/slave/test', 07:33:32 INFO - 'SHELL': '/bin/bash', 07:33:32 INFO - 'SHLVL': '1', 07:33:32 INFO - 'TERM': 'linux', 07:33:32 INFO - 'TMOUT': '86400', 07:33:32 INFO - 'USER': 'cltbld', 07:33:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:32 INFO - '_': '/tools/buildbot/bin/python'} 07:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 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)) 07:33:32 INFO - Cleaning up... 07:33:32 INFO - Return code: 0 07:33:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:33: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')]} 07:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33: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')]} 07:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:32 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 0x171f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x175da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19bd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, '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': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', '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 07:33:32 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 07:33:32 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 07:33:32 INFO - Using env: {'DISPLAY': ':0', 07:33:32 INFO - 'HOME': '/home/cltbld', 07:33:32 INFO - 'LANG': 'en_US.UTF-8', 07:33:32 INFO - 'LANGUAGE': 'en_US:en', 07:33:32 INFO - 'LOGNAME': 'cltbld', 07:33:32 INFO - 'MAIL': '/var/mail/cltbld', 07:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:32 INFO - 'MOZ_NO_REMOTE': '1', 07:33:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:32 INFO - 'NO_EM_RESTART': '1', 07:33:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:32 INFO - 'PWD': '/builds/slave/test', 07:33:32 INFO - 'SHELL': '/bin/bash', 07:33:32 INFO - 'SHLVL': '1', 07:33:32 INFO - 'TERM': 'linux', 07:33:32 INFO - 'TMOUT': '86400', 07:33:32 INFO - 'USER': 'cltbld', 07:33:32 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:32 INFO - '_': '/tools/buildbot/bin/python'} 07:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:33:32 INFO - Cleaning up... 07:33:32 INFO - Return code: 0 07:33:32 INFO - Running post-action listener: _resource_record_post_action 07:33:32 INFO - Running post-action listener: _start_resource_monitoring 07:33:33 INFO - Starting resource monitoring. 07:33:33 INFO - [mozharness: 2017-04-18 14:33:33.009267Z] Finished create-virtualenv step (success) 07:33:33 INFO - [mozharness: 2017-04-18 14:33:33.009744Z] Running install step. 07:33:33 INFO - Running pre-action listener: _resource_record_pre_action 07:33:33 INFO - Running main action method: install 07:33:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:33 INFO - Reading from file tmpfile_stdout 07:33:33 INFO - Detecting whether we're running mozinstall >=1.0... 07:33:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:33:33 INFO - Reading from file tmpfile_stdout 07:33:33 INFO - Output received: 07:33:33 INFO - Usage: mozinstall [options] installer 07:33:33 INFO - Options: 07:33:33 INFO - -h, --help show this help message and exit 07:33:33 INFO - -d DEST, --destination=DEST 07:33:33 INFO - Directory to install application into. [default: 07:33:33 INFO - "/builds/slave/test"] 07:33:33 INFO - --app=APP Application being installed. [default: firefox] 07:33:33 INFO - mkdir: /builds/slave/test/build/application 07:33:33 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'] 07:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:33:49 INFO - Reading from file tmpfile_stdout 07:33:49 INFO - Output received: 07:33:49 INFO - /builds/slave/test/build/application/firefox/firefox 07:33:49 INFO - Running post-action listener: _resource_record_post_action 07:33:49 INFO - [mozharness: 2017-04-18 14:33:49.889583Z] Finished install step (success) 07:33:49 INFO - [mozharness: 2017-04-18 14:33:49.889726Z] Running run-tests step. 07:33:49 INFO - Running pre-action listener: _resource_record_pre_action 07:33:49 INFO - Running main action method: run_tests 07:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:49 INFO - Python 2.7.3 07:33:49 INFO - Return code: 0 07:33:49 INFO - grabbing minidump binary from tooltool 07:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:49 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 0x19ba400>, '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 0x19bb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19bb840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:49 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 07:33:49 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 07:33:49 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 07:33:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:49 INFO - Return code: 0 07:33:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:33:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:49 INFO - ENV: RUST_BACKTRACE is now 1 07:33:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:33:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:49 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/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 07:33:49 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/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 07:33:49 INFO - Using env: {'DISPLAY': ':0', 07:33:49 INFO - 'HOME': '/home/cltbld', 07:33:49 INFO - 'LANG': 'en_US.UTF-8', 07:33:49 INFO - 'LANGUAGE': 'en_US:en', 07:33:49 INFO - 'LOGNAME': 'cltbld', 07:33:49 INFO - 'MAIL': '/var/mail/cltbld', 07:33:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:49 INFO - 'MOZ_NO_REMOTE': '1', 07:33:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:49 INFO - 'NO_EM_RESTART': '1', 07:33:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:49 INFO - 'PWD': '/builds/slave/test', 07:33:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:49 INFO - 'RUST_BACKTRACE': '1', 07:33:49 INFO - 'SHELL': '/bin/bash', 07:33:49 INFO - 'SHLVL': '1', 07:33:49 INFO - 'TERM': 'linux', 07:33:49 INFO - 'TMOUT': '86400', 07:33:49 INFO - 'USER': 'cltbld', 07:33:49 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664', 07:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:49 INFO - '_': '/tools/buildbot/bin/python'} 07:33:49 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/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 07:33:50 INFO - mozversion application_buildid: 20170418133727 07:33:50 INFO - mozversion application_changeset: 4dae386f2c331851b192a3ef493cc139fd562a44 07:33:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:33:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:50 INFO - mozversion application_name: Firefox 07:33:50 INFO - mozversion application_remotingname: firefox-dev 07:33:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:50 INFO - mozversion application_vendor: Mozilla 07:33:50 INFO - mozversion application_version: 54.0a2 07:33:50 INFO - mozversion platform_buildid: 20170418133727 07:33:50 INFO - mozversion platform_changeset: 4dae386f2c331851b192a3ef493cc139fd562a44 07:33:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:50 INFO - mozversion platform_version: 54.0a2 07:33:50 INFO - using testdate: 1492526030 07:33:50 INFO - actual date: 1492526030 07:33:50 INFO - starting webserver on 'localhost:38302' 07:33:50 INFO - SUITE-START | Running 2 tests 07:33:50 INFO - TEST-START | dromaeo_css 07:33:50 INFO - operating with platform_type : linux_ 07:33:50 INFO - Initialising browser for dromaeo_css test... 07:33:50 INFO - TEST-INFO | started process 28335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU4mKDw/profile http://localhost:38302/getInfo.html) 07:33:54 INFO - PROCESS | 28335 | __metrics Screen width/height:1600/1200 07:33:54 INFO - PROCESS | 28335 | colorDepth:24 07:33:54 INFO - PROCESS | 28335 | Browser inner width/height: 1024/697 07:33:54 INFO - PROCESS | 28335 | __metrics 07:33:55 INFO - PROCESS | 28335 | 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" 07:33:55 INFO - PROCESS | 28335 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:56 INFO - TEST-INFO | 28335: exit 0 07:33:56 INFO - Browser initialized. 07:33:56 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:56 INFO - TEST-INFO | started process 28429 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU4mKDw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:34:08 INFO - PROCESS | 28429 | RSS: Main: 139952128 07:34:08 INFO - PROCESS | 28429 | 07:37:09 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38302/tests/dromaeo/cssquery-ext.html) 07:37:11 INFO - PROCESS | 28429 | RSS: Main: 253775872 07:37:11 INFO - PROCESS | 28429 | 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | A coding exception was thrown and uncaught in a Task. 07:38:58 INFO - PROCESS | 28429 | 07:38:58 ERROR - PROCESS | 28429 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:58 INFO - PROCESS | 28429 | Full stack: 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | A coding exception was thrown and uncaught in a Task. 07:38:58 INFO - PROCESS | 28429 | 07:38:58 ERROR - PROCESS | 28429 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:58 INFO - PROCESS | 28429 | Full stack: 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | A coding exception was thrown and uncaught in a Task. 07:38:58 INFO - PROCESS | 28429 | 07:38:58 ERROR - PROCESS | 28429 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:58 INFO - PROCESS | 28429 | Full stack: 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | ************************* 07:38:58 INFO - PROCESS | 28429 | A coding exception was thrown and uncaught in a Task. 07:38:58 INFO - PROCESS | 28429 | 07:38:58 ERROR - PROCESS | 28429 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:38:58 INFO - PROCESS | 28429 | Full stack: 07:38:58 INFO - PROCESS | 28429 | ************************* 07:40:13 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-ext.html (next: http://localhost:38302/tests/dromaeo/cssquery-jquery.html) 07:40:13 INFO - PROCESS | 28429 | RSS: Main: 227168256 07:40:13 INFO - PROCESS | 28429 | 07:43:15 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38302/tests/dromaeo/cssquery-mootools.html) 07:43:16 INFO - PROCESS | 28429 | RSS: Main: 223150080 07:43:16 INFO - PROCESS | 28429 | 07:46:18 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38302/tests/dromaeo/cssquery-prototype.html) 07:46:18 INFO - PROCESS | 28429 | RSS: Main: 170336256 07:46:18 INFO - PROCESS | 28429 | 07:49:21 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38302/tests/dromaeo/cssquery-yui.html) 07:49:22 INFO - PROCESS | 28429 | RSS: Main: 175775744 07:49:22 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | Cycle 1(1): loaded http://localhost:38302/tests/dromaeo/cssquery-yui.html (next: http://localhost:38302/tests/dromaeo/cssquery-dojo.html) 07:52:24 INFO - PROCESS | 28429 | RSS: Main: 268775424 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | __start_tp_report 07:52:24 INFO - PROCESS | 28429 | _x_x_mozilla_page_load 07:52:24 INFO - PROCESS | 28429 | _x_x_mozilla_page_load_details 07:52:24 INFO - PROCESS | 28429 | |i|pagename|runs| 07:52:24 INFO - PROCESS | 28429 | |0;dojo.html;3431.5538979932603;3447.362237985972;3457.550518432605;3477.304539092182;3513.718902487801;5823.912641310384;5889.381614930435;5910.202122713443;5912.497437717789;5919.171316015756;5849.79525716599;5882.14708867214;5891.381404952483;5900.734466948987;5903.321118071423;5209.036328279271;5228.79084836606;5248.475152484759;5291.444398338177;5307.601929855257;5140.280360749498;5160.974195129019;5318.494742999409;5325.946740532603;5328.706921119337;5219.42586315505;5251.684898906059;5315.202719592054;5322.520973112419;5333.386660534049;5345;5352.357717073937;5354.384245811742;5356.571474282048;5356.785728570872;5101.464346243628;5129.256257842592;5191.818286359997;5266.0257852297445;5350.117230656937;5719.056355701305;5737.598368114233;5773.740181691792;5799.5650326225705;5804.100364443518;6202.255729312466;6233.252009758858;6267.185265915447;6276.96861515694;6289.968550157266;6131.051857025259;6315;6336.46140078094;6337.524685648595;6352.428281454645;5768.798092066758;5769.798057067983;5794.21778059965;5801.8549536261935;5849;6339.11252424661;6368.235811702625;6370.108184854124;6376.649284289409;6377.71300291488;6031.24609423822;6083.969580152071;6133.233345831771;6144.446999770043;6149.477294430024;6184;6187.535934804908;6199.411055949678;6228.22147231596;6233.719482623293;6225.8132256032395;6279.120923070774;6290.496760259169;6292.2134733158355;6294.339094395114;6106.114613381035;6110.953680641517;6112.868254062989;6186.350433204539;6277.2153480814895;4784.40194975628;4789.3294938708605;4800.3279540864305;4808.927866082012;4810.470848206694;4247.193033323659;4254.7021708480725;4259.169461954889;4281.2293787118;4281.657467402601;5750.396208398141;5791.015527360359;6087.117367981707;6087.908681369783;6090.756369745161;6194.194754681863;6220.875582488325;6293.150424692608;6302.338254483305;6323.272823625342;6034.788782392683;6048.455638992512;6050.667213303311;6061.54538409621;6063.265825183641;5327.121025030827;5328.893422131536;5329.760160792774;5337.519623233928;5339.119045357473;6318.526110541728;6326.936730632727;6417.358264173546;6425.421712045938;6466.288708242089;6335.334789847184;6336.556441049082;6341.8731625368155;6356;6357.809265722036;6545.803625891231;6582.703778329891;6597.901031484435;6598;6598.703058362289;6037.184980027816;6056.3035250946705;6062.120992455981;6153.600015998945;6213.347598502092;6196.504279657526;6224.657643829632;6232.501399887908;6237.220347456568;6240.875182496234;6063;6072.271327440735;6074.863969600762;6075;6125.693715314305;5910.438508341701;5939.554533410098;6035.637861728311;6049.153118563317;6092.817215483543;6060.545459090674;6069.241344831896;6133.723982420713;6146.385361463817;6163.476104531165;6137.864495068427;6138.202033735586;6148.4773794227995;6150.323464419;6156.29202641702;5824.854378640568;5871.823845284648;5882.205902203148;5894.793682221101;5941.554383421174 07:52:24 INFO - PROCESS | 28429 | |1;ext.html;739.6819367671899;802.514478740362;822.7490615362316;854.3336197765744;865.9956700216502;31535.21161970952;43936.78031609841;44918.55081449184;45029.09941801162;45149;44758.32862507065;44948.3257751134;44997.32504012442;45007.549924500745;45093;7660.119086305091;7850.842983140334;9157.542122893861;9320.114589114024;9330;10757.30077544961;10950.34297942126;11337.206395552315;11344.829827552594;11350.71623209418;11102.888971110307;11119.777604447907;11139.72150696235;11140.777184456307;11148;11002.834957475645;11049.392283424408;11072.612458563912;11083.667489975314;11093.223474356799;10613.097886679641;10641.361518308926;10704.678859634223;10707.036366727032;10707.411092389915;40886.1822763546;40985;41024.58975410237;41100.58899411027;41103.794481027704;4166.91666166678;4183.602557757008;4219.43037689911;4234.745915245096;4316.266234740102;30243.697563024307;30323.696763032527;30528.54207186894;30577.235569110726;31918.680813192037;4252;4455.487618923833;4461.08547747711;4478.328250762412;4512.368268442421;237117;238630.99999999825;239484;240107;240806;46841;47111.05777884423;47136.29295560569;47151.29273060907;47204;48514.75742621264;48712;48736;48749.512504874496;48759.26861097087;15673.921630392004;15858.048517089012;15890.920545397199;15893.920530397274;15897.841021589868;12265.141440099107;12560.434780434902;13712.588622341145;13872.861271387157;13874.098183618033;11813.350265735295;12468.937655311847;12857.292848893214;13195.934020330029;13268.53560125391;5266.657667251617;5309.761060752276;5330.067238233293;5377.085895397791;5394.433584473652;989.9158571521501;990.8563258327646;1000.9099181073739;1002.6340385759146;1007.9496025198711;28576.285592859927;28747.28131796722;28828.279293017422;28992.855035724686;29417.411651766844;1062.5059347403494;1079.390144568332;1089.6022951622601;1105.635140403681;1112.4159816096615;14933.775993360108;15123.773143402857;15259.160746158846;15472.381104755683;15497.690046199014;341244;345034;345658;345700;346159;56820.14769778457;57092.143617845766;57155.42844571584;57337.426625733206;57641.711791441616;1489.2330449818353;1491.135141617859;1511.8790496760232;1517.8861585381142;1530.5714399968026;26552.468950620492;27727.168184954484;27810.86094569514;28213.294667632654;28281;42222.366664499445;42311;42337.57662423459;42356.788216058725;42503.99999999876;293879;294538;294669;295554;296125;32018.51972220372;32455.350892982482;32536.51195232026;32681.673183268813;32824.83587582047;43490.78254608833;44045;44508;44998.55001449944;45394.773026135976;33540.49689254712;33700.325993479506;33727.3254534903;33742;33839.15402114967;33219.66780332166;33285.66714332825;33621.327573448885;33882.32235355328;34626.82686586652;38364.232715346094;39003.07476939184;39226.2154756909;39263.84048877225;39569.60430395659;32017;32311;32345.191370215933;32355;32455.026349209562;25227;25930.481390372464;25939.481210376063;26067.869660652334;26762.732372676805 07:52:24 INFO - PROCESS | 28429 | |2;jquery.html;415.38108218754064;463.4762718128515;466.7876116367053;471.17073949848276;484.95635392814637;19927.800721992775;19943.60112797745;20169.798302016974;21299.25452609159;21699.457513562167;21068.473288167766;21187.36437906865;21595.1361945522;22033.669494957547;22065.889670551624;6489.253735820382;6493.545451818374;6670.93329066708;6675.299093595176;6727.730890764364;4184.288670925935;4371.34429835524;6747.08914296571;6818.965905170492;6866.725330986755;7392.33468987791;7646.311831935125;7681.846363072763;7683.961580192091;7684.807879802994;7464.514806537585;7636.083669959585;7663.846723065563;7671.578063206522;7708.180323855481;7371.447141464411;7455;7463.216362281936;7570.621468926587;7632.236776322379;20607.381778546667;20650.58698826015;24640.630390544156;25287;25989.22032339014;3589.5154154189113;3598.1004748812798;3643.8178091095338;3696.5194524711615;3712.925741485155;15905.443309484113;16504.504864854072;16651.41720039805;16849.41027064047;17216.139193040297;2300.4478925058033;2351.9412014699597;2374.691290132289;2406.542756876205;2417.10567090176;111063;111165.44417277943;111851;112147;112371;14117.64705882345;16299.429519966745;17807.910960445115;18173.63652726938;18725.90637046806;31750.364992700015;31803.363932721215;31840.68159318377;32145.51781723276;32337.838310808766;10594.735131621772;10688.25182237236;10710.089642380484;10811;10942.562297508011;8954.552272386354;9004.59479323432;9012.774680632905;9172.724818255463;9191;9020.774480638036;9120.26392082386;9232;9338.439693618404;9560.904390956;3583.982080089635;3709.703223742094;3847.711421643388;3972.0139930034984;3976.4830572025453;954.6324665004023;968.0899954043317;969.6606187834202;978.814025335184;989.4162444157981;19823.405297841087;21067;21155.8942205288;21179.576408471745;21352.466188345104;976.7167521418709;983.7442265011006;987.9160271377013;991.548845275398;993.3245393132739;11171.050460710769;11529.308241505536;11556.248843825124;11725.589604363977;11732.824007639892;608411;616874;618688;638294;667472;88533;104946.47526762317;117579;118643.40678296554;122169;1270.1997741423029;1287.575100216926;1315.7368526294779;1316.3220941215282;1319.274399080521;13857.861421385656;17765.911170444066;18162.09189540544;18826.24695012184;19310.227590896768;53612.73193634007;53901;54379.72810135924;54692;55252.171217430965;68924;69084;69118;69611;69847;12455.252684838939;12710.682232944251;12812.679683007627;12861.742765144458;13016.219026858418;13796.793048104086;13970;14266.714665706835;14608.612181842707;14708.632284192981;12228.571999979958;12466.501339946662;12904.741905162033;13020;13115.540956066492;11720.70698232551;11932.522699091938;12069.637910862688;12201;12249.755004899675;12624.17942833713;12669.80995285053;12720.363981800689;12812.55156069533;13037.022223333099;11628.94185529067;12093.879061209627;12528;12681.4293356801;12974.870251297367;12016.158868879094;12679.93660031694;12842.614721558368;12866.228026318451;12932.741345173232 07:52:24 INFO - PROCESS | 28429 | |3;mootools.html;1500.9699806003873;1519.7796319533668;1548.922553872306;1561.5315405378387;1571.2536545141058;10944.726381840457;11699.941500292487;11725;11732.765344693102;11739.882601173986;11287.830682539749;11661.533538658465;11977.820332695017;11983.340916249603;11983.340916249603;2565.7434256574334;2606.9348266293305;2607.1526753804997;2608.0610980047168;2610.3474131467133;2483.8137139714504;2592.0927675313583;2606.9869650651817;2610.2430295214367;2611.5299246135687;2411.4694767151286;2503.161440917295;2504.0484615846044;2505.549001179787;2522.571162902311;2390.725066617344;2439.195065628347;2450.803935685141;2473.51766405551;2474.9752502474926;2394.5330660521204;2418.685570875775;2435.0625009371342;2436.049940523197;2436.9268921932194;10825.13398928084;10844.240903136784;10857.294275872044;10876.836847447295;10885.83671244932;6045.758169673208;6163.01391777318;6237.750489980395;6244.094606282064;6245.500359971192;3691.169486865461;3740.7194460415576;3771.396576547739;3818.1600047989677;3831.961680383188;1321.5969129415525;1385.4319728911098;1416.9291535423188;2181.4110190248703;2278.9658155127686;14837.7774333384;15286.464973725866;15901;17963.461096167135;18160.455186344432;4949.876253093701;4972.378452693413;4974.32846565709;5119.820806271762;5124.769385377667;12726.600073991853;12729.872701272869;12730.045246606542;12753.426095825711;12755.170913890568;6056.606320589148;6056.606320589148;6056.697165141725;6057.061155520902;6059.030555111161;5595.18869763882;5656.6888821115235;5729.942700572941;5741.253637027244;5758.798442054508;4360.236958532244;4402.84590039347;4494.213512635276;4502.954970450319;4513.142502924434;1189.8453201083803;1224.1561496899565;1228.0298564134412;1241.596481143632;1242.6272118364636;1014.9695509134738;1040.69819752271;1046.7801761630144;1050.9421981791074;1055.2454994678842;7043.260457651975;7085.787426377217;7157.964210178916;7172.784816455514;7291.4531410144455;987.3532835992437;1019.3985548526405;1027.8201314769885;1091.6724982505216;1099.7030801683661;4454.799534020977;4686.95313046872;4747.620190384761;4811.879703007383;4993.800247990112;14485.130892146504;15045.473408430653;15193.772093418607;15199.848001520064;15430.691386172213;14703.264836758333;14751.262436878113;14979.850201497846;15055.171965541782;15251.084934903942;8940.418872773249;10942.617008404668;11155.665330040112;11157.944210278896;11168.66494005181;6563.573367731082;7476.887846682413;7511.098668159856;7547.0943486781935;7562.773116806505;12558.87441125577;12815.423305951068;12959.676008099874;13199;13295.135816171918;13093.607191784262;13109.672258193621;13339.866601333862;13390.732185356044;13483.73032539324;9233.122853328923;9302.302327325342;9368.203702685076;9379.624815007322;9444.95277523608;10789.838152427878;10790;10866.78266434651;10879.45602719845;10973.177011724312;8808.867866981873;8884.644614215358;8934.687285944961;9071.954640226757;9072.092790720875;8565.143485651633;8748.256398206224;8803.251723603566;8865.157810008039;8983.416077954913;8227.177282271965;8344.165583441607;8431.95784021076;8471.152884711479;8515.701950431705;6277;6334.081558174131;6382.505009524391;6385.744570217325;6487.286398496256;6584;6601.240857301472;6719.697613607302;6738.764143254963;6796.898046529207 07:52:24 INFO - PROCESS | 28429 | |4;prototype.html;411.96791613722996;422.36223302812743;426.46904603768314;433.19425867885747;433.8676703605401;5346.224797404374;5348.144296912495;5351.769093108583;5353.260190438109;5354.95578362219;4974.228994505857;5120.411152717438;5148.279240906276;5209.817656382027;5216.930529241506;4230.259704551707;4305.4833419989645;4336.349547567875;4348.760818155;4354.695171338008;4343.478782546099;4343.739375637456;4344.695871289011;4352.912941741163;4353.064091220387;4281.18049828823;4325.653947684178;4353.542877997812;4381.780910954455;4385.10105428388;4135.29699951006;4308.116836048634;4337.457817772778;4373.475182978063;4384.89037774055;4051.7917734834587;4062.4921884764403;4065.9796701016603;4070.837166513336;4089.7137200395982;5056.84829455117;5071.923921141186;5074.955026983817;5075.096838685493;5090.516400941941;4865.44047434546;4977.552020318189;5013.724245166514;5036.370453693288;5128.410232823198;5403.810866619689;5408.432114627947;5408.486193811582;5430.75561599725;5432.375276843174;4514.45826500822;4546.386237857913;4552.248878934972;4620.399348084761;4631.791569379386;5429.945700542983;5614.466625670514;5672.858178545569;5708.915306091829;5729.312482502085;4632.328312394684;4640.097560000384;4661.044485880387;4681.578657920803;4687.226607609774;4722.858314250578;4728.456227533878;4737.786799594027;4779.211430114062;4792.568668819823;4885.389326334208;4964.8758781030765;5042.672226305279;5107.565856902131;5107.923381149286;5342.2787923630585;5394.973025134849;5408.242846001563;5415;5434.510894019557;1644.3011720018944;1658.4361317152227;1663.3014134063721;1664.6920319740886;1664.9583760406088;1266;1273.6433798536425;1294.3269499860207;1297.7145028093805;1300.4524615707467;5311.787528498817;5315.627906046617;5349.251104845324;5384.273123128328;5448.291722076105;5576.219329293902;5639.43605639441;5658.81164955364;5674.2339784129435;5683.38023663254;5233.267342572043;5397.487238712316;5417.864553386118;5441.211024401518;5478.945210547923;2977.940441191164;2984.164433958495;2987.2830520674884;2992.610960575155;2995.7303842654264;5502.5597952163735;5845.210896528914;5856.648601083949;5862.446451690305;5868.383819698955;5384.246205531229;5619.381867994517;5779.508741756914;5779.508741756998;5779.88440231193;5651.26533550644;5658.462446067617;5760.913586296209;5814.505767009851;5825.737841797045;5581.5255703265675;5592.161175823659;5611.410801865745;5612.663240205601;5632.802851900164;5039.798408063783;5267.7884086659515;5291.656042357235;5506.256655351636;5594.916076258778;5757.424257574209;5766.365699772938;5785.6817875015595;5804.693943862597;5822.301323841166;4567.109413664303;4597.885052873705;4600;4628.9537104628525;4677;5565.5825813063375;5568.415316391721;5641.633293835887;5665.5750818689585;5725.370209276893;5445.918311225414;5452.318460192476;5464.371597266365;5537;5552.333719953632;5222.991052660172;5492.642978206404;5509;5510.669359838423;5516.613837031369;5413.242146099628;5422.213779002102;5449.509544141047;5480.808171713971;5534.086875665631;5393.8112166074;5483.369412517612;5494.670319780826;5502.642328248651;5506.394296627448;5045.208950822405;5283.418823929288;5332.813351532678;5407.675539467645;5423.457654234545 07:52:24 INFO - PROCESS | 28429 | |5;yui.html;877.8244351129775;885.4687187687389;922.4511415707656;925.0537879614116;938.6057855700606;17256.482305530837;17280.567985800346;17882.37411690591;18536.81463185368;18768.71846922294;16446.67106657866;16848.83151168488;17045.914770426163;17062.488125356227;17313.220905059272;874.6632546469607;883.5228976352794;896.6547879066541;900.9054049324825;906.9591868365907;894.449913303317;895.1496078725237;896.4038914122101;896.4173287363201;896.7444278380663;960.7502049467154;960.8270511307961;962.3552220012573;962.562034274407;963.1572374172599;949.7768024514234;952.4095061062117;952.7475219066918;953.2040745977083;954.0173621170136;700.4116542104606;701.386286998876;701.4003027411541;701.6667083135521;702.2029995954578;17521.123943802886;17580.208890599955;17708.822911770847;18929.148188331557;19186.520336991547;16063.91968040164;16320.999999999882;16515.58711032234;16669.24988375526;16910.74633880493;13497.662558436019;13612.863871361358;13765;14184.361703723254;14226.644333891632;3991.960080399188;4082.897927551835;4107.301758701028;4135.359019352005;4226.809793559267;90123;90303;90429;92192.53903730438;94261;12338.259704417764;12375.133740638248;12404.131710780159;12424.813627795591;12488.50045998168;24547;24560;24565.263042108767;24634;24683.382915427257;8233.300169485541;8387.287080598095;8391.874121888177;8405.537695426689;8545.786355341043;4582.221022426195;4658.580727734452;4659.394278743742;4709.764511774466;4772.880677983078;3797.6392242736897;3902.35611124167;3911.8630847920754;3920.1179734560064;3920.294347017564;637.1175921348872;643.8454770854961;651.212033439534;651.6546230497844;653.2259272761697;644.7388807532957;670.5473805181581;674.3593586093133;680.9250982391933;686.8557602903346;11255.43722813856;11618.76762464746;11661.6501504955;11862.7934675897;12142.757144857052;849.7408290471342;859.8366310401004;862.1335557764406;866.6923242249037;872.0843114729508;5157.948420515821;5180.922286165711;5181.689098654093;5238.292830467914;5245.842624721265;67981.66009169923;79603.20396795958;81458.59270703609;82264;83602;64134.679326603065;68937.65531172312;69182;70681.64659176671;71672.28327716656;63931;64931;65647;65762.34237657562;66025.66987165129;9886.950565247127;10124.69625911224;10125.949370253102;10175.643852465128;10182.236332275257;46164.7691761539;46358.7682061601;46892;47157.528424716686;47470.52529474661;52494.21258681046;52750.47249527455;52832.73583632057;52988.73505632447;53296.20055699245;12339.814902776645;12378.195417297848;12600.243985360908;12664.556740514037;12876.806847897476;14639.780403294171;14806.851931480547;14815.777763333774;14857.331420086339;14957.626059348604;12849.807252891027;13592;13828.792568111687;13838.100523465942;14105.294735263402;14997.850021500082;16384.26270817792;16538.669226615642;16820.915895420934;16947.067911265;15600.219989000278;15781.763273551136;15965.44120955761;16561.751573726164;17044.14779261057;10399.48002599882;10683.786324273626;10763.300385474919;10879.347239165676;11041.558337666404;13412.597622071353;13434.328283585977;13558.796618050934;13664.863351366359;13828 07:52:24 INFO - PROCESS | 28429 | __end_tp_report 07:52:24 INFO - PROCESS | 28429 | __start_cc_report 07:52:24 INFO - PROCESS | 28429 | _x_x_mozilla_cycle_collect,1162 07:52:24 INFO - PROCESS | 28429 | __end_cc_report 07:52:24 INFO - PROCESS | 28429 | __startTimestamp1492527144622__endTimestamp 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | ------- Summary: start ------- 07:52:24 INFO - PROCESS | 28429 | Number of tests: 6 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#0] dojo.html Cycles:165 Average:5799.73 Median:6060.55 stddev:655.92 (10.8%) stddev-sans-first:631.07 07:52:24 INFO - PROCESS | 28429 | Values: 3431.6 3447.4 3457.6 3477.3 3513.7 5823.9 5889.4 5910.2 5912.5 5919.2 5849.8 5882.1 5891.4 5900.7 5903.3 5209.0 5228.8 5248.5 5291.4 5307.6 5140.3 5161.0 5318.5 5325.9 5328.7 5219.4 5251.7 5315.2 5322.5 5333.4 5345.0 5352.4 5354.4 5356.6 5356.8 5101.5 5129.3 5191.8 5266.0 5350.1 5719.1 5737.6 5773.7 5799.6 5804.1 6202.3 6233.3 6267.2 6277.0 6290.0 6131.1 6315.0 6336.5 6337.5 6352.4 5768.8 5769.8 5794.2 5801.9 5849.0 6339.1 6368.2 6370.1 6376.6 6377.7 6031.2 6084.0 6133.2 6144.4 6149.5 6184.0 6187.5 6199.4 6228.2 6233.7 6225.8 6279.1 6290.5 6292.2 6294.3 6106.1 6111.0 6112.9 6186.4 6277.2 4784.4 4789.3 4800.3 4808.9 4810.5 4247.2 4254.7 4259.2 4281.2 4281.7 5750.4 5791.0 6087.1 6087.9 6090.8 6194.2 6220.9 6293.2 6302.3 6323.3 6034.8 6048.5 6050.7 6061.5 6063.3 5327.1 5328.9 5329.8 5337.5 5339.1 6318.5 6326.9 6417.4 6425.4 6466.3 6335.3 6336.6 6341.9 6356.0 6357.8 6545.8 6582.7 6597.9 6598.0 6598.7 6037.2 6056.3 6062.1 6153.6 6213.3 6196.5 6224.7 6232.5 6237.2 6240.9 6063.0 6072.3 6074.9 6075.0 6125.7 5910.4 5939.6 6035.6 6049.2 6092.8 6060.5 6069.2 6133.7 6146.4 6163.5 6137.9 6138.2 6148.5 6150.3 6156.3 5824.9 5871.8 5882.2 5894.8 5941.6 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#1] ext.html Cycles:180 Average:46102.17 Median:32495.93 stddev:77368.84 (238.1%) stddev-sans-first:77510.91 07:52:24 INFO - PROCESS | 28429 | Values: 739.7 802.5 822.7 854.3 866.0 31535.2 43936.8 44918.6 45029.1 45149.0 44758.3 44948.3 44997.3 45007.5 45093.0 7660.1 7850.8 9157.5 9320.1 9330.0 10757.3 10950.3 11337.2 11344.8 11350.7 11102.9 11119.8 11139.7 11140.8 11148.0 11002.8 11049.4 11072.6 11083.7 11093.2 10613.1 10641.4 10704.7 10707.0 10707.4 40886.2 40985.0 41024.6 41100.6 41103.8 4166.9 4183.6 4219.4 4234.7 4316.3 30243.7 30323.7 30528.5 30577.2 31918.7 4252.0 4455.5 4461.1 4478.3 4512.4 237117.0 238631.0 239484.0 240107.0 240806.0 46841.0 47111.1 47136.3 47151.3 47204.0 48514.8 48712.0 48736.0 48749.5 48759.3 15673.9 15858.0 15890.9 15893.9 15897.8 12265.1 12560.4 13712.6 13872.9 13874.1 11813.4 12468.9 12857.3 13195.9 13268.5 5266.7 5309.8 5330.1 5377.1 5394.4 989.9 990.9 1000.9 1002.6 1007.9 28576.3 28747.3 28828.3 28992.9 29417.4 1062.5 1079.4 1089.6 1105.6 1112.4 14933.8 15123.8 15259.2 15472.4 15497.7 341244.0 345034.0 345658.0 345700.0 346159.0 56820.1 57092.1 57155.4 57337.4 57641.7 1489.2 1491.1 1511.9 1517.9 1530.6 26552.5 27727.2 27810.9 28213.3 28281.0 42222.4 42311.0 42337.6 42356.8 42504.0 293879.0 294538.0 294669.0 295554.0 296125.0 32018.5 32455.4 32536.5 32681.7 32824.8 43490.8 44045.0 44508.0 44998.6 45394.8 33540.5 33700.3 33727.3 33742.0 33839.2 33219.7 33285.7 33621.3 33882.3 34626.8 38364.2 39003.1 39226.2 39263.8 39569.6 32017.0 32311.0 32345.2 32355.0 32455.0 25227.0 25930.5 25939.5 26067.9 26762.7 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#2] jquery.html Cycles:180 Average:36790.42 Median:12183.17 stddev:103941.70 (853.2%) stddev-sans-first:104197.40 07:52:24 INFO - PROCESS | 28429 | Values: 415.4 463.5 466.8 471.2 485.0 19927.8 19943.6 20169.8 21299.3 21699.5 21068.5 21187.4 21595.1 22033.7 22065.9 6489.3 6493.5 6670.9 6675.3 6727.7 4184.3 4371.3 6747.1 6819.0 6866.7 7392.3 7646.3 7681.8 7684.0 7684.8 7464.5 7636.1 7663.8 7671.6 7708.2 7371.4 7455.0 7463.2 7570.6 7632.2 20607.4 20650.6 24640.6 25287.0 25989.2 3589.5 3598.1 3643.8 3696.5 3712.9 15905.4 16504.5 16651.4 16849.4 17216.1 2300.4 2351.9 2374.7 2406.5 2417.1 111063.0 111165.4 111851.0 112147.0 112371.0 14117.6 16299.4 17807.9 18173.6 18725.9 31750.4 31803.4 31840.7 32145.5 32337.8 10594.7 10688.3 10710.1 10811.0 10942.6 8954.6 9004.6 9012.8 9172.7 9191.0 9020.8 9120.3 9232.0 9338.4 9560.9 3584.0 3709.7 3847.7 3972.0 3976.5 954.6 968.1 969.7 978.8 989.4 19823.4 21067.0 21155.9 21179.6 21352.5 976.7 983.7 987.9 991.5 993.3 11171.1 11529.3 11556.2 11725.6 11732.8 608411.0 616874.0 618688.0 638294.0 667472.0 88533.0 104946.5 117579.0 118643.4 122169.0 1270.2 1287.6 1315.7 1316.3 1319.3 13857.9 17765.9 18162.1 18826.2 19310.2 53612.7 53901.0 54379.7 54692.0 55252.2 68924.0 69084.0 69118.0 69611.0 69847.0 12455.3 12710.7 12812.7 12861.7 13016.2 13796.8 13970.0 14266.7 14608.6 14708.6 12228.6 12466.5 12904.7 13020.0 13115.5 11720.7 11932.5 12069.6 12201.0 12249.8 12624.2 12669.8 12720.4 12812.6 13037.0 11628.9 12093.9 12528.0 12681.4 12974.9 12016.2 12679.9 12842.6 12866.2 12932.7 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#3] mootools.html Cycles:180 Average:7201.48 Median:2503.60 stddev:4489.25 (179.3%) stddev-sans-first:4481.41 07:52:24 INFO - PROCESS | 28429 | Values: 1501.0 1519.8 1548.9 1561.5 1571.3 10944.7 11699.9 11725.0 11732.8 11739.9 11287.8 11661.5 11977.8 11983.3 11983.3 2565.7 2606.9 2607.2 2608.1 2610.3 2483.8 2592.1 2607.0 2610.2 2611.5 2411.5 2503.2 2504.0 2505.5 2522.6 2390.7 2439.2 2450.8 2473.5 2475.0 2394.5 2418.7 2435.1 2436.0 2436.9 10825.1 10844.2 10857.3 10876.8 10885.8 6045.8 6163.0 6237.8 6244.1 6245.5 3691.2 3740.7 3771.4 3818.2 3832.0 1321.6 1385.4 1416.9 2181.4 2279.0 14837.8 15286.5 15901.0 17963.5 18160.5 4949.9 4972.4 4974.3 5119.8 5124.8 12726.6 12729.9 12730.0 12753.4 12755.2 6056.6 6056.6 6056.7 6057.1 6059.0 5595.2 5656.7 5729.9 5741.3 5758.8 4360.2 4402.8 4494.2 4503.0 4513.1 1189.8 1224.2 1228.0 1241.6 1242.6 1015.0 1040.7 1046.8 1050.9 1055.2 7043.3 7085.8 7158.0 7172.8 7291.5 987.4 1019.4 1027.8 1091.7 1099.7 4454.8 4687.0 4747.6 4811.9 4993.8 14485.1 15045.5 15193.8 15199.8 15430.7 14703.3 14751.3 14979.9 15055.2 15251.1 8940.4 10942.6 11155.7 11157.9 11168.7 6563.6 7476.9 7511.1 7547.1 7562.8 12558.9 12815.4 12959.7 13199.0 13295.1 13093.6 13109.7 13339.9 13390.7 13483.7 9233.1 9302.3 9368.2 9379.6 9445.0 10789.8 10790.0 10866.8 10879.5 10973.2 8808.9 8884.6 8934.7 9072.0 9072.1 8565.1 8748.3 8803.3 8865.2 8983.4 8227.2 8344.2 8432.0 8471.2 8515.7 6277.0 6334.1 6382.5 6385.7 6487.3 6584.0 6601.2 6719.7 6738.8 6796.9 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#4] prototype.html Cycles:180 Average:4764.34 Median:5287.54 stddev:1261.52 (23.9%) stddev-sans-first:1222.03 07:52:24 INFO - PROCESS | 28429 | Values: 412.0 422.4 426.5 433.2 433.9 5346.2 5348.1 5351.8 5353.3 5355.0 4974.2 5120.4 5148.3 5209.8 5216.9 4230.3 4305.5 4336.3 4348.8 4354.7 4343.5 4343.7 4344.7 4352.9 4353.1 4281.2 4325.7 4353.5 4381.8 4385.1 4135.3 4308.1 4337.5 4373.5 4384.9 4051.8 4062.5 4066.0 4070.8 4089.7 5056.8 5071.9 5075.0 5075.1 5090.5 4865.4 4977.6 5013.7 5036.4 5128.4 5403.8 5408.4 5408.5 5430.8 5432.4 4514.5 4546.4 4552.2 4620.4 4631.8 5429.9 5614.5 5672.9 5708.9 5729.3 4632.3 4640.1 4661.0 4681.6 4687.2 4722.9 4728.5 4737.8 4779.2 4792.6 4885.4 4964.9 5042.7 5107.6 5107.9 5342.3 5395.0 5408.2 5415.0 5434.5 1644.3 1658.4 1663.3 1664.7 1665.0 1266.0 1273.6 1294.3 1297.7 1300.5 5311.8 5315.6 5349.3 5384.3 5448.3 5576.2 5639.4 5658.8 5674.2 5683.4 5233.3 5397.5 5417.9 5441.2 5478.9 2977.9 2984.2 2987.3 2992.6 2995.7 5502.6 5845.2 5856.6 5862.4 5868.4 5384.2 5619.4 5779.5 5779.5 5779.9 5651.3 5658.5 5760.9 5814.5 5825.7 5581.5 5592.2 5611.4 5612.7 5632.8 5039.8 5267.8 5291.7 5506.3 5594.9 5757.4 5766.4 5785.7 5804.7 5822.3 4567.1 4597.9 4600.0 4629.0 4677.0 5565.6 5568.4 5641.6 5665.6 5725.4 5445.9 5452.3 5464.4 5537.0 5552.3 5223.0 5492.6 5509.0 5510.7 5516.6 5413.2 5422.2 5449.5 5480.8 5534.1 5393.8 5483.4 5494.7 5502.6 5506.4 5045.2 5283.4 5332.8 5407.7 5423.5 07:52:24 INFO - PROCESS | 28429 | 07:52:24 INFO - PROCESS | 28429 | [#5] yui.html Cycles:180 Average:18838.91 Median:46261.77 stddev:23528.95 (50.9%) stddev-sans-first:23556.30 07:52:24 INFO - PROCESS | 28429 | Values: 877.8 885.5 922.5 925.1 938.6 17256.5 17280.6 17882.4 18536.8 18768.7 16446.7 16848.8 17045.9 17062.5 17313.2 874.7 883.5 896.7 900.9 907.0 894.4 895.1 896.4 896.4 896.7 960.8 960.8 962.4 962.6 963.2 949.8 952.4 952.7 953.2 954.0 700.4 701.4 701.4 701.7 702.2 17521.1 17580.2 17708.8 18929.1 19186.5 16063.9 16321.0 16515.6 16669.2 16910.7 13497.7 13612.9 13765.0 14184.4 14226.6 3992.0 4082.9 4107.3 4135.4 4226.8 90123.0 90303.0 90429.0 92192.5 94261.0 12338.3 12375.1 12404.1 12424.8 12488.5 24547.0 24560.0 24565.3 24634.0 24683.4 8233.3 8387.3 8391.9 8405.5 8545.8 4582.2 4658.6 4659.4 4709.8 4772.9 3797.6 3902.4 3911.9 3920.1 3920.3 637.1 643.8 651.2 651.7 653.2 644.7 670.5 674.4 680.9 686.9 11255.4 11618.8 11661.7 11862.8 12142.8 849.7 859.8 862.1 866.7 872.1 5157.9 5180.9 5181.7 5238.3 5245.8 67981.7 79603.2 81458.6 82264.0 83602.0 64134.7 68937.7 69182.0 70681.6 71672.3 63931.0 64931.0 65647.0 65762.3 66025.7 9887.0 10124.7 10125.9 10175.6 10182.2 46164.8 46358.8 46892.0 47157.5 47470.5 52494.2 52750.5 52832.7 52988.7 53296.2 12339.8 12378.2 12600.2 12664.6 12876.8 14639.8 14806.9 14815.8 14857.3 14957.6 12849.8 13592.0 13828.8 13838.1 14105.3 14997.9 16384.3 16538.7 16820.9 16947.1 15600.2 15781.8 15965.4 16561.8 17044.1 10399.5 10683.8 10763.3 10879.3 11041.6 13412.6 13434.3 13558.8 13664.9 13828.0 07:52:24 INFO - PROCESS | 28429 | -------- Summary: end -------- 07:52:24 INFO - PROCESS | 28429 | 07:52:25 INFO - TEST-INFO | 28429: exit 0 07:52:25 INFO - TEST-OK | dromaeo_css | took 1115306ms 07:52:25 INFO - TEST-START | kraken 07:52:25 INFO - operating with platform_type : linux_ 07:52:25 INFO - Initialising browser for kraken test... 07:52:25 INFO - TEST-INFO | started process 28788 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsQ5Xq/profile http://localhost:38302/getInfo.html) 07:52:29 INFO - PROCESS | 28788 | __metrics Screen width/height:1600/1200 07:52:29 INFO - PROCESS | 28788 | colorDepth:24 07:52:29 INFO - PROCESS | 28788 | Browser inner width/height: 1024/697 07:52:29 INFO - PROCESS | 28788 | __metrics 07:52:30 INFO - PROCESS | 28788 | 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" 07:52:30 INFO - PROCESS | 28788 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:52:31 INFO - PROCESS | 28788 | console.error: PushService: 07:52:31 INFO - PROCESS | 28788 | stateChangeProcessEnqueue: Error transitioning state 07:52:31 INFO - PROCESS | 28788 | UnknownError 07:52:31 INFO - TEST-INFO | 28788: exit 0 07:52:31 INFO - Browser initialized. 07:52:31 INFO - Running cycle 1/1 for kraken test... 07:52:31 INFO - TEST-INFO | started process 28881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsQ5Xq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:43 INFO - PROCESS | 28881 | RSS: Main: 140152832 07:52:43 INFO - PROCESS | 28881 | 07:52:46 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38302/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:46 INFO - PROCESS | 28881 | RSS: Main: 183160832 07:52:46 INFO - PROCESS | 28881 | 07:52:49 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38302/tests/kraken/driver.html?testName=audio-dft) 07:52:50 INFO - PROCESS | 28881 | RSS: Main: 174313472 07:52:50 INFO - PROCESS | 28881 | 07:52:52 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38302/tests/kraken/driver.html?testName=audio-fft) 07:52:53 INFO - PROCESS | 28881 | RSS: Main: 265601024 07:52:53 INFO - PROCESS | 28881 | 07:52:55 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38302/tests/kraken/driver.html?testName=audio-oscillator) 07:52:56 INFO - PROCESS | 28881 | RSS: Main: 171462656 07:52:56 INFO - PROCESS | 28881 | 07:52:58 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:58 INFO - PROCESS | 28881 | RSS: Main: 173998080 07:52:58 INFO - PROCESS | 28881 | 07:53:01 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38302/tests/kraken/driver.html?testName=imaging-darkroom) 07:53:02 INFO - PROCESS | 28881 | RSS: Main: 213553152 07:53:02 INFO - PROCESS | 28881 | 07:53:05 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38302/tests/kraken/driver.html?testName=imaging-desaturate) 07:53:06 INFO - PROCESS | 28881 | RSS: Main: 211939328 07:53:06 INFO - PROCESS | 28881 | 07:53:09 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38302/tests/kraken/driver.html?testName=json-parse-financial) 07:53:09 INFO - PROCESS | 28881 | RSS: Main: 210432000 07:53:09 INFO - PROCESS | 28881 | 07:53:11 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:53:11 INFO - PROCESS | 28881 | RSS: Main: 172802048 07:53:11 INFO - PROCESS | 28881 | 07:53:13 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:53:14 INFO - PROCESS | 28881 | RSS: Main: 179187712 07:53:14 INFO - PROCESS | 28881 | 07:53:16 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:53:16 INFO - PROCESS | 28881 | RSS: Main: 189825024 07:53:16 INFO - PROCESS | 28881 | 07:53:19 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:53:19 INFO - PROCESS | 28881 | RSS: Main: 197378048 07:53:19 INFO - PROCESS | 28881 | 07:53:22 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:53:23 INFO - PROCESS | 28881 | RSS: Main: 194072576 07:53:23 INFO - PROCESS | 28881 | 07:53:24 INFO - PROCESS | 28881 | Cycle 1(1): loaded http://localhost:38302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38302/tests/kraken/driver.html?testName=ai-astar) 07:53:25 INFO - PROCESS | 28881 | RSS: Main: 246095872 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | __start_tp_report 07:53:25 INFO - PROCESS | 28881 | _x_x_mozilla_page_load 07:53:25 INFO - PROCESS | 28881 | _x_x_mozilla_page_load_details 07:53:25 INFO - PROCESS | 28881 | |i|pagename|runs| 07:53:25 INFO - PROCESS | 28881 | |0;ai-astar;111;112;114;114;113;113;113;113;113;114 07:53:25 INFO - PROCESS | 28881 | |1;audio-beat-detection;141;115;114;157;117;120;115;117;137;114 07:53:25 INFO - PROCESS | 28881 | |2;audio-dft;160;160;161;159;161;161;162;160;160;161 07:53:25 INFO - PROCESS | 28881 | |3;audio-fft;75;75;76;109;75;75;77;77;94;75 07:53:25 INFO - PROCESS | 28881 | |4;audio-oscillator;83;82;106;82;82;81;103;83;83;107 07:53:25 INFO - PROCESS | 28881 | |5;imaging-gaussian-blur;113;114;113;112;113;113;113;113;114;113 07:53:25 INFO - PROCESS | 28881 | |6;imaging-darkroom;146;146;146;146;146;146;147;147;146;146 07:53:25 INFO - PROCESS | 28881 | |7;imaging-desaturate;94;94;94;94;95;93;94;94;94;94 07:53:25 INFO - PROCESS | 28881 | |8;json-parse-financial;55;53;53;56;53;54;54;54;55;54 07:53:25 INFO - PROCESS | 28881 | |9;json-stringify-tinderbox;55;55;54;55;54;55;54;54;54;54 07:53:25 INFO - PROCESS | 28881 | |10;stanford-crypto-aes;80;80;86;77;79;76;85;75;74;78 07:53:25 INFO - PROCESS | 28881 | |11;stanford-crypto-ccm;126;127;126;121;120;120;119;120;164;124 07:53:25 INFO - PROCESS | 28881 | |12;stanford-crypto-pbkdf2;158;157;155;157;161;180;162;156;160;161 07:53:25 INFO - PROCESS | 28881 | |13;stanford-crypto-sha256-iterative;60;60;59;60;61;59;61;62;60;58 07:53:25 INFO - PROCESS | 28881 | __end_tp_report 07:53:25 INFO - PROCESS | 28881 | __start_cc_report 07:53:25 INFO - PROCESS | 28881 | _x_x_mozilla_cycle_collect,1663 07:53:25 INFO - PROCESS | 28881 | __end_cc_report 07:53:25 INFO - PROCESS | 28881 | __startTimestamp1492527205107__endTimestamp 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | ------- Summary: start ------- 07:53:25 INFO - PROCESS | 28881 | Number of tests: 14 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:0.94 (0.8%) stddev-sans-first:0.67 07:53:25 INFO - PROCESS | 28881 | Values: 111.0 112.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 114.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#1] audio-beat-detection Cycles:10 Average:124.70 Median:118.50 stddev:14.97 (12.6%) stddev-sans-first:14.68 07:53:25 INFO - PROCESS | 28881 | Values: 141.0 115.0 114.0 157.0 117.0 120.0 115.0 117.0 137.0 114.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 07:53:25 INFO - PROCESS | 28881 | Values: 160.0 160.0 161.0 159.0 161.0 161.0 162.0 160.0 160.0 161.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:11.50 (15.2%) stddev-sans-first:12.00 07:53:25 INFO - PROCESS | 28881 | Values: 75.0 75.0 76.0 109.0 75.0 75.0 77.0 77.0 94.0 75.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:82.00 stddev:11.19 (13.7%) stddev-sans-first:11.65 07:53:25 INFO - PROCESS | 28881 | Values: 83.0 82.0 106.0 82.0 82.0 81.0 103.0 83.0 83.0 107.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:53:25 INFO - PROCESS | 28881 | Values: 113.0 114.0 113.0 112.0 113.0 113.0 113.0 113.0 114.0 113.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 07:53:25 INFO - PROCESS | 28881 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:53:25 INFO - PROCESS | 28881 | Values: 94.0 94.0 94.0 94.0 95.0 93.0 94.0 94.0 94.0 94.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.00 07:53:25 INFO - PROCESS | 28881 | Values: 55.0 53.0 53.0 56.0 53.0 54.0 54.0 54.0 55.0 54.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 07:53:25 INFO - PROCESS | 28881 | Values: 55.0 55.0 54.0 55.0 54.0 55.0 54.0 54.0 54.0 54.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:79.50 stddev:3.97 (5.0%) stddev-sans-first:4.20 07:53:25 INFO - PROCESS | 28881 | Values: 80.0 80.0 86.0 77.0 79.0 76.0 85.0 75.0 74.0 78.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:125.00 stddev:13.44 (10.8%) stddev-sans-first:14.25 07:53:25 INFO - PROCESS | 28881 | Values: 126.0 127.0 126.0 121.0 120.0 120.0 119.0 120.0 164.0 124.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.50 stddev:7.18 (4.5%) stddev-sans-first:7.55 07:53:25 INFO - PROCESS | 28881 | Values: 158.0 157.0 155.0 157.0 161.0 180.0 162.0 156.0 160.0 161.0 07:53:25 INFO - PROCESS | 28881 | 07:53:25 INFO - PROCESS | 28881 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.00 Median:60.00 stddev:1.15 (1.9%) stddev-sans-first:1.22 07:53:25 INFO - PROCESS | 28881 | Values: 60.0 60.0 59.0 60.0 61.0 59.0 61.0 62.0 60.0 58.0 07:53:25 INFO - PROCESS | 28881 | -------- Summary: end -------- 07:53:25 INFO - PROCESS | 28881 | 07:53:26 INFO - TEST-INFO | 28881: exit 0 07:53:26 INFO - TEST-OK | kraken | took 60745ms 07:53:26 INFO - SUITE-END | took 1176s 07:53:26 INFO - Completed test suite (00:19:36) 07:53:26 INFO - javascript benchmark 07:53:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7899.341116863024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3431.5538979932603, 3447.362237985972, 3457.550518432605, 3477.304539092182, 3513.718902487801, 5823.912641310384, 5889.381614930435, 5910.202122713443, 5912.497437717789, 5919.171316015756, 5849.79525716599, 5882.14708867214, 5891.381404952483, 5900.734466948987, 5903.321118071423, 5209.036328279271, 5228.79084836606, 5248.475152484759, 5291.444398338177, 5307.601929855257, 5140.280360749498, 5160.974195129019, 5318.494742999409, 5325.946740532603, 5328.706921119337, 5219.42586315505, 5251.684898906059, 5315.202719592054, 5322.520973112419, 5333.386660534049, 5345.0, 5352.357717073937, 5354.384245811742, 5356.571474282048, 5356.785728570872, 5101.464346243628, 5129.256257842592, 5191.818286359997, 5266.0257852297445, 5350.117230656937, 5719.056355701305, 5737.598368114233, 5773.740181691792, 5799.5650326225705, 5804.100364443518, 6202.255729312466, 6233.252009758858, 6267.185265915447, 6276.96861515694, 6289.968550157266, 6131.051857025259, 6315.0, 6336.46140078094, 6337.524685648595, 6352.428281454645, 5768.798092066758, 5769.798057067983, 5794.21778059965, 5801.8549536261935, 5849.0, 6339.11252424661, 6368.235811702625, 6370.108184854124, 6376.649284289409, 6377.71300291488, 6031.24609423822, 6083.969580152071, 6133.233345831771, 6144.446999770043, 6149.477294430024, 6184.0, 6187.535934804908, 6199.411055949678, 6228.22147231596, 6233.719482623293, 6225.8132256032395, 6279.120923070774, 6290.496760259169, 6292.2134733158355, 6294.339094395114, 6106.114613381035, 6110.953680641517, 6112.868254062989, 6186.350433204539, 6277.2153480814895, 4784.40194975628, 4789.3294938708605, 4800.3279540864305, 4808.927866082012, 4810.470848206694, 4247.193033323659, 4254.7021708480725, 4259.169461954889, 4281.2293787118, 4281.657467402601, 5750.396208398141, 5791.015527360359, 6087.117367981707, 6087.908681369783, 6090.756369745161, 6194.194754681863, 6220.875582488325, 6293.150424692608, 6302.338254483305, 6323.272823625342, 6034.788782392683, 6048.455638992512, 6050.667213303311, 6061.54538409621, 6063.265825183641, 5327.121025030827, 5328.893422131536, 5329.760160792774, 5337.519623233928, 5339.119045357473, 6318.526110541728, 6326.936730632727, 6417.358264173546, 6425.421712045938, 6466.288708242089, 6335.334789847184, 6336.556441049082, 6341.8731625368155, 6356.0, 6357.809265722036, 6545.803625891231, 6582.703778329891, 6597.901031484435, 6598.0, 6598.703058362289, 6037.184980027816, 6056.3035250946705, 6062.120992455981, 6153.600015998945, 6213.347598502092, 6196.504279657526, 6224.657643829632, 6232.501399887908, 6237.220347456568, 6240.875182496234, 6063.0, 6072.271327440735, 6074.863969600762, 6075.0, 6125.693715314305, 5910.438508341701, 5939.554533410098, 6035.637861728311, 6049.153118563317, 6092.817215483543, 6060.545459090674, 6069.241344831896, 6133.723982420713, 6146.385361463817, 6163.476104531165, 6137.864495068427, 6138.202033735586, 6148.4773794227995, 6150.323464419, 6156.29202641702, 5824.854378640568, 5871.823845284648, 5882.205902203148, 5894.793682221101, 5941.554383421174], "value": 5756.252965269708, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.6819367671899, 802.514478740362, 822.7490615362316, 854.3336197765744, 865.9956700216502, 31535.21161970952, 43936.78031609841, 44918.55081449184, 45029.09941801162, 45149.0, 44758.32862507065, 44948.3257751134, 44997.32504012442, 45007.549924500745, 45093.0, 7660.119086305091, 7850.842983140334, 9157.542122893861, 9320.114589114024, 9330.0, 10757.30077544961, 10950.34297942126, 11337.206395552315, 11344.829827552594, 11350.71623209418, 11102.888971110307, 11119.777604447907, 11139.72150696235, 11140.777184456307, 11148.0, 11002.834957475645, 11049.392283424408, 11072.612458563912, 11083.667489975314, 11093.223474356799, 10613.097886679641, 10641.361518308926, 10704.678859634223, 10707.036366727032, 10707.411092389915, 40886.1822763546, 40985.0, 41024.58975410237, 41100.58899411027, 41103.794481027704, 4166.91666166678, 4183.602557757008, 4219.43037689911, 4234.745915245096, 4316.266234740102, 30243.697563024307, 30323.696763032527, 30528.54207186894, 30577.235569110726, 31918.680813192037, 4252.0, 4455.487618923833, 4461.08547747711, 4478.328250762412, 4512.368268442421, 237117.0, 238630.99999999825, 239484.0, 240107.0, 240806.0, 46841.0, 47111.05777884423, 47136.29295560569, 47151.29273060907, 47204.0, 48514.75742621264, 48712.0, 48736.0, 48749.512504874496, 48759.26861097087, 15673.921630392004, 15858.048517089012, 15890.920545397199, 15893.920530397274, 15897.841021589868, 12265.141440099107, 12560.434780434902, 13712.588622341145, 13872.861271387157, 13874.098183618033, 11813.350265735295, 12468.937655311847, 12857.292848893214, 13195.934020330029, 13268.53560125391, 5266.657667251617, 5309.761060752276, 5330.067238233293, 5377.085895397791, 5394.433584473652, 989.9158571521501, 990.8563258327646, 1000.9099181073739, 1002.6340385759146, 1007.9496025198711, 28576.285592859927, 28747.28131796722, 28828.279293017422, 28992.855035724686, 29417.411651766844, 1062.5059347403494, 1079.390144568332, 1089.6022951622601, 1105.635140403681, 1112.4159816096615, 14933.775993360108, 15123.773143402857, 15259.160746158846, 15472.381104755683, 15497.690046199014, 341244.0, 345034.0, 345658.0, 345700.0, 346159.0, 56820.14769778457, 57092.143617845766, 57155.42844571584, 57337.426625733206, 57641.711791441616, 1489.2330449818353, 1491.135141617859, 1511.8790496760232, 1517.8861585381142, 1530.5714399968026, 26552.468950620492, 27727.168184954484, 27810.86094569514, 28213.294667632654, 28281.0, 42222.366664499445, 42311.0, 42337.57662423459, 42356.788216058725, 42503.99999999876, 293879.0, 294538.0, 294669.0, 295554.0, 296125.0, 32018.51972220372, 32455.350892982482, 32536.51195232026, 32681.673183268813, 32824.83587582047, 43490.78254608833, 44045.0, 44508.0, 44998.55001449944, 45394.773026135976, 33540.49689254712, 33700.325993479506, 33727.3254534903, 33742.0, 33839.15402114967, 33219.66780332166, 33285.66714332825, 33621.327573448885, 33882.32235355328, 34626.82686586652, 38364.232715346094, 39003.07476939184, 39226.2154756909, 39263.84048877225, 39569.60430395659, 32017.0, 32311.0, 32345.191370215933, 32355.0, 32455.026349209562, 25227.0, 25930.481390372464, 25939.481210376063, 26067.869660652334, 26762.732372676805], "value": 18940.90790779306, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.38108218754064, 463.4762718128515, 466.7876116367053, 471.17073949848276, 484.95635392814637, 19927.800721992775, 19943.60112797745, 20169.798302016974, 21299.25452609159, 21699.457513562167, 21068.473288167766, 21187.36437906865, 21595.1361945522, 22033.669494957547, 22065.889670551624, 6489.253735820382, 6493.545451818374, 6670.93329066708, 6675.299093595176, 6727.730890764364, 4184.288670925935, 4371.34429835524, 6747.08914296571, 6818.965905170492, 6866.725330986755, 7392.33468987791, 7646.311831935125, 7681.846363072763, 7683.961580192091, 7684.807879802994, 7464.514806537585, 7636.083669959585, 7663.846723065563, 7671.578063206522, 7708.180323855481, 7371.447141464411, 7455.0, 7463.216362281936, 7570.621468926587, 7632.236776322379, 20607.381778546667, 20650.58698826015, 24640.630390544156, 25287.0, 25989.22032339014, 3589.5154154189113, 3598.1004748812798, 3643.8178091095338, 3696.5194524711615, 3712.925741485155, 15905.443309484113, 16504.504864854072, 16651.41720039805, 16849.41027064047, 17216.139193040297, 2300.4478925058033, 2351.9412014699597, 2374.691290132289, 2406.542756876205, 2417.10567090176, 111063.0, 111165.44417277943, 111851.0, 112147.0, 112371.0, 14117.64705882345, 16299.429519966745, 17807.910960445115, 18173.63652726938, 18725.90637046806, 31750.364992700015, 31803.363932721215, 31840.68159318377, 32145.51781723276, 32337.838310808766, 10594.735131621772, 10688.25182237236, 10710.089642380484, 10811.0, 10942.562297508011, 8954.552272386354, 9004.59479323432, 9012.774680632905, 9172.724818255463, 9191.0, 9020.774480638036, 9120.26392082386, 9232.0, 9338.439693618404, 9560.904390956, 3583.982080089635, 3709.703223742094, 3847.711421643388, 3972.0139930034984, 3976.4830572025453, 954.6324665004023, 968.0899954043317, 969.6606187834202, 978.814025335184, 989.4162444157981, 19823.405297841087, 21067.0, 21155.8942205288, 21179.576408471745, 21352.466188345104, 976.7167521418709, 983.7442265011006, 987.9160271377013, 991.548845275398, 993.3245393132739, 11171.050460710769, 11529.308241505536, 11556.248843825124, 11725.589604363977, 11732.824007639892, 608411.0, 616874.0, 618688.0, 638294.0, 667472.0, 88533.0, 104946.47526762317, 117579.0, 118643.40678296554, 122169.0, 1270.1997741423029, 1287.575100216926, 1315.7368526294779, 1316.3220941215282, 1319.274399080521, 13857.861421385656, 17765.911170444066, 18162.09189540544, 18826.24695012184, 19310.227590896768, 53612.73193634007, 53901.0, 54379.72810135924, 54692.0, 55252.171217430965, 68924.0, 69084.0, 69118.0, 69611.0, 69847.0, 12455.252684838939, 12710.682232944251, 12812.679683007627, 12861.742765144458, 13016.219026858418, 13796.793048104086, 13970.0, 14266.714665706835, 14608.612181842707, 14708.632284192981, 12228.571999979958, 12466.501339946662, 12904.741905162033, 13020.0, 13115.540956066492, 11720.70698232551, 11932.522699091938, 12069.637910862688, 12201.0, 12249.755004899675, 12624.17942833713, 12669.80995285053, 12720.363981800689, 12812.55156069533, 13037.022223333099, 11628.94185529067, 12093.879061209627, 12528.0, 12681.4293356801, 12974.870251297367, 12016.158868879094, 12679.93660031694, 12842.614721558368, 12866.228026318451, 12932.741345173232], "value": 11566.932959006957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.9699806003873, 1519.7796319533668, 1548.922553872306, 1561.5315405378387, 1571.2536545141058, 10944.726381840457, 11699.941500292487, 11725.0, 11732.765344693102, 11739.882601173986, 11287.830682539749, 11661.533538658465, 11977.820332695017, 11983.340916249603, 11983.340916249603, 2565.7434256574334, 2606.9348266293305, 2607.1526753804997, 2608.0610980047168, 2610.3474131467133, 2483.8137139714504, 2592.0927675313583, 2606.9869650651817, 2610.2430295214367, 2611.5299246135687, 2411.4694767151286, 2503.161440917295, 2504.0484615846044, 2505.549001179787, 2522.571162902311, 2390.725066617344, 2439.195065628347, 2450.803935685141, 2473.51766405551, 2474.9752502474926, 2394.5330660521204, 2418.685570875775, 2435.0625009371342, 2436.049940523197, 2436.9268921932194, 10825.13398928084, 10844.240903136784, 10857.294275872044, 10876.836847447295, 10885.83671244932, 6045.758169673208, 6163.01391777318, 6237.750489980395, 6244.094606282064, 6245.500359971192, 3691.169486865461, 3740.7194460415576, 3771.396576547739, 3818.1600047989677, 3831.961680383188, 1321.5969129415525, 1385.4319728911098, 1416.9291535423188, 2181.4110190248703, 2278.9658155127686, 14837.7774333384, 15286.464973725866, 15901.0, 17963.461096167135, 18160.455186344432, 4949.876253093701, 4972.378452693413, 4974.32846565709, 5119.820806271762, 5124.769385377667, 12726.600073991853, 12729.872701272869, 12730.045246606542, 12753.426095825711, 12755.170913890568, 6056.606320589148, 6056.606320589148, 6056.697165141725, 6057.061155520902, 6059.030555111161, 5595.18869763882, 5656.6888821115235, 5729.942700572941, 5741.253637027244, 5758.798442054508, 4360.236958532244, 4402.84590039347, 4494.213512635276, 4502.954970450319, 4513.142502924434, 1189.8453201083803, 1224.1561496899565, 1228.0298564134412, 1241.596481143632, 1242.6272118364636, 1014.9695509134738, 1040.69819752271, 1046.7801761630144, 1050.9421981791074, 1055.2454994678842, 7043.260457651975, 7085.787426377217, 7157.964210178916, 7172.784816455514, 7291.4531410144455, 987.3532835992437, 1019.3985548526405, 1027.8201314769885, 1091.6724982505216, 1099.7030801683661, 4454.799534020977, 4686.95313046872, 4747.620190384761, 4811.879703007383, 4993.800247990112, 14485.130892146504, 15045.473408430653, 15193.772093418607, 15199.848001520064, 15430.691386172213, 14703.264836758333, 14751.262436878113, 14979.850201497846, 15055.171965541782, 15251.084934903942, 8940.418872773249, 10942.617008404668, 11155.665330040112, 11157.944210278896, 11168.66494005181, 6563.573367731082, 7476.887846682413, 7511.098668159856, 7547.0943486781935, 7562.773116806505, 12558.87441125577, 12815.423305951068, 12959.676008099874, 13199.0, 13295.135816171918, 13093.607191784262, 13109.672258193621, 13339.866601333862, 13390.732185356044, 13483.73032539324, 9233.122853328923, 9302.302327325342, 9368.203702685076, 9379.624815007322, 9444.95277523608, 10789.838152427878, 10790.0, 10866.78266434651, 10879.45602719845, 10973.177011724312, 8808.867866981873, 8884.644614215358, 8934.687285944961, 9071.954640226757, 9072.092790720875, 8565.143485651633, 8748.256398206224, 8803.251723603566, 8865.157810008039, 8983.416077954913, 8227.177282271965, 8344.165583441607, 8431.95784021076, 8471.152884711479, 8515.701950431705, 6277.0, 6334.081558174131, 6382.505009524391, 6385.744570217325, 6487.286398496256, 6584.0, 6601.240857301472, 6719.697613607302, 6738.764143254963, 6796.898046529207], "value": 5537.854601461802, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.96791613722996, 422.36223302812743, 426.46904603768314, 433.19425867885747, 433.8676703605401, 5346.224797404374, 5348.144296912495, 5351.769093108583, 5353.260190438109, 5354.95578362219, 4974.228994505857, 5120.411152717438, 5148.279240906276, 5209.817656382027, 5216.930529241506, 4230.259704551707, 4305.4833419989645, 4336.349547567875, 4348.760818155, 4354.695171338008, 4343.478782546099, 4343.739375637456, 4344.695871289011, 4352.912941741163, 4353.064091220387, 4281.18049828823, 4325.653947684178, 4353.542877997812, 4381.780910954455, 4385.10105428388, 4135.29699951006, 4308.116836048634, 4337.457817772778, 4373.475182978063, 4384.89037774055, 4051.7917734834587, 4062.4921884764403, 4065.9796701016603, 4070.837166513336, 4089.7137200395982, 5056.84829455117, 5071.923921141186, 5074.955026983817, 5075.096838685493, 5090.516400941941, 4865.44047434546, 4977.552020318189, 5013.724245166514, 5036.370453693288, 5128.410232823198, 5403.810866619689, 5408.432114627947, 5408.486193811582, 5430.75561599725, 5432.375276843174, 4514.45826500822, 4546.386237857913, 4552.248878934972, 4620.399348084761, 4631.791569379386, 5429.945700542983, 5614.466625670514, 5672.858178545569, 5708.915306091829, 5729.312482502085, 4632.328312394684, 4640.097560000384, 4661.044485880387, 4681.578657920803, 4687.226607609774, 4722.858314250578, 4728.456227533878, 4737.786799594027, 4779.211430114062, 4792.568668819823, 4885.389326334208, 4964.8758781030765, 5042.672226305279, 5107.565856902131, 5107.923381149286, 5342.2787923630585, 5394.973025134849, 5408.242846001563, 5415.0, 5434.510894019557, 1644.3011720018944, 1658.4361317152227, 1663.3014134063721, 1664.6920319740886, 1664.9583760406088, 1266.0, 1273.6433798536425, 1294.3269499860207, 1297.7145028093805, 1300.4524615707467, 5311.787528498817, 5315.627906046617, 5349.251104845324, 5384.273123128328, 5448.291722076105, 5576.219329293902, 5639.43605639441, 5658.81164955364, 5674.2339784129435, 5683.38023663254, 5233.267342572043, 5397.487238712316, 5417.864553386118, 5441.211024401518, 5478.945210547923, 2977.940441191164, 2984.164433958495, 2987.2830520674884, 2992.610960575155, 2995.7303842654264, 5502.5597952163735, 5845.210896528914, 5856.648601083949, 5862.446451690305, 5868.383819698955, 5384.246205531229, 5619.381867994517, 5779.508741756914, 5779.508741756998, 5779.88440231193, 5651.26533550644, 5658.462446067617, 5760.913586296209, 5814.505767009851, 5825.737841797045, 5581.5255703265675, 5592.161175823659, 5611.410801865745, 5612.663240205601, 5632.802851900164, 5039.798408063783, 5267.7884086659515, 5291.656042357235, 5506.256655351636, 5594.916076258778, 5757.424257574209, 5766.365699772938, 5785.6817875015595, 5804.693943862597, 5822.301323841166, 4567.109413664303, 4597.885052873705, 4600.0, 4628.9537104628525, 4677.0, 5565.5825813063375, 5568.415316391721, 5641.633293835887, 5665.5750818689585, 5725.370209276893, 5445.918311225414, 5452.318460192476, 5464.371597266365, 5537.0, 5552.333719953632, 5222.991052660172, 5492.642978206404, 5509.0, 5510.669359838423, 5516.613837031369, 5413.242146099628, 5422.213779002102, 5449.509544141047, 5480.808171713971, 5534.086875665631, 5393.8112166074, 5483.369412517612, 5494.670319780826, 5502.642328248651, 5506.394296627448, 5045.208950822405, 5283.418823929288, 5332.813351532678, 5407.675539467645, 5423.457654234545], "value": 4402.557334291032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.8244351129775, 885.4687187687389, 922.4511415707656, 925.0537879614116, 938.6057855700606, 17256.482305530837, 17280.567985800346, 17882.37411690591, 18536.81463185368, 18768.71846922294, 16446.67106657866, 16848.83151168488, 17045.914770426163, 17062.488125356227, 17313.220905059272, 874.6632546469607, 883.5228976352794, 896.6547879066541, 900.9054049324825, 906.9591868365907, 894.449913303317, 895.1496078725237, 896.4038914122101, 896.4173287363201, 896.7444278380663, 960.7502049467154, 960.8270511307961, 962.3552220012573, 962.562034274407, 963.1572374172599, 949.7768024514234, 952.4095061062117, 952.7475219066918, 953.2040745977083, 954.0173621170136, 700.4116542104606, 701.386286998876, 701.4003027411541, 701.6667083135521, 702.2029995954578, 17521.123943802886, 17580.208890599955, 17708.822911770847, 18929.148188331557, 19186.520336991547, 16063.91968040164, 16320.999999999882, 16515.58711032234, 16669.24988375526, 16910.74633880493, 13497.662558436019, 13612.863871361358, 13765.0, 14184.361703723254, 14226.644333891632, 3991.960080399188, 4082.897927551835, 4107.301758701028, 4135.359019352005, 4226.809793559267, 90123.0, 90303.0, 90429.0, 92192.53903730438, 94261.0, 12338.259704417764, 12375.133740638248, 12404.131710780159, 12424.813627795591, 12488.50045998168, 24547.0, 24560.0, 24565.263042108767, 24634.0, 24683.382915427257, 8233.300169485541, 8387.287080598095, 8391.874121888177, 8405.537695426689, 8545.786355341043, 4582.221022426195, 4658.580727734452, 4659.394278743742, 4709.764511774466, 4772.880677983078, 3797.6392242736897, 3902.35611124167, 3911.8630847920754, 3920.1179734560064, 3920.294347017564, 637.1175921348872, 643.8454770854961, 651.212033439534, 651.6546230497844, 653.2259272761697, 644.7388807532957, 670.5473805181581, 674.3593586093133, 680.9250982391933, 686.8557602903346, 11255.43722813856, 11618.76762464746, 11661.6501504955, 11862.7934675897, 12142.757144857052, 849.7408290471342, 859.8366310401004, 862.1335557764406, 866.6923242249037, 872.0843114729508, 5157.948420515821, 5180.922286165711, 5181.689098654093, 5238.292830467914, 5245.842624721265, 67981.66009169923, 79603.20396795958, 81458.59270703609, 82264.0, 83602.0, 64134.679326603065, 68937.65531172312, 69182.0, 70681.64659176671, 71672.28327716656, 63931.0, 64931.0, 65647.0, 65762.34237657562, 66025.66987165129, 9886.950565247127, 10124.69625911224, 10125.949370253102, 10175.643852465128, 10182.236332275257, 46164.7691761539, 46358.7682061601, 46892.0, 47157.528424716686, 47470.52529474661, 52494.21258681046, 52750.47249527455, 52832.73583632057, 52988.73505632447, 53296.20055699245, 12339.814902776645, 12378.195417297848, 12600.243985360908, 12664.556740514037, 12876.806847897476, 14639.780403294171, 14806.851931480547, 14815.777763333774, 14857.331420086339, 14957.626059348604, 12849.807252891027, 13592.0, 13828.792568111687, 13838.100523465942, 14105.294735263402, 14997.850021500082, 16384.26270817792, 16538.669226615642, 16820.915895420934, 16947.067911265, 15600.219989000278, 15781.763273551136, 15965.44120955761, 16561.751573726164, 17044.14779261057, 10399.48002599882, 10683.786324273626, 10763.300385474919, 10879.347239165676, 11041.558337666404, 13412.597622071353, 13434.328283585977, 13558.796618050934, 13664.863351366359, 13828.0], "value": 7901.356981406769, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 114.0, 157.0, 117.0, 120.0, 115.0, 117.0, 137.0, 114.0], "value": 124.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 161.0, 161.0, 162.0, 160.0, 160.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 75.0, 75.0, 77.0, 77.0, 94.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 106.0, 82.0, 82.0, 81.0, 103.0, 83.0, 83.0, 107.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 112.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 53.0, 56.0, 53.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 86.0, 77.0, 79.0, 76.0, 85.0, 75.0, 74.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 126.0, 121.0, 120.0, 120.0, 119.0, 120.0, 164.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 155.0, 157.0, 161.0, 180.0, 162.0, 156.0, 160.0, 161.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 61.0, 59.0, 61.0, 62.0, 60.0, 58.0], "value": 60.0, "unit": "score"}]}]} 07:53:26 INFO - Return code: 0 07:53:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:53:26 ERROR - # TBPL SUCCESS # 07:53:26 INFO - Running post-action listener: _resource_record_post_action 07:53:26 INFO - [mozharness: 2017-04-18 14:53:26.452643Z] Finished run-tests step (success) 07:53:26 INFO - Running post-run listener: _resource_record_post_run 07:53:26 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 2236416; Write bytes: 364269568; Read time: 1080; Write time: 285936 07:53:26 INFO - TinderboxPrint: CPU usage
13.2% 07:53:26 INFO - TinderboxPrint: I/O read bytes / time
2,236,416 / 1,080 07:53:26 INFO - TinderboxPrint: I/O write bytes / time
364,269,568 / 285,936 07:53:26 INFO - TinderboxPrint: CPU idle
8,268.1 (86.8%) 07:53:26 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 07:53:26 INFO - TinderboxPrint: Swap in / out
0 / 0 07:53:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110125056; Read time: 0; Write time: 94408 07:53:26 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 2236416; Write bytes: 253050880; Read time: 1080; Write time: 191476 07:53:27 INFO - Running post-run listener: _upload_blobber_files 07:53:27 INFO - Blob upload gear active. 07:53:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:53:27 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 07:53:27 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'] 07:53:27 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 07:53:27 INFO - (blobuploader) - INFO - Open directory for files ... 07:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:28 INFO - (blobuploader) - INFO - Done attempting. 07:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:29 INFO - (blobuploader) - INFO - Done attempting. 07:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:32 INFO - (blobuploader) - INFO - Done attempting. 07:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:33 INFO - (blobuploader) - INFO - Done attempting. 07:53:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:33 INFO - Return code: 0 07:53:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c519c13b875ed878d7b4ad8f345de0219a3a2450e9f3e3814343bdc14e4b1e0034a95a9a398c1a83fbc53fba97f76c75aab78cd865e1cf0b95945c4327332690", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/443f907a22ca89fd334e59caa3ffbf046980b60ad55a5837e144914d410bc3e4c4adc4dec5bf998b976f809891fccfd65fe51b14d46aec5d175c9e091d6753f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3bf59011799925281d068b288691ee4dcf36bbc32ea367963c2cd70caa74299970b84c892bbb7caebbeae6c3fac86561dbc7a02fdb03efa41f8f82226337f474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5bb1e98074a0c11a28d8a2ec3b1f9bafeca6609f7fa4a7218bccea3ba481f1fad26310bcdf5e2b957de3297da29122385386570ec944c261443916f49bf8f3d5"} 07:53:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:33 INFO - Contents: 07:53:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c519c13b875ed878d7b4ad8f345de0219a3a2450e9f3e3814343bdc14e4b1e0034a95a9a398c1a83fbc53fba97f76c75aab78cd865e1cf0b95945c4327332690", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/443f907a22ca89fd334e59caa3ffbf046980b60ad55a5837e144914d410bc3e4c4adc4dec5bf998b976f809891fccfd65fe51b14d46aec5d175c9e091d6753f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3bf59011799925281d068b288691ee4dcf36bbc32ea367963c2cd70caa74299970b84c892bbb7caebbeae6c3fac86561dbc7a02fdb03efa41f8f82226337f474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5bb1e98074a0c11a28d8a2ec3b1f9bafeca6609f7fa4a7218bccea3ba481f1fad26310bcdf5e2b957de3297da29122385386570ec944c261443916f49bf8f3d5"} 07:53:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:33 INFO - Copying logs to upload dir... 07:53:33 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.538210 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-18 07:53:32.404472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 07:53:32.407798) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c519c13b875ed878d7b4ad8f345de0219a3a2450e9f3e3814343bdc14e4b1e0034a95a9a398c1a83fbc53fba97f76c75aab78cd865e1cf0b95945c4327332690", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/443f907a22ca89fd334e59caa3ffbf046980b60ad55a5837e144914d410bc3e4c4adc4dec5bf998b976f809891fccfd65fe51b14d46aec5d175c9e091d6753f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3bf59011799925281d068b288691ee4dcf36bbc32ea367963c2cd70caa74299970b84c892bbb7caebbeae6c3fac86561dbc7a02fdb03efa41f8f82226337f474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5bb1e98074a0c11a28d8a2ec3b1f9bafeca6609f7fa4a7218bccea3ba481f1fad26310bcdf5e2b957de3297da29122385386570ec944c261443916f49bf8f3d5"} build_url:https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/ZVCbm0xfTEGg2SKhag-RSQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c519c13b875ed878d7b4ad8f345de0219a3a2450e9f3e3814343bdc14e4b1e0034a95a9a398c1a83fbc53fba97f76c75aab78cd865e1cf0b95945c4327332690", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/443f907a22ca89fd334e59caa3ffbf046980b60ad55a5837e144914d410bc3e4c4adc4dec5bf998b976f809891fccfd65fe51b14d46aec5d175c9e091d6753f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3bf59011799925281d068b288691ee4dcf36bbc32ea367963c2cd70caa74299970b84c892bbb7caebbeae6c3fac86561dbc7a02fdb03efa41f8f82226337f474", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5bb1e98074a0c11a28d8a2ec3b1f9bafeca6609f7fa4a7218bccea3ba481f1fad26310bcdf5e2b957de3297da29122385386570ec944c261443916f49bf8f3d5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-18 07:53:32.433495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:53:32.433811) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1492525958.272057-1385824664 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-18 07:53:32.517186) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 07:53:32.517553) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-18 07:53:32.517865) ========= ========= Total master_lag: 0.16 =========