builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-044 starttime: 1491494228.66 results: success (0) revision: 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.655728) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.656183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.656467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.670974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.671254) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-06 08:57:09-- 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% 223M=0s 2017-04-06 08:57:09 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092856 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.868728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.869051) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019507 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:08.901036) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 08:57:08.901362) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e --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 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e --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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-06 08:57:09,462 truncating revision to first 12 chars 2017-04-06 08:57:09,462 Setting DEBUG logging. 2017-04-06 08:57:09,462 attempt 1/10 2017-04-06 08:57:09,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5a1c52f42dd5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 08:57:10,481 unpacking tar archive at: mozilla-aurora-5a1c52f42dd5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.408436 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 08:57:10.323113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:10.323444) ========= script_repo_revision: 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:10.323848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:10.324120) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 08:57:10.333789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-06 08:57:10.334061) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:57:10 INFO - MultiFileLogger online at 20170406 08:57:10 in /builds/slave/test 08:57:10 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 08:57:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:57:10 INFO - {'append_to_log': False, 08:57:10 INFO - 'base_work_dir': '/builds/slave/test', 08:57:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 08:57:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:57:10 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 08:57:10 INFO - 'buildbot_json_path': 'buildprops.json', 08:57:10 INFO - 'config_files': ('talos/linux_config.py',), 08:57:10 INFO - 'default_actions': ('clobber', 08:57:10 INFO - 'read-buildbot-config', 08:57:10 INFO - 'download-and-extract', 08:57:10 INFO - 'populate-webroot', 08:57:10 INFO - 'create-virtualenv', 08:57:10 INFO - 'install', 08:57:10 INFO - 'run-tests'), 08:57:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:57:10 INFO - 'download_minidump_stackwalk': True, 08:57:10 INFO - 'download_symbols': 'ondemand', 08:57:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:57:10 INFO - 'tooltool.py': '/tools/tooltool.py', 08:57:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:57:10 INFO - '/tools/misc-python/virtualenv.py')}, 08:57:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:57:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:57:10 INFO - 'gecko_profile': False, 08:57:10 INFO - 'gecko_profile_interval': 0, 08:57:10 INFO - 'installer_path': 'installer.exe', 08:57:10 INFO - 'log_level': 'info', 08:57:10 INFO - 'log_name': 'talos', 08:57:10 INFO - 'log_to_console': True, 08:57:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:57:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:57:10 INFO - 'opt_config_files': (), 08:57:10 INFO - 'pip_index': False, 08:57:10 INFO - 'suite': 'dromaeojs', 08:57:10 INFO - 'system_bits': '32', 08:57:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:57:10 INFO - 'title': 'talos-linux64-ix-044', 08:57:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:57:10 INFO - 'use_talos_json': True, 08:57:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:57:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:57:10 INFO - 'work_dir': 'build'} 08:57:10 INFO - [mozharness: 2017-04-06 15:57:10.992777Z] Running clobber step. 08:57:10 INFO - Running pre-action listener: _resource_record_pre_action 08:57:10 INFO - Running main action method: clobber 08:57:10 INFO - rmtree: /builds/slave/test/build 08:57:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:57:11 INFO - Running post-action listener: _resource_record_post_action 08:57:11 INFO - [mozharness: 2017-04-06 15:57:11.931563Z] Finished clobber step (success) 08:57:11 INFO - [mozharness: 2017-04-06 15:57:11.931663Z] Running read-buildbot-config step. 08:57:11 INFO - Running pre-action listener: _resource_record_pre_action 08:57:11 INFO - Running main action method: read_buildbot_config 08:57:11 INFO - Using buildbot properties: 08:57:11 INFO - { 08:57:11 INFO - "project": "", 08:57:11 INFO - "product": "firefox", 08:57:11 INFO - "who": "ffxbld@noreply.mozilla.org", 08:57:11 INFO - "installer_path": "public/build/target.tar.bz2", 08:57:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:57:11 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 08:57:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 08:57:11 INFO - "stage_platform": "linux64", 08:57:11 INFO - "basedir": "/builds/slave/test", 08:57:11 INFO - "buildnumber": 118, 08:57:11 INFO - "platform": "ubuntu64_hw", 08:57:11 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:57:11 INFO - "slavebuilddir": "test", 08:57:11 INFO - "taskId": "R2a7YtjMTaGQool0T_VMTg", 08:57:11 INFO - "branch": "mozilla-aurora", 08:57:11 INFO - "script_repo_revision": "production", 08:57:11 INFO - "revision": "5a1c52f42dd5c0aaf5196d4b02deb7564b03895e", 08:57:11 INFO - "slavename": "talos-linux64-ix-044", 08:57:11 INFO - "repo_path": "releases/mozilla-aurora" 08:57:11 INFO - } 08:57:11 INFO - Finding installer, test and symbols from parent task. 08:57:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R2a7YtjMTaGQool0T_VMTg'}, attempt #1 08:57:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R2a7YtjMTaGQool0T_VMTg'}, attempt #1 08:57:12 INFO - Task dependencies: IZYHO1zxQcmA7_9A5e6fiA 08:57:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA'}, attempt #1 08:57:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 08:57:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/test_packages.json 08:57:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.crashreporter-symbols.zip 08:57:13 INFO - Running post-action listener: _resource_record_post_action 08:57:13 INFO - [mozharness: 2017-04-06 15:57:13.370959Z] Finished read-buildbot-config step (success) 08:57:13 INFO - [mozharness: 2017-04-06 15:57:13.371177Z] Running download-and-extract step. 08:57:13 INFO - Running pre-action listener: _resource_record_pre_action 08:57:13 INFO - Running main action method: download_and_extract 08:57:13 INFO - mkdir: /builds/slave/test/build/tests 08:57:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:13 INFO - trying https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.test_packages.json 08:57:13 INFO - Downloading https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:57:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:57:13 INFO - Downloaded 896 bytes. 08:57:13 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:57:13 INFO - Using the following test package requirements: 08:57:13 INFO - {u'common': [u'target.common.tests.zip'], 08:57:13 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:57:13 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:57:13 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:57:13 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:57:13 INFO - u'mozbase': [u'target.common.tests.zip'], 08:57:13 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:57:13 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:57:13 INFO - u'web-platform': [u'target.common.tests.zip', 08:57:13 INFO - u'target.web-platform.tests.zip'], 08:57:13 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:57:13 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:57:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip 08:57:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:57:13 INFO - Fetch https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip into memory 08:57:15 INFO - Expected file size: 59542062 08:57:15 INFO - Obtained file size: 59542062 08:57:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:57:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip 08:57:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:57:24 INFO - Fetch https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.common.tests.zip into memory 08:57:25 INFO - Expected file size: 59542062 08:57:25 INFO - Obtained file size: 59542062 08:57:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.talos.tests.zip 08:57:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:57:36 INFO - Fetch https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.talos.tests.zip into memory 08:57:37 INFO - Expected file size: 14404438 08:57:37 INFO - Obtained file size: 14404438 08:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:37 INFO - trying https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 08:57:37 INFO - Downloading https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:57:38 INFO - Downloaded 66712748 bytes. 08:57:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 08:57:38 INFO - mkdir: /builds/slave/test/properties 08:57:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:57:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:57:38 INFO - Contents: 08:57:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 08:57:38 INFO - Running post-action listener: _resource_record_post_action 08:57:38 INFO - Running post-action listener: set_extra_try_arguments 08:57:38 INFO - [mozharness: 2017-04-06 15:57:38.818133Z] Finished download-and-extract step (success) 08:57:38 INFO - [mozharness: 2017-04-06 15:57:38.818231Z] Running populate-webroot step. 08:57:38 INFO - Running pre-action listener: _resource_record_pre_action 08:57:38 INFO - Running main action method: populate_webroot 08:57:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:57:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:57:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:57:38 INFO - '--tppagecycles', 08:57:38 INFO - '7'], 08:57:38 INFO - 'tests': ['tsvgm']}}, 08:57:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:57:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:57:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:57:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:57:38 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:38 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['damp', 'tps']}, 08:57:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'tests': ['damp', 'tps']}, 08:57:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['dromaeo_dom']}, 08:57:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:57:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['basic_compositor_video']}, 08:57:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:57:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'other-e10s': {'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['a11yr', 08:57:38 INFO - 'ts_paint', 08:57:38 INFO - 'tpaint', 08:57:38 INFO - 'sessionrestore', 08:57:38 INFO - 'sessionrestore_no_auto_restore', 08:57:38 INFO - 'tabpaint']}, 08:57:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['tsvgx', 08:57:38 INFO - 'tsvgr_opacity', 08:57:38 INFO - 'tart', 08:57:38 INFO - 'tscrollx', 08:57:38 INFO - 'cart', 08:57:38 INFO - 'tsvg_static']}, 08:57:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:57:38 INFO - 'tsvgr_opacity', 08:57:38 INFO - 'tart', 08:57:38 INFO - 'tscrollx', 08:57:38 INFO - 'cart', 08:57:38 INFO - 'tsvg_static']}, 08:57:38 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'talos_options': ['--disable-e10s'], 08:57:38 INFO - 'tests': ['tp5o']}, 08:57:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:57:38 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'talos_options': ['--disable-e10s', 08:57:38 INFO - '--xperf_path', 08:57:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:38 INFO - 'tests': ['tp5n']}, 08:57:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:57:38 INFO - 'talos_options': ['--xperf_path', 08:57:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:38 INFO - 'tests': ['tp5n']}}, 08:57:38 INFO - 'talos.zip': {'path': '', 08:57:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:57:38 INFO - Running post-action listener: _resource_record_post_action 08:57:38 INFO - [mozharness: 2017-04-06 15:57:38.831287Z] Finished populate-webroot step (success) 08:57:38 INFO - [mozharness: 2017-04-06 15:57:38.831378Z] Running create-virtualenv step. 08:57:38 INFO - Running pre-action listener: _resource_record_pre_action 08:57:38 INFO - Running main action method: create_virtualenv 08:57:38 INFO - Creating virtualenv /builds/slave/test/build/venv 08:57:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:57:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:57:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:57:38 INFO - Using real prefix '/usr' 08:57:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:39 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:41 INFO - Installing pip.................done. 08:57:41 INFO - Return code: 0 08:57:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:57:41 INFO - Reading from file tmpfile_stdout 08:57:41 INFO - Output received: 08:57:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:57:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:41 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:57:41 INFO - Using env: {'DISPLAY': ':0', 08:57:41 INFO - 'HOME': '/home/cltbld', 08:57:41 INFO - 'LANG': 'en_US.UTF-8', 08:57:41 INFO - 'LANGUAGE': 'en_US:en', 08:57:41 INFO - 'LOGNAME': 'cltbld', 08:57:41 INFO - 'MAIL': '/var/mail/cltbld', 08:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:41 INFO - 'MOZ_NO_REMOTE': '1', 08:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:41 INFO - 'NO_EM_RESTART': '1', 08:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:41 INFO - 'PWD': '/builds/slave/test', 08:57:41 INFO - 'SHELL': '/bin/bash', 08:57:41 INFO - 'SHLVL': '1', 08:57:41 INFO - 'TERM': 'linux', 08:57:41 INFO - 'TMOUT': '86400', 08:57:41 INFO - 'USER': 'cltbld', 08:57:41 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:41 INFO - '_': '/tools/buildbot/bin/python'} 08:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:57:41 INFO - Cleaning up... 08:57:41 INFO - Return code: 0 08:57:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:41 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:57:41 INFO - Using env: {'DISPLAY': ':0', 08:57:41 INFO - 'HOME': '/home/cltbld', 08:57:41 INFO - 'LANG': 'en_US.UTF-8', 08:57:41 INFO - 'LANGUAGE': 'en_US:en', 08:57:41 INFO - 'LOGNAME': 'cltbld', 08:57:41 INFO - 'MAIL': '/var/mail/cltbld', 08:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:41 INFO - 'MOZ_NO_REMOTE': '1', 08:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:41 INFO - 'NO_EM_RESTART': '1', 08:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:41 INFO - 'PWD': '/builds/slave/test', 08:57:41 INFO - 'SHELL': '/bin/bash', 08:57:41 INFO - 'SHLVL': '1', 08:57:41 INFO - 'TERM': 'linux', 08:57:41 INFO - 'TMOUT': '86400', 08:57:41 INFO - 'USER': 'cltbld', 08:57:41 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:41 INFO - '_': '/tools/buildbot/bin/python'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 INFO - Downloading/unpacking psutil>=3.1.1 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:44 INFO - Installing collected packages: psutil 08:57:44 INFO - Running setup.py install for psutil 08:57:44 INFO - building 'psutil._psutil_linux' extension 08:57:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:57:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:57:44 INFO - building 'psutil._psutil_posix' extension 08:57:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:57:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:57:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:44 INFO - Successfully installed psutil 08:57:44 INFO - Cleaning up... 08:57:44 INFO - Return code: 0 08:57:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:44 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:57:44 INFO - Using env: {'DISPLAY': ':0', 08:57:44 INFO - 'HOME': '/home/cltbld', 08:57:44 INFO - 'LANG': 'en_US.UTF-8', 08:57:44 INFO - 'LANGUAGE': 'en_US:en', 08:57:44 INFO - 'LOGNAME': 'cltbld', 08:57:44 INFO - 'MAIL': '/var/mail/cltbld', 08:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:44 INFO - 'MOZ_NO_REMOTE': '1', 08:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:44 INFO - 'NO_EM_RESTART': '1', 08:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:44 INFO - 'PWD': '/builds/slave/test', 08:57:44 INFO - 'SHELL': '/bin/bash', 08:57:44 INFO - 'SHLVL': '1', 08:57:44 INFO - 'TERM': 'linux', 08:57:44 INFO - 'TMOUT': '86400', 08:57:44 INFO - 'USER': 'cltbld', 08:57:44 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:44 INFO - '_': '/tools/buildbot/bin/python'} 08:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:57:47 INFO - Installing collected packages: mozsystemmonitor 08:57:47 INFO - Running setup.py install for mozsystemmonitor 08:57:47 INFO - Successfully installed mozsystemmonitor 08:57:47 INFO - Cleaning up... 08:57:47 INFO - Return code: 0 08:57:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:47 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:57:47 INFO - Using env: {'DISPLAY': ':0', 08:57:47 INFO - 'HOME': '/home/cltbld', 08:57:47 INFO - 'LANG': 'en_US.UTF-8', 08:57:47 INFO - 'LANGUAGE': 'en_US:en', 08:57:47 INFO - 'LOGNAME': 'cltbld', 08:57:47 INFO - 'MAIL': '/var/mail/cltbld', 08:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:47 INFO - 'MOZ_NO_REMOTE': '1', 08:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:47 INFO - 'NO_EM_RESTART': '1', 08:57:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:47 INFO - 'PWD': '/builds/slave/test', 08:57:47 INFO - 'SHELL': '/bin/bash', 08:57:47 INFO - 'SHLVL': '1', 08:57:47 INFO - 'TERM': 'linux', 08:57:47 INFO - 'TMOUT': '86400', 08:57:47 INFO - 'USER': 'cltbld', 08:57:47 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:47 INFO - '_': '/tools/buildbot/bin/python'} 08:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:47 INFO - Downloading/unpacking jsonschema==2.5.1 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:57:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:49 INFO - Downloading functools32-3.2.3-2.tar.gz 08:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:57:49 INFO - warning: no files found matching '*.txt' 08:57:49 INFO - no previously-included directories found matching 'build' 08:57:49 INFO - no previously-included directories found matching 'dist' 08:57:49 INFO - no previously-included directories found matching '.git*' 08:57:49 INFO - Installing collected packages: jsonschema, functools32 08:57:49 INFO - Running setup.py install for functools32 08:57:49 INFO - warning: no files found matching '*.txt' 08:57:49 INFO - no previously-included directories found matching 'build' 08:57:49 INFO - no previously-included directories found matching 'dist' 08:57:49 INFO - no previously-included directories found matching '.git*' 08:57:49 INFO - Successfully installed jsonschema functools32 08:57:49 INFO - Cleaning up... 08:57:49 INFO - Return code: 0 08:57:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:57:49 INFO - Using env: {'DISPLAY': ':0', 08:57:49 INFO - 'HOME': '/home/cltbld', 08:57:49 INFO - 'LANG': 'en_US.UTF-8', 08:57:49 INFO - 'LANGUAGE': 'en_US:en', 08:57:49 INFO - 'LOGNAME': 'cltbld', 08:57:49 INFO - 'MAIL': '/var/mail/cltbld', 08:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:49 INFO - 'MOZ_NO_REMOTE': '1', 08:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:49 INFO - 'NO_EM_RESTART': '1', 08:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:49 INFO - 'PWD': '/builds/slave/test', 08:57:49 INFO - 'SHELL': '/bin/bash', 08:57:49 INFO - 'SHLVL': '1', 08:57:49 INFO - 'TERM': 'linux', 08:57:49 INFO - 'TMOUT': '86400', 08:57:49 INFO - 'USER': 'cltbld', 08:57:49 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:49 INFO - '_': '/tools/buildbot/bin/python'} 08:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:57:50 INFO - Cleaning up... 08:57:50 INFO - Return code: 0 08:57:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:57:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:57:50 INFO - Using env: {'DISPLAY': ':0', 08:57:50 INFO - 'HOME': '/home/cltbld', 08:57:50 INFO - 'LANG': 'en_US.UTF-8', 08:57:50 INFO - 'LANGUAGE': 'en_US:en', 08:57:50 INFO - 'LOGNAME': 'cltbld', 08:57:50 INFO - 'MAIL': '/var/mail/cltbld', 08:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:50 INFO - 'MOZ_NO_REMOTE': '1', 08:57:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:50 INFO - 'NO_EM_RESTART': '1', 08:57:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:50 INFO - 'PWD': '/builds/slave/test', 08:57:50 INFO - 'SHELL': '/bin/bash', 08:57:50 INFO - 'SHLVL': '1', 08:57:50 INFO - 'TERM': 'linux', 08:57:50 INFO - 'TMOUT': '86400', 08:57:50 INFO - 'USER': 'cltbld', 08:57:50 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:50 INFO - '_': '/tools/buildbot/bin/python'} 08:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:53 INFO - Downloading docopt-0.6.1.tar.gz 08:57:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:53 INFO - Running setup.py install for blobuploader 08:57:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:53 INFO - Running setup.py install for requests 08:57:53 INFO - Running setup.py install for docopt 08:57:53 INFO - Successfully installed blobuploader requests docopt 08:57:53 INFO - Cleaning up... 08:57:53 INFO - Return code: 0 08:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:53 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:53 INFO - Using env: {'DISPLAY': ':0', 08:57:53 INFO - 'HOME': '/home/cltbld', 08:57:53 INFO - 'LANG': 'en_US.UTF-8', 08:57:53 INFO - 'LANGUAGE': 'en_US:en', 08:57:53 INFO - 'LOGNAME': 'cltbld', 08:57:53 INFO - 'MAIL': '/var/mail/cltbld', 08:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:53 INFO - 'MOZ_NO_REMOTE': '1', 08:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:53 INFO - 'NO_EM_RESTART': '1', 08:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:53 INFO - 'PWD': '/builds/slave/test', 08:57:53 INFO - 'SHELL': '/bin/bash', 08:57:53 INFO - 'SHLVL': '1', 08:57:53 INFO - 'TERM': 'linux', 08:57:53 INFO - 'TMOUT': '86400', 08:57:53 INFO - 'USER': 'cltbld', 08:57:53 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:53 INFO - '_': '/tools/buildbot/bin/python'} 08:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:53 INFO - Running setup.py (path:/tmp/pip-WYz6tD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:54 INFO - Running setup.py (path:/tmp/pip-62pwQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:54 INFO - Running setup.py (path:/tmp/pip-c5bBkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:54 INFO - Running setup.py (path:/tmp/pip-nQpNOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:54 INFO - Running setup.py (path:/tmp/pip-nkuEg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:54 INFO - Running setup.py (path:/tmp/pip-n3Walw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:54 INFO - Running setup.py (path:/tmp/pip-hsCo7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:54 INFO - Running setup.py (path:/tmp/pip-A4Nkzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:54 INFO - Running setup.py (path:/tmp/pip-NCt2ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:54 INFO - Running setup.py (path:/tmp/pip-Red9WF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:54 INFO - Running setup.py (path:/tmp/pip-EqZuYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:54 INFO - Running setup.py (path:/tmp/pip-OmgeOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:54 INFO - Running setup.py (path:/tmp/pip-h_oAOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:54 INFO - Running setup.py (path:/tmp/pip-ckdVny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:54 INFO - Running setup.py (path:/tmp/pip-0hXJcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:55 INFO - Running setup.py (path:/tmp/pip-Qrkayp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:55 INFO - Running setup.py (path:/tmp/pip-3a6ui4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:55 INFO - Running setup.py install for manifestparser 08:57:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Running setup.py install for mozcrash 08:57:55 INFO - Running setup.py install for mozdebug 08:57:55 INFO - Running setup.py install for mozdevice 08:57:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Running setup.py install for mozfile 08:57:55 INFO - Running setup.py install for mozhttpd 08:57:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Running setup.py install for mozinfo 08:57:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Running setup.py install for mozInstall 08:57:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:55 INFO - Running setup.py install for mozleak 08:57:56 INFO - Running setup.py install for mozlog 08:57:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Running setup.py install for moznetwork 08:57:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Running setup.py install for mozprocess 08:57:56 INFO - Running setup.py install for mozprofile 08:57:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Running setup.py install for mozrunner 08:57:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Running setup.py install for mozscreenshot 08:57:56 INFO - Running setup.py install for moztest 08:57:56 INFO - Running setup.py install for mozversion 08:57:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:56 INFO - Cleaning up... 08:57:56 INFO - Return code: 0 08:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:56 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:57:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:57:56 INFO - Using env: {'DISPLAY': ':0', 08:57:56 INFO - 'HOME': '/home/cltbld', 08:57:56 INFO - 'LANG': 'en_US.UTF-8', 08:57:56 INFO - 'LANGUAGE': 'en_US:en', 08:57:56 INFO - 'LOGNAME': 'cltbld', 08:57:56 INFO - 'MAIL': '/var/mail/cltbld', 08:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:56 INFO - 'MOZ_NO_REMOTE': '1', 08:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:57:56 INFO - 'NO_EM_RESTART': '1', 08:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:56 INFO - 'PWD': '/builds/slave/test', 08:57:56 INFO - 'SHELL': '/bin/bash', 08:57:56 INFO - 'SHLVL': '1', 08:57:56 INFO - 'TERM': 'linux', 08:57:56 INFO - 'TMOUT': '86400', 08:57:56 INFO - 'USER': 'cltbld', 08:57:56 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:56 INFO - '_': '/tools/buildbot/bin/python'} 08:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:57 INFO - Running setup.py (path:/tmp/pip-8jpz34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:57 INFO - Running setup.py (path:/tmp/pip-sag0e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:57 INFO - Running setup.py (path:/tmp/pip-VERCdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:57 INFO - Running setup.py (path:/tmp/pip-u7OfGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:57 INFO - Running setup.py (path:/tmp/pip-kYXrGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:57 INFO - Running setup.py (path:/tmp/pip-BC1vBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:57 INFO - Running setup.py (path:/tmp/pip-XGR16u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:57 INFO - Running setup.py (path:/tmp/pip-psxyk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:57 INFO - Running setup.py (path:/tmp/pip-8nTSsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:57 INFO - Running setup.py (path:/tmp/pip-1vHFwo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:57 INFO - Running setup.py (path:/tmp/pip-qDjyS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:57:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:58 INFO - Running setup.py (path:/tmp/pip-mWEe0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:58 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)) 08:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:58 INFO - Running setup.py (path:/tmp/pip-ljA8L8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:58 INFO - Running setup.py (path:/tmp/pip-wzTGMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:58 INFO - Running setup.py (path:/tmp/pip-HD0Gr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:58 INFO - Running setup.py (path:/tmp/pip-Yz6cq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:57:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:58 INFO - Running setup.py (path:/tmp/pip-RLnizT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:57:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:58:00 INFO - Downloading blessings-1.6.tar.gz 08:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:58:00 INFO - Installing collected packages: blessings 08:58:00 INFO - Running setup.py install for blessings 08:58:00 INFO - Successfully installed blessings 08:58:00 INFO - Cleaning up... 08:58:00 INFO - Return code: 0 08:58:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:58:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:00 INFO - Reading from file tmpfile_stdout 08:58:00 INFO - Current package versions: 08:58:00 INFO - argparse == 1.2.1 08:58:00 INFO - blessings == 1.6 08:58:00 INFO - blobuploader == 1.2.4 08:58:00 INFO - docopt == 0.6.1 08:58:00 INFO - functools32 == 3.2.3-2 08:58:00 INFO - jsonschema == 2.5.1 08:58:00 INFO - manifestparser == 1.1 08:58:00 INFO - mozInstall == 1.12 08:58:00 INFO - mozcrash == 1.0 08:58:00 INFO - mozdebug == 0.1 08:58:00 INFO - mozdevice == 0.49 08:58:00 INFO - mozfile == 1.2 08:58:00 INFO - mozhttpd == 0.7 08:58:00 INFO - mozinfo == 0.9 08:58:00 INFO - mozleak == 0.1 08:58:00 INFO - mozlog == 3.4 08:58:00 INFO - moznetwork == 0.27 08:58:00 INFO - mozprocess == 0.25 08:58:00 INFO - mozprofile == 0.28 08:58:00 INFO - mozrunner == 6.13 08:58:00 INFO - mozscreenshot == 0.1 08:58:00 INFO - mozsystemmonitor == 0.3 08:58:00 INFO - moztest == 0.8 08:58:00 INFO - mozversion == 1.4 08:58:00 INFO - psutil == 3.1.1 08:58:00 INFO - requests == 1.2.3 08:58:00 INFO - wsgiref == 0.1.2 08:58:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:00 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:58:00 INFO - Using env: {'DISPLAY': ':0', 08:58:00 INFO - 'HOME': '/home/cltbld', 08:58:00 INFO - 'LANG': 'en_US.UTF-8', 08:58:00 INFO - 'LANGUAGE': 'en_US:en', 08:58:00 INFO - 'LOGNAME': 'cltbld', 08:58:00 INFO - 'MAIL': '/var/mail/cltbld', 08:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:00 INFO - 'MOZ_NO_REMOTE': '1', 08:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:00 INFO - 'NO_EM_RESTART': '1', 08:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:00 INFO - 'PWD': '/builds/slave/test', 08:58:00 INFO - 'SHELL': '/bin/bash', 08:58:00 INFO - 'SHLVL': '1', 08:58:00 INFO - 'TERM': 'linux', 08:58:00 INFO - 'TMOUT': '86400', 08:58:00 INFO - 'USER': 'cltbld', 08:58:00 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:00 INFO - '_': '/tools/buildbot/bin/python'} 08:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:58:01 INFO - Cleaning up... 08:58:01 INFO - Return code: 0 08:58:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:58:01 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 0xec51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1163310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:58:01 INFO - Using env: {'DISPLAY': ':0', 08:58:01 INFO - 'HOME': '/home/cltbld', 08:58:01 INFO - 'LANG': 'en_US.UTF-8', 08:58:01 INFO - 'LANGUAGE': 'en_US:en', 08:58:01 INFO - 'LOGNAME': 'cltbld', 08:58:01 INFO - 'MAIL': '/var/mail/cltbld', 08:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:01 INFO - 'MOZ_NO_REMOTE': '1', 08:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:01 INFO - 'NO_EM_RESTART': '1', 08:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:01 INFO - 'PWD': '/builds/slave/test', 08:58:01 INFO - 'SHELL': '/bin/bash', 08:58:01 INFO - 'SHLVL': '1', 08:58:01 INFO - 'TERM': 'linux', 08:58:01 INFO - 'TMOUT': '86400', 08:58:01 INFO - 'USER': 'cltbld', 08:58:01 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:01 INFO - '_': '/tools/buildbot/bin/python'} 08:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:58:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:58:01 INFO - Cleaning up... 08:58:01 INFO - Return code: 0 08:58:01 INFO - Running post-action listener: _resource_record_post_action 08:58:01 INFO - Running post-action listener: _start_resource_monitoring 08:58:01 INFO - Starting resource monitoring. 08:58:01 INFO - [mozharness: 2017-04-06 15:58:01.439790Z] Finished create-virtualenv step (success) 08:58:01 INFO - [mozharness: 2017-04-06 15:58:01.440298Z] Running install step. 08:58:01 INFO - Running pre-action listener: _resource_record_pre_action 08:58:01 INFO - Running main action method: install 08:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:58:01 INFO - Reading from file tmpfile_stdout 08:58:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:58:01 INFO - Reading from file tmpfile_stdout 08:58:01 INFO - Output received: 08:58:01 INFO - Usage: mozinstall [options] installer 08:58:01 INFO - Options: 08:58:01 INFO - -h, --help show this help message and exit 08:58:01 INFO - -d DEST, --destination=DEST 08:58:01 INFO - Directory to install application into. [default: 08:58:01 INFO - "/builds/slave/test"] 08:58:01 INFO - --app=APP Application being installed. [default: firefox] 08:58:01 INFO - mkdir: /builds/slave/test/build/application 08:58:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:58:18 INFO - Reading from file tmpfile_stdout 08:58:18 INFO - Output received: 08:58:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:58:18 INFO - Running post-action listener: _resource_record_post_action 08:58:18 INFO - [mozharness: 2017-04-06 15:58:18.266568Z] Finished install step (success) 08:58:18 INFO - [mozharness: 2017-04-06 15:58:18.266835Z] Running run-tests step. 08:58:18 INFO - Running pre-action listener: _resource_record_pre_action 08:58:18 INFO - Running main action method: run_tests 08:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:58:18 INFO - Python 2.7.3 08:58:18 INFO - Return code: 0 08:58:18 INFO - grabbing minidump binary from tooltool 08:58: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')]} 08:58:18 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 0x1160400>, '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 0x11613b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1161840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:58:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:58:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:58:18 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:58:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:58:18 INFO - Return code: 0 08:58:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:58:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:58:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:58:18 INFO - ENV: RUST_BACKTRACE is now 1 08:58:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:58:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:58:18 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/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:58:18 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/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:58:18 INFO - Using env: {'DISPLAY': ':0', 08:58:18 INFO - 'HOME': '/home/cltbld', 08:58:18 INFO - 'LANG': 'en_US.UTF-8', 08:58:18 INFO - 'LANGUAGE': 'en_US:en', 08:58:18 INFO - 'LOGNAME': 'cltbld', 08:58:18 INFO - 'MAIL': '/var/mail/cltbld', 08:58:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:58:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:18 INFO - 'MOZ_NO_REMOTE': '1', 08:58:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:58:18 INFO - 'NO_EM_RESTART': '1', 08:58:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:18 INFO - 'PWD': '/builds/slave/test', 08:58:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:58:18 INFO - 'RUST_BACKTRACE': '1', 08:58:18 INFO - 'SHELL': '/bin/bash', 08:58:18 INFO - 'SHLVL': '1', 08:58:18 INFO - 'TERM': 'linux', 08:58:18 INFO - 'TMOUT': '86400', 08:58:18 INFO - 'USER': 'cltbld', 08:58:18 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217', 08:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:18 INFO - '_': '/tools/buildbot/bin/python'} 08:58:18 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/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:58:18 INFO - mozversion application_buildid: 20170406150515 08:58:18 INFO - mozversion application_changeset: 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e 08:58:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:58:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:58:18 INFO - mozversion application_name: Firefox 08:58:18 INFO - mozversion application_remotingname: firefox-dev 08:58:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:58:18 INFO - mozversion application_vendor: Mozilla 08:58:18 INFO - mozversion application_version: 54.0a2 08:58:18 INFO - mozversion platform_buildid: 20170406150515 08:58:18 INFO - mozversion platform_changeset: 5a1c52f42dd5c0aaf5196d4b02deb7564b03895e 08:58:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:58:18 INFO - mozversion platform_version: 54.0a2 08:58:18 INFO - using testdate: 1491494298 08:58:18 INFO - actual date: 1491494298 08:58:18 INFO - starting webserver on 'localhost:54919' 08:58:18 INFO - SUITE-START | Running 2 tests 08:58:18 INFO - TEST-START | dromaeo_css 08:58:18 INFO - operating with platform_type : linux_ 08:58:18 INFO - Initialising browser for dromaeo_css test... 08:58:18 INFO - TEST-INFO | started process 3250 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKJkT8/profile http://localhost:54919/getInfo.html) 08:58:22 INFO - PROCESS | 3250 | __metrics Screen width/height:1600/1200 08:58:22 INFO - PROCESS | 3250 | colorDepth:24 08:58:22 INFO - PROCESS | 3250 | Browser inner width/height: 1024/697 08:58:22 INFO - PROCESS | 3250 | __metrics 08:58:23 INFO - PROCESS | 3250 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:58:23 INFO - PROCESS | 3250 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:24 INFO - TEST-INFO | 3250: exit 0 08:58:24 INFO - Browser initialized. 08:58:24 INFO - Running cycle 1/1 for dromaeo_css test... 08:58:24 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEKJkT8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:36 INFO - PROCESS | 3347 | RSS: Main: 139952128 08:58:36 INFO - PROCESS | 3347 | 09:01:37 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54919/tests/dromaeo/cssquery-ext.html) 09:01:39 INFO - PROCESS | 3347 | RSS: Main: 285073408 09:01:39 INFO - PROCESS | 3347 | 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | A coding exception was thrown and uncaught in a Task. 09:03:26 INFO - PROCESS | 3347 | 09:03:26 ERROR - PROCESS | 3347 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:26 INFO - PROCESS | 3347 | Full stack: 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | A coding exception was thrown and uncaught in a Task. 09:03:26 INFO - PROCESS | 3347 | 09:03:26 ERROR - PROCESS | 3347 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:26 INFO - PROCESS | 3347 | Full stack: 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | A coding exception was thrown and uncaught in a Task. 09:03:26 INFO - PROCESS | 3347 | 09:03:26 ERROR - PROCESS | 3347 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:26 INFO - PROCESS | 3347 | Full stack: 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | ************************* 09:03:26 INFO - PROCESS | 3347 | A coding exception was thrown and uncaught in a Task. 09:03:26 INFO - PROCESS | 3347 | 09:03:26 ERROR - PROCESS | 3347 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:26 INFO - PROCESS | 3347 | Full stack: 09:03:26 INFO - PROCESS | 3347 | ************************* 09:04:41 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-ext.html (next: http://localhost:54919/tests/dromaeo/cssquery-jquery.html) 09:04:41 INFO - PROCESS | 3347 | RSS: Main: 226299904 09:04:41 INFO - PROCESS | 3347 | 09:07:43 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54919/tests/dromaeo/cssquery-mootools.html) 09:07:44 INFO - PROCESS | 3347 | RSS: Main: 213086208 09:07:44 INFO - PROCESS | 3347 | 09:10:46 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54919/tests/dromaeo/cssquery-prototype.html) 09:10:46 INFO - PROCESS | 3347 | RSS: Main: 175964160 09:10:46 INFO - PROCESS | 3347 | 09:13:49 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54919/tests/dromaeo/cssquery-yui.html) 09:13:50 INFO - PROCESS | 3347 | RSS: Main: 175779840 09:13:50 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | Cycle 1(1): loaded http://localhost:54919/tests/dromaeo/cssquery-yui.html (next: http://localhost:54919/tests/dromaeo/cssquery-dojo.html) 09:16:52 INFO - PROCESS | 3347 | RSS: Main: 262762496 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | __start_tp_report 09:16:52 INFO - PROCESS | 3347 | _x_x_mozilla_page_load 09:16:52 INFO - PROCESS | 3347 | _x_x_mozilla_page_load_details 09:16:52 INFO - PROCESS | 3347 | |i|pagename|runs| 09:16:52 INFO - PROCESS | 3347 | |0;dojo.html;3357.882474113406;3391.4573668213084;3406.9488957665626;3429.074149979504;3448.086257141858;5626.043572592659;5698;5707.3721890592005;5722.685252311121;5727.312722473299;5754.65472071676;5787.363390027093;5795.449432303924;5795.507381872535;5806.042003069489;5159.174532074869;5160.174372100465;5201.895962080756;5204.635675502716;5228.294180285669;5025.899482010358;5075.873103172414;5234.502722241381;5253.973730131344;5296.920546191791;5068.645194836345;5112.309838171855;5160.948390516103;5175.24958880962;5187.844364669066;5238.423773384925;5250.527452529291;5256.290400795881;5259.342582177228;5278.736063196825;5040.017196646655;5115.2327150927285;5178.352705911761;5225.738713064369;5234.162533994542;5635.098384258499;5645.943540564583;5721.599488035839;5722.799702010451;5726.856828579277;6169.321374648785;6210.347913469066;6214.906776398358;6222.222222222223;6224.937750622481;6238.585215421324;6263.749450022039;6274.121622972787;6276.435120839146;6280.246370435531;5636.154576813511;5679.744411501492;5788;5810.564207684441;5921.851953701106;6346.270178929482;6351.555391122577;6353.174087368612;6354.3010268870385;6354.3963323484195;6072.878542429126;6121.112438696364;6131.448169664752;6132.018876979661;6135.877282454326;5914.556408269311;5943.61366511184;6031.698415079316;6053.122297266872;6219.129321894939;6074.635521868702;6076.392360763888;6083.847903802441;6114.602550834182;6128.785492507741;5895.852603684943;5974.283086029617;6018.518518518508;6076.240469941257;6127.142200091991;4661.906761864744;4743.715377077387;4759.809607615726;4761.047790441926;4779.928301075487;4112.691548133902;4123.525794533607;4155.771432571177;4224.281872081692;4224.8732538023905;5919.052951527821;5975.103734439782;5978.0733986231335;5979;6011.609245399035;6228;6237.594556353823;6258.43674069336;6259.311475737665;6259.436650701458;5780.826575202751;5797.246357973437;5964.194833697482;5969.343372229051;5981.252343457068;5172.405173405106;5187;5263.6315457918345;5300.575953923677;5311.946880531223;6465.741370345134;6471.773487927994;6481.611103333721;6488.124103246096;6489.221293444912;5914.319853216935;6179.590289072633;6223.937760622336;6225.408586184305;6225.439710426083;6292.748290068529;6344.1118243445035;6384.521160912857;6421.550491465552;6496.317886621837;6151.231096112986;6165.84585385369;6166.691665416801;6175.536834737323;6176.474999624902;6275.6862156892885;6277;6278.654673992792;6280.152179455898;6282.937170628235;5781;5893.204417403767;5988;5997.220361353171;6101.115338276014;6038.51691864641;6058.4850287724275;6083.726232319645;6096.695165241809;6113.480354169946;5863.677497737665;6066.181065556093;6070.666113363807;6078.756849725962;6079.483243924316;5935.703214839327;5999.850003749942;6025.728842202024;6067.696615169136;6136.417040381157;5960.433758792908;5964.373740757158;5965.612235204698;5970.164177015135;5997.730102145327 09:16:52 INFO - PROCESS | 3347 | |1;ext.html;762.3139174742731;816.1919699497497;839.5927974932157;905.0858632780894;924.6024209589874;31291.53062704061;43602.34596481051;44072.55927440725;44148.896277593034;44182.33726494105;45100.77449612747;45395;45515;45530;45550.54449455505;7836.647350869224;7994.440389172761;9294.163525282705;9444.574994125282;9448;10473.73815654611;10697.411642359668;10979.725506862313;11005;11009.449527523591;10796.190285728562;10800.13598912089;10808.78382432351;10821.891781082168;10846.511906964206;10701.250912436133;10738.463076846165;10752.408617526033;10761.354318740901;10777.622783202629;10612.204084693602;10648.361098334048;10650.573977040909;10670.146388288918;10673.946630266799;41786.373204401956;42084.579154208375;42093.78953105215;42173.789131054145;42204.36693449601;4182.025932733848;4230.153969206141;4279.550647182064;4372.737635741833;4376.824927002916;29408.55887161673;29838.403231935456;29860.253493662614;30501.389972200654;31033;4393.319035549495;4451.109778044404;4491.1466821304175;4530.411046563926;4560.1335746208115;239809;240122;240445;241095;241239;53769.462305376444;53784.73107634437;53844.461555384725;53856.73071634695;53870.730646346514;56669.14996275059;56679;56774.43225567774;56845.71577142088;56873;15478.845211547965;15685.529434116996;15705.842941570667;15711.450099246471;15729.44946926852;13518.729625407437;13542.390592423168;13648.385822638005;13648.590542283748;13791.241481718602;12953.352332383532;13370.532031378854;13512.527061552995;13588.456461741618;13597.32013399326;5526.364468086141;5551.666899986014;5700.201971723962;5714.314282286069;5753.568482363839;1018.6332920148741;1027.732789474742;1030.3096925060227;1034.3070143004206;1037.9273450858368;27604.44791104207;28339.291517712223;28370;28706.425871482454;28747.712522874503;1079.56957031933;1079.5951518180682;1100.0979197058334;1114.849495318138;1128.3060917535656;14649.12105273687;15051;15162;15237.847621523642;15415.922920385327;310484;311965;312097;312512;312920;55925;56015.71992140013;56038.71980640071;56039.719801401545;56147;1444.4727674398769;1499.400239904047;1502.7370210213169;1513.5988962924835;1522.665013696985;26170.73829261683;27240.727592724612;27687.723122768515;27903.16290511288;27904.860475697493;42619.147617048104;42660.36009459923;42676.78661606672;42694;42710.786446068814;275221;276908;277402;277817;277942;33963.89848564852;34744.47883281804;34849;34889.82555087208;34986.65013349834;41469.58530414778;41613;41695.166096678506;42752.35871461993;42802.57197427986;32141.35717285688;32753.181170469976;32895;33015;33559.83220083884;32030.679693203703;32153.196170094998;32672.34655306833;32991.41030763046;33343.49984750279;36969.81515092407;37632.81183594064;37696;37991;38070.809645951595;31185.8440707795;31255.030772076618;31277.218069548442;31398.372032559677;31863.450923925568;25297.367565811;25317;25331.113411030525;25379.61930571006;25564.23307300784 09:16:52 INFO - PROCESS | 3347 | |2;jquery.html;389.64542266537455;446.14785759199924;452.87772301478583;468.4098036474044;472.275057786298;19186.136623851926;19441.51396215095;21749.782502174974;21792.89103554484;22018.669719954214;21143.365699029015;21733.782662173373;22160.88919555404;22197;22384;6596.505262105361;6634.469242460604;6702;6761.087253220826;6800.183977922631;6506.674666266667;6532.444742196919;6539.574927629689;6542.41118299353;6603.801885943405;4141.213169497801;4452.666050046259;4615.261558150696;7502.099748030244;7636.541807491541;7375.668094935741;7479.289467500633;7622.656980435893;7626.809329766773;7632.542047477169;7296.124465064173;7308.598027108507;7313.597752123631;7330.450216233804;7338.046054012944;23720.88139559291;24470;25627.231183064538;25695.48609027828;26027;3115.190050586841;3174.6666600006897;3178.618565772099;3182.5067114597273;3246.5779448671756;16254.83745162545;16267.674646507123;16275.83724162755;16398.508044758677;16678.916605416896;2206.4925067234467;2267.8299127565497;2272.409173614872;2292.289390289016;2347.33101066197;109753;115053.42473287664;115067;115656;116871;14286.82638226646;16385.672286554203;18330.541736456697;18447.354342597944;18492.167852446673;32603.02190934276;32631.184220394207;32687.18282042968;32738.67261327404;33105.50341744876;9989.550470228856;10097.545610447547;10178.745531361776;10229.48852557384;10430.113440357503;8477.448965817326;8497.277731392776;8497.320214382959;8639.092895246034;8643.827123457622;9226.630934762668;9235.861462078074;9395.201407880406;9626.422414655142;9644.662436814679;3324.4182268102986;3566.732495062881;3652.579953305351;3803.7527560708463;3871.4773505576386;953.8092381523584;968.9467079310706;969.6557722008727;972.9270304727174;975.9072888075622;20548.178072877217;21591.460213494473;21803.890980544995;21835.344939651837;22118.33644990653;976.0873583199731;985.2905907746411;994.4033579852176;995.144176008632;997.7804882925744;11342.773144537063;11516.251443656303;11558.94220528892;12068.456919438471;12113.757724845455;583404;707384;714873;716048;749565;112705;120049;121673;123476;124992;1365.2422905287463;1404.487362112842;1407.289318893952;1419.6947656253749;1421.1970236816167;14918.552443426715;19779.70330445016;19897.204111835363;19965.800341996393;19990.300339488047;51608;51745;52188;52610.473895260555;52872;65832.67083664551;65932;66716;67348.3265167342;68117.3188268111;12679.049071319872;12785.61643150707;12907.935460322638;12934.676633084247;12985.350732463528;14522.782158267846;14567.053141545766;14568.198749068903;14718.852811471748;14799.704005920037;12561.43473543711;12645.620631381073;12654.683632909251;12889.871101289242;12989;11125.888741112485;11336.263142895685;11483.48324325424;11739.413029348669;11760.82358764602;12204.206726562745;12315.753684926072;12717.173383730027;13066.477340906258;13156.671083222996;12695.873041269839;12736.490540378281;12777.105602607728;12804.29576373271;13099.410526526139;7083;12439;12514.687132821753;12854.228746275254;13053.673658158623 09:16:52 INFO - PROCESS | 3347 | |3;mootools.html;1537.2083377060808;1545.6908618276348;1568.4980806142034;1578.1083687716443;1580.2572790788327;10880;11565.942170289158;11567.305961642296;11576.073914086874;11674.591389301377;11275.66173014811;11423.143264255194;11595.768084638303;11939.701507462318;11946.522139114446;2405.1581946318825;2431.63525471179;2437.1591800828687;2437.5124975004983;2440.5973014452684;2392.724836643782;2442.8534287942693;2482.7889629381525;2488.4774197418565;2492.102842976527;2387.128698025217;2432.8297019208662;2444.633305004255;2453.7055553333626;2455.631655251718;2316.745158032615;2359.4101474631343;2363.598188307983;2371.4071482129466;2435.0503303711566;2402;2429.5748244057395;2430.0887167312258;2432.2338463383976;2440.2679196241234;11278.097752179807;11550.942245288803;11565.248258863232;11568.479418426192;11574.305541667527;5776.104703770922;5877.4122587740885;5882.6764527950945;5887.676177810219;5910.645361278294;3474.5483087198754;3528.576570811519;3569.446735755962;3597.2733088117852;3602.6937710294656;1342.8455727591256;1350.6825895914453;1359.6125104345313;1391.5268808605124;1409.105218186459;17342.393016244496;17510.64978700419;17623.206955687026;17813;17884.105794710213;4554.0891821635805;4699.953000469952;4771.4512831024185;4797.136515427187;4798.832040878552;12933.224006559636;12963.416646250942;13022.804657930139;13048.217106973612;13070.150440221356;5819.6614778600315;5828;5833.183354330397;5833.649981001154;5842.503387212049;5422.783088676409;5469.453054694578;5512.5589952803675;5552.52803511706;5596.552275817925;3992.201559688016;4090.9181816363507;4100.5489396166995;4133.6693064554765;4175.415441838145;1033.1476531861244;1036.290141253244;1036.6423583863555;1054.752133248686;1055.1189756553365;946.4747065378643;977.6333874796951;978.6330126202674;981.7398389426808;993.1607791416242;6794.286599906938;6869.896951545731;6875.3812156906115;6909.689063992032;7048.224695283515;1009.1976878381557;1037.5486663301488;1039.3296323871061;1039.4958445154093;1073.973150671224;4480.215962206601;4750.619950404029;4905.656604037683;4929.778159982738;5046.243063540498;14339.569812905629;14383.640408989859;14586.124832510084;14710.852891471162;14910.627234319229;14308;14481.420743170365;14611.123332600078;14675.266236688123;14730.263486825615;10577.524011419504;10655.786884262272;10676.57293708243;10746.355218686904;10788.568457261621;6815.556988795713;6873.5875847449315;6916.273791252047;6944.756933507303;6967.616781077089;12766.489340426278;12913.418896149507;13109.082364234411;13121.868781312065;13247.138935969131;13128.409221585243;13329.933605311358;13330.666733331744;13403.262820544574;13481.460741570227;9151.86272205904;9269.490178040272;9360.20438262728;9373.484458354857;9375.203107735919;10712.035916767529;10913.290636108944;10932.508037138188;11039.227254092137;11097.722556936142;8955.776105597412;9166.17504424605;9224.215941645036;9234.492102934402;9507.286953478655;9147.86278205814;9160.267178625561;9183.311251656287;9219.44683319003;9482.38364506305;8474.449160804528;8607.698730544402;8608.569571521524;8635.568221589021;8641.827163456821;6348.809535713936;6354.110424540476;6355.968220158869;6445.613263204035;6496.545241833026;6036.456718895321;6134.079888016833;6151.6001459904965;6242.719077641608;6391.520635952229 09:16:52 INFO - PROCESS | 3347 | |4;prototype.html;408.4751094843123;426.79087247248845;428.70317290197147;433.3932494507689;437.78110944527737;5134.589232861372;5187.9740601297035;5219.660722053069;5225.764840582174;5267.315249017632;4803.375561177042;5168.0180765654495;5180.222966555009;5185.662931909433;5201.5838732901375;4271.594198551133;4280.8013756148175;4284.635805956497;4292.441982542266;4294.742315461067;4252.787360631972;4261.105167914741;4263.467066616673;4282.443282373287;4293.849715259967;4282.665947058845;4302.483701955754;4310.482742070956;4326.913461730764;4384.780760961939;4089.243489954353;4242.53332133465;4256.361545768129;4280.379344994958;4314.137172565468;4047.1500984792933;4050.453188819501;4058.695597830145;4060.5127384714024;4086.1419101988618;5070.6957582545165;5077.847664570068;5102.081625307444;5113.948860511385;5117.360329958755;4868.951310486886;5030.471800460936;5036.388355726169;5040.42035165957;5051.333060090162;5441.428649991773;5457.536109430703;5478.58910581708;5499.230107784913;5508.944910550883;4496.4487251898045;4552.180607490651;4552.704074235197;4574.931376029363;4591.655625828076;5433.293671822677;5653.4911857932575;5655.745491452894;5676.574256930706;5708.257926469574;4656.278276867091;4676.883077923011;4678.836240731626;4685.882852928636;4689.718616882998;4755.690880092783;4770.284457331359;4771.4512831024185;4778.5699287063635;4784.784684689197;4935.90128197434;4937.530934561211;5031;5065.924011139836;5070.340855688737;5413.837584872382;5424.213489044067;5444.727763611803;5445.264889239981;5468.7539060742365;1627.7314243149985;1639.5327331710405;1639.877009224313;1646.4237516869;1649.4062137630444;1235.407004637761;1276.95289862312;1282.5318758653025;1284.4926254129566;1307.6073981209981;5117.71852548106;5390.272313237741;5408.538535337388;5450.809221677222;5462.918056229159;5564.4713752193475;5582.078956972054;5600.355959064678;5603.411641777555;5610.691411972299;5377.418838957323;5405.270288511079;5406.675599464044;5419.430959749248;5437.673739575638;2819.4502072095743;2921.182069020678;2938.985305073461;2941.955870661942;2943.484890144216;5697.601167918206;5720.596245234079;5735.369109397963;5744.856378590569;5750.769969201185;5444.40111587725;5585.218069470277;5702.372738998707;5703.686297253608;5737.770489180386;5327.786888524493;5586.91619625706;5828.417158284223;5833.774907269521;5842.503387212049;5611.410801865745;5619.8198378339375;5624.156376543551;5628.296462942132;5640;5261.921071184011;5496.395396506301;5564.860878478071;5591.27313449249;5628.85927851807;5763.394843541368;5772.7402266898935;5781.94218057814;5790.378693965697;5798.82603521895;4631.166390049689;4680.344751734828;4719;4762.761861906822;4783.449903261169;5443.537299329443;5555.250041244381;5605.383407825218;5606.943930560642;5690.630109042899;5458.426865179099;5459.344878614433;5482.643628164156;5490.917636235539;5524.922640085145;5396.83809485716;5488.341399032141;5516.393196748435;5553.639358357228;5573.770491803311;5386.676799392049;5443.374011988672;5465.578949473086;5469.42571030052;5492.6268432891775;5464.590155738256;5467.152591348347;5498.4981833266565;5507.531859791802;5568.49883510486;5129.487051294841;5337.9466205339;5383.650062745909;5409.648372855751;5467.17992301158 09:16:52 INFO - PROCESS | 3347 | |5;yui.html;813.8006188483819;844.923956843884;905.6694306578099;927.536231884058;934.2385955446313;15293.388264469408;15920.681586368266;16207.027578345293;16248.51254462368;16471.423500177498;15716.292766825492;15858.36566537337;16004.199790010482;16566.66866662666;16591.50225493234;863.5941107679396;884.5046773806689;886.9512176830272;887.3211992825494;888.9911100889005;868.444195714743;890.9242714369286;898.8157427727333;904.0146240597747;905.9637614495413;923.201430762389;924.1082355526916;924.306769922558;925.2967744514184;925.8703781470599;918.7703074231442;919.3702313914989;920.2637889688256;920.3327587499076;920.7237828651412;677.6848765324098;679.2901418018183;679.3851564334285;679.9830004249884;680.1566058087935;17391.1304434779;17426.564335891577;17557.20992555338;18504.90747546267;18681.626367472574;16064.59838504035;16272.18639068042;16378.344866205338;16412.589685257844;16595.17024148788;13404.329783510882;13529.32353382327;13609.31953402326;13713.0400871939;13830.446782128703;4044.2315959967514;4091.754494730326;4104.753714777093;4116.526599441043;4186.727862688946;88164;88255;88740.55629721875;89152;91539;11322.490487928064;11790.410479475991;12699.619011429671;13049.217046977212;13223.140495867738;20900.477488062617;21499.46251343729;21503.56992860134;21506.462338441663;23859.64210536843;9754.609815607439;9892.505374731234;9959.751006224902;10025.749356266151;10052;5109.923351149736;5178.326817513775;5270.130428479258;5323.787048518094;5338.492843179892;4128.2156390285745;4270.61564459194;4273.67947403946;4279.037216626234;4281.422008028876;676.0400231670941;676.3709749932511;684.0628339175362;691.1671435919704;698.3156506623537;740.6481921087441;753.5817621220166;758.4956004257217;769.4267770511005;778.1246098139593;11253.212275140662;11793;11846.289222646668;11846.466908989116;12123.454444550016;746.1829296919864;749.539033494397;749.865024295632;766.3945483068425;773.8839174123814;5578.497935185853;5585.106382978704;5668.943310566924;5721.284839395075;5731.226284451629;73284.63357683178;73465;73525;75811;81685.59157204175;46970;60988.69505652532;62970.685146573975;64996;69462.65268673726;59466.702666487254;59719.104213437706;60172.69913650404;60187.69906150441;61387.38612613906;10949.721781592283;11331.603393881174;11368.147388945697;11580.594679186188;11604;41938.79030604827;42392.788036059625;42720.572794272906;42942.35586466268;43523.34714979214;49849;49922.25116623326;50102.49897500978;50787.49212507828;52371.21443178279;13685.589432317047;13807.723845523235;13869;13912.791308130183;14326;16156.67686646237;16249.675006499567;16563.503094907173;16651.750223746894;16818.831811682216;15395.923020384826;15450.922745386652;15547.611309717347;16552;16606.086665233044;14048.578542643738;14324.57026289213;14554;15221.391144354102;15255.771163432335;15024.098554086353;15408.460703875311;16002.279897404413;16182.757258641364;16222.10778407199;10567.841482377617;10675.466226688479;11213.439328033728;11333.659990200307;11352.602658906899;11543.4805433754;11722.94138529336;11828.76342473163;11970.401479926142;11984.340861252715 09:16:52 INFO - PROCESS | 3347 | __end_tp_report 09:16:52 INFO - PROCESS | 3347 | __start_cc_report 09:16:52 INFO - PROCESS | 3347 | _x_x_mozilla_cycle_collect,1471 09:16:52 INFO - PROCESS | 3347 | __end_cc_report 09:16:52 INFO - PROCESS | 3347 | __startTimestamp1491495412880__endTimestamp 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | ------- Summary: start ------- 09:16:52 INFO - PROCESS | 3347 | Number of tests: 6 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#0] dojo.html Cycles:165 Average:5732.58 Median:5974.28 stddev:663.95 (11.1%) stddev-sans-first:639.32 09:16:52 INFO - PROCESS | 3347 | Values: 3357.9 3391.5 3406.9 3429.1 3448.1 5626.0 5698.0 5707.4 5722.7 5727.3 5754.7 5787.4 5795.4 5795.5 5806.0 5159.2 5160.2 5201.9 5204.6 5228.3 5025.9 5075.9 5234.5 5254.0 5296.9 5068.6 5112.3 5160.9 5175.2 5187.8 5238.4 5250.5 5256.3 5259.3 5278.7 5040.0 5115.2 5178.4 5225.7 5234.2 5635.1 5645.9 5721.6 5722.8 5726.9 6169.3 6210.3 6214.9 6222.2 6224.9 6238.6 6263.7 6274.1 6276.4 6280.2 5636.2 5679.7 5788.0 5810.6 5921.9 6346.3 6351.6 6353.2 6354.3 6354.4 6072.9 6121.1 6131.4 6132.0 6135.9 5914.6 5943.6 6031.7 6053.1 6219.1 6074.6 6076.4 6083.8 6114.6 6128.8 5895.9 5974.3 6018.5 6076.2 6127.1 4661.9 4743.7 4759.8 4761.0 4779.9 4112.7 4123.5 4155.8 4224.3 4224.9 5919.1 5975.1 5978.1 5979.0 6011.6 6228.0 6237.6 6258.4 6259.3 6259.4 5780.8 5797.2 5964.2 5969.3 5981.3 5172.4 5187.0 5263.6 5300.6 5311.9 6465.7 6471.8 6481.6 6488.1 6489.2 5914.3 6179.6 6223.9 6225.4 6225.4 6292.7 6344.1 6384.5 6421.6 6496.3 6151.2 6165.8 6166.7 6175.5 6176.5 6275.7 6277.0 6278.7 6280.2 6282.9 5781.0 5893.2 5988.0 5997.2 6101.1 6038.5 6058.5 6083.7 6096.7 6113.5 5863.7 6066.2 6070.7 6078.8 6079.5 5935.7 5999.9 6025.7 6067.7 6136.4 5960.4 5964.4 5965.6 5970.2 5997.7 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#1] ext.html Cycles:180 Average:44971.17 Median:31266.12 stddev:72447.84 (231.7%) stddev-sans-first:72575.03 09:16:52 INFO - PROCESS | 3347 | Values: 762.3 816.2 839.6 905.1 924.6 31291.5 43602.3 44072.6 44148.9 44182.3 45100.8 45395.0 45515.0 45530.0 45550.5 7836.6 7994.4 9294.2 9444.6 9448.0 10473.7 10697.4 10979.7 11005.0 11009.4 10796.2 10800.1 10808.8 10821.9 10846.5 10701.3 10738.5 10752.4 10761.4 10777.6 10612.2 10648.4 10650.6 10670.1 10673.9 41786.4 42084.6 42093.8 42173.8 42204.4 4182.0 4230.2 4279.6 4372.7 4376.8 29408.6 29838.4 29860.3 30501.4 31033.0 4393.3 4451.1 4491.1 4530.4 4560.1 239809.0 240122.0 240445.0 241095.0 241239.0 53769.5 53784.7 53844.5 53856.7 53870.7 56669.1 56679.0 56774.4 56845.7 56873.0 15478.8 15685.5 15705.8 15711.5 15729.4 13518.7 13542.4 13648.4 13648.6 13791.2 12953.4 13370.5 13512.5 13588.5 13597.3 5526.4 5551.7 5700.2 5714.3 5753.6 1018.6 1027.7 1030.3 1034.3 1037.9 27604.4 28339.3 28370.0 28706.4 28747.7 1079.6 1079.6 1100.1 1114.8 1128.3 14649.1 15051.0 15162.0 15237.8 15415.9 310484.0 311965.0 312097.0 312512.0 312920.0 55925.0 56015.7 56038.7 56039.7 56147.0 1444.5 1499.4 1502.7 1513.6 1522.7 26170.7 27240.7 27687.7 27903.2 27904.9 42619.1 42660.4 42676.8 42694.0 42710.8 275221.0 276908.0 277402.0 277817.0 277942.0 33963.9 34744.5 34849.0 34889.8 34986.7 41469.6 41613.0 41695.2 42752.4 42802.6 32141.4 32753.2 32895.0 33015.0 33559.8 32030.7 32153.2 32672.3 32991.4 33343.5 36969.8 37632.8 37696.0 37991.0 38070.8 31185.8 31255.0 31277.2 31398.4 31863.5 25297.4 25317.0 25331.1 25379.6 25564.2 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#2] jquery.html Cycles:180 Average:38844.08 Median:2282.35 stddev:114778.57 (5029.0%) stddev-sans-first:115064.23 09:16:52 INFO - PROCESS | 3347 | Values: 389.6 446.1 452.9 468.4 472.3 19186.1 19441.5 21749.8 21792.9 22018.7 21143.4 21733.8 22160.9 22197.0 22384.0 6596.5 6634.5 6702.0 6761.1 6800.2 6506.7 6532.4 6539.6 6542.4 6603.8 4141.2 4452.7 4615.3 7502.1 7636.5 7375.7 7479.3 7622.7 7626.8 7632.5 7296.1 7308.6 7313.6 7330.5 7338.0 23720.9 24470.0 25627.2 25695.5 26027.0 3115.2 3174.7 3178.6 3182.5 3246.6 16254.8 16267.7 16275.8 16398.5 16678.9 2206.5 2267.8 2272.4 2292.3 2347.3 109753.0 115053.4 115067.0 115656.0 116871.0 14286.8 16385.7 18330.5 18447.4 18492.2 32603.0 32631.2 32687.2 32738.7 33105.5 9989.6 10097.5 10178.7 10229.5 10430.1 8477.4 8497.3 8497.3 8639.1 8643.8 9226.6 9235.9 9395.2 9626.4 9644.7 3324.4 3566.7 3652.6 3803.8 3871.5 953.8 968.9 969.7 972.9 975.9 20548.2 21591.5 21803.9 21835.3 22118.3 976.1 985.3 994.4 995.1 997.8 11342.8 11516.3 11558.9 12068.5 12113.8 583404.0 707384.0 714873.0 716048.0 749565.0 112705.0 120049.0 121673.0 123476.0 124992.0 1365.2 1404.5 1407.3 1419.7 1421.2 14918.6 19779.7 19897.2 19965.8 19990.3 51608.0 51745.0 52188.0 52610.5 52872.0 65832.7 65932.0 66716.0 67348.3 68117.3 12679.0 12785.6 12907.9 12934.7 12985.4 14522.8 14567.1 14568.2 14718.9 14799.7 12561.4 12645.6 12654.7 12889.9 12989.0 11125.9 11336.3 11483.5 11739.4 11760.8 12204.2 12315.8 12717.2 13066.5 13156.7 12695.9 12736.5 12777.1 12804.3 13099.4 7083.0 12439.0 12514.7 12854.2 13053.7 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#3] mootools.html Cycles:180 Average:7157.00 Median:2438.89 stddev:4601.25 (188.7%) stddev-sans-first:4594.78 09:16:52 INFO - PROCESS | 3347 | Values: 1537.2 1545.7 1568.5 1578.1 1580.3 10880.0 11565.9 11567.3 11576.1 11674.6 11275.7 11423.1 11595.8 11939.7 11946.5 2405.2 2431.6 2437.2 2437.5 2440.6 2392.7 2442.9 2482.8 2488.5 2492.1 2387.1 2432.8 2444.6 2453.7 2455.6 2316.7 2359.4 2363.6 2371.4 2435.1 2402.0 2429.6 2430.1 2432.2 2440.3 11278.1 11550.9 11565.2 11568.5 11574.3 5776.1 5877.4 5882.7 5887.7 5910.6 3474.5 3528.6 3569.4 3597.3 3602.7 1342.8 1350.7 1359.6 1391.5 1409.1 17342.4 17510.6 17623.2 17813.0 17884.1 4554.1 4700.0 4771.5 4797.1 4798.8 12933.2 12963.4 13022.8 13048.2 13070.2 5819.7 5828.0 5833.2 5833.6 5842.5 5422.8 5469.5 5512.6 5552.5 5596.6 3992.2 4090.9 4100.5 4133.7 4175.4 1033.1 1036.3 1036.6 1054.8 1055.1 946.5 977.6 978.6 981.7 993.2 6794.3 6869.9 6875.4 6909.7 7048.2 1009.2 1037.5 1039.3 1039.5 1074.0 4480.2 4750.6 4905.7 4929.8 5046.2 14339.6 14383.6 14586.1 14710.9 14910.6 14308.0 14481.4 14611.1 14675.3 14730.3 10577.5 10655.8 10676.6 10746.4 10788.6 6815.6 6873.6 6916.3 6944.8 6967.6 12766.5 12913.4 13109.1 13121.9 13247.1 13128.4 13329.9 13330.7 13403.3 13481.5 9151.9 9269.5 9360.2 9373.5 9375.2 10712.0 10913.3 10932.5 11039.2 11097.7 8955.8 9166.2 9224.2 9234.5 9507.3 9147.9 9160.3 9183.3 9219.4 9482.4 8474.4 8607.7 8608.6 8635.6 8641.8 6348.8 6354.1 6356.0 6445.6 6496.5 6036.5 6134.1 6151.6 6242.7 6391.5 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#4] prototype.html Cycles:180 Average:4758.78 Median:5243.84 stddev:1267.19 (24.2%) stddev-sans-first:1227.96 09:16:52 INFO - PROCESS | 3347 | Values: 408.5 426.8 428.7 433.4 437.8 5134.6 5188.0 5219.7 5225.8 5267.3 4803.4 5168.0 5180.2 5185.7 5201.6 4271.6 4280.8 4284.6 4292.4 4294.7 4252.8 4261.1 4263.5 4282.4 4293.8 4282.7 4302.5 4310.5 4326.9 4384.8 4089.2 4242.5 4256.4 4280.4 4314.1 4047.2 4050.5 4058.7 4060.5 4086.1 5070.7 5077.8 5102.1 5113.9 5117.4 4869.0 5030.5 5036.4 5040.4 5051.3 5441.4 5457.5 5478.6 5499.2 5508.9 4496.4 4552.2 4552.7 4574.9 4591.7 5433.3 5653.5 5655.7 5676.6 5708.3 4656.3 4676.9 4678.8 4685.9 4689.7 4755.7 4770.3 4771.5 4778.6 4784.8 4935.9 4937.5 5031.0 5065.9 5070.3 5413.8 5424.2 5444.7 5445.3 5468.8 1627.7 1639.5 1639.9 1646.4 1649.4 1235.4 1277.0 1282.5 1284.5 1307.6 5117.7 5390.3 5408.5 5450.8 5462.9 5564.5 5582.1 5600.4 5603.4 5610.7 5377.4 5405.3 5406.7 5419.4 5437.7 2819.5 2921.2 2939.0 2942.0 2943.5 5697.6 5720.6 5735.4 5744.9 5750.8 5444.4 5585.2 5702.4 5703.7 5737.8 5327.8 5586.9 5828.4 5833.8 5842.5 5611.4 5619.8 5624.2 5628.3 5640.0 5261.9 5496.4 5564.9 5591.3 5628.9 5763.4 5772.7 5781.9 5790.4 5798.8 4631.2 4680.3 4719.0 4762.8 4783.4 5443.5 5555.3 5605.4 5606.9 5690.6 5458.4 5459.3 5482.6 5490.9 5524.9 5396.8 5488.3 5516.4 5553.6 5573.8 5386.7 5443.4 5465.6 5469.4 5492.6 5464.6 5467.2 5498.5 5507.5 5568.5 5129.5 5337.9 5383.7 5409.6 5467.2 09:16:52 INFO - PROCESS | 3347 | 09:16:52 INFO - PROCESS | 3347 | [#5] yui.html Cycles:180 Average:18137.38 Median:23495.59 stddev:22086.06 (94.0%) stddev-sans-first:22109.71 09:16:52 INFO - PROCESS | 3347 | Values: 813.8 844.9 905.7 927.5 934.2 15293.4 15920.7 16207.0 16248.5 16471.4 15716.3 15858.4 16004.2 16566.7 16591.5 863.6 884.5 887.0 887.3 889.0 868.4 890.9 898.8 904.0 906.0 923.2 924.1 924.3 925.3 925.9 918.8 919.4 920.3 920.3 920.7 677.7 679.3 679.4 680.0 680.2 17391.1 17426.6 17557.2 18504.9 18681.6 16064.6 16272.2 16378.3 16412.6 16595.2 13404.3 13529.3 13609.3 13713.0 13830.4 4044.2 4091.8 4104.8 4116.5 4186.7 88164.0 88255.0 88740.6 89152.0 91539.0 11322.5 11790.4 12699.6 13049.2 13223.1 20900.5 21499.5 21503.6 21506.5 23859.6 9754.6 9892.5 9959.8 10025.7 10052.0 5109.9 5178.3 5270.1 5323.8 5338.5 4128.2 4270.6 4273.7 4279.0 4281.4 676.0 676.4 684.1 691.2 698.3 740.6 753.6 758.5 769.4 778.1 11253.2 11793.0 11846.3 11846.5 12123.5 746.2 749.5 749.9 766.4 773.9 5578.5 5585.1 5668.9 5721.3 5731.2 73284.6 73465.0 73525.0 75811.0 81685.6 46970.0 60988.7 62970.7 64996.0 69462.7 59466.7 59719.1 60172.7 60187.7 61387.4 10949.7 11331.6 11368.1 11580.6 11604.0 41938.8 42392.8 42720.6 42942.4 43523.3 49849.0 49922.3 50102.5 50787.5 52371.2 13685.6 13807.7 13869.0 13912.8 14326.0 16156.7 16249.7 16563.5 16651.8 16818.8 15395.9 15450.9 15547.6 16552.0 16606.1 14048.6 14324.6 14554.0 15221.4 15255.8 15024.1 15408.5 16002.3 16182.8 16222.1 10567.8 10675.5 11213.4 11333.7 11352.6 11543.5 11722.9 11828.8 11970.4 11984.3 09:16:52 INFO - PROCESS | 3347 | -------- Summary: end -------- 09:16:52 INFO - PROCESS | 3347 | 09:16:53 INFO - TEST-INFO | 3347: exit 0 09:16:53 INFO - TEST-OK | dromaeo_css | took 1115156ms 09:16:53 INFO - TEST-START | kraken 09:16:53 INFO - operating with platform_type : linux_ 09:16:53 INFO - Initialising browser for kraken test... 09:16:53 INFO - TEST-INFO | started process 3671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEN0cP/profile http://localhost:54919/getInfo.html) 09:16:57 INFO - PROCESS | 3671 | __metrics Screen width/height:1600/1200 09:16:57 INFO - PROCESS | 3671 | colorDepth:24 09:16:57 INFO - PROCESS | 3671 | Browser inner width/height: 1024/697 09:16:57 INFO - PROCESS | 3671 | __metrics 09:16:58 INFO - PROCESS | 3671 | 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" 09:16:58 INFO - PROCESS | 3671 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:59 INFO - TEST-INFO | 3671: exit 0 09:16:59 INFO - Browser initialized. 09:16:59 INFO - Running cycle 1/1 for kraken test... 09:16:59 INFO - TEST-INFO | started process 3763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEN0cP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:11 INFO - PROCESS | 3763 | RSS: Main: 139997184 09:17:11 INFO - PROCESS | 3763 | 09:17:13 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54919/tests/kraken/driver.html?testName=audio-beat-detection) 09:17:14 INFO - PROCESS | 3763 | RSS: Main: 184643584 09:17:14 INFO - PROCESS | 3763 | 09:17:17 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54919/tests/kraken/driver.html?testName=audio-dft) 09:17:17 INFO - PROCESS | 3763 | RSS: Main: 175214592 09:17:17 INFO - PROCESS | 3763 | 09:17:20 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54919/tests/kraken/driver.html?testName=audio-fft) 09:17:21 INFO - PROCESS | 3763 | RSS: Main: 266317824 09:17:21 INFO - PROCESS | 3763 | 09:17:23 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54919/tests/kraken/driver.html?testName=audio-oscillator) 09:17:23 INFO - PROCESS | 3763 | RSS: Main: 172761088 09:17:23 INFO - PROCESS | 3763 | 09:17:25 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54919/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:17:26 INFO - PROCESS | 3763 | RSS: Main: 174583808 09:17:26 INFO - PROCESS | 3763 | 09:17:29 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54919/tests/kraken/driver.html?testName=imaging-darkroom) 09:17:29 INFO - PROCESS | 3763 | RSS: Main: 213962752 09:17:29 INFO - PROCESS | 3763 | 09:17:33 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54919/tests/kraken/driver.html?testName=imaging-desaturate) 09:17:33 INFO - PROCESS | 3763 | RSS: Main: 212758528 09:17:33 INFO - PROCESS | 3763 | 09:17:36 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54919/tests/kraken/driver.html?testName=json-parse-financial) 09:17:37 INFO - PROCESS | 3763 | RSS: Main: 211218432 09:17:37 INFO - PROCESS | 3763 | 09:17:38 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54919/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:39 INFO - PROCESS | 3763 | RSS: Main: 173293568 09:17:39 INFO - PROCESS | 3763 | 09:17:41 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:41 INFO - PROCESS | 3763 | RSS: Main: 180305920 09:17:41 INFO - PROCESS | 3763 | 09:17:43 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:44 INFO - PROCESS | 3763 | RSS: Main: 189812736 09:17:44 INFO - PROCESS | 3763 | 09:17:46 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:47 INFO - PROCESS | 3763 | RSS: Main: 198713344 09:17:47 INFO - PROCESS | 3763 | 09:17:50 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:50 INFO - PROCESS | 3763 | RSS: Main: 195551232 09:17:50 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | Cycle 1(1): loaded http://localhost:54919/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54919/tests/kraken/driver.html?testName=ai-astar) 09:17:52 INFO - PROCESS | 3763 | RSS: Main: 246255616 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | __start_tp_report 09:17:52 INFO - PROCESS | 3763 | _x_x_mozilla_page_load 09:17:52 INFO - PROCESS | 3763 | _x_x_mozilla_page_load_details 09:17:52 INFO - PROCESS | 3763 | |i|pagename|runs| 09:17:52 INFO - PROCESS | 3763 | |0;ai-astar;103;112;112;113;113;113;113;112;113;111 09:17:52 INFO - PROCESS | 3763 | |1;audio-beat-detection;147;114;115;159;116;116;115;114;132;114 09:17:52 INFO - PROCESS | 3763 | |2;audio-dft;162;161;161;162;160;162;161;161;161;161 09:17:52 INFO - PROCESS | 3763 | |3;audio-fft;75;75;75;106;76;76;76;77;97;75 09:17:52 INFO - PROCESS | 3763 | |4;audio-oscillator;82;82;121;81;82;82;94;82;82;102 09:17:52 INFO - PROCESS | 3763 | |5;imaging-gaussian-blur;113;113;113;114;113;114;113;113;113;113 09:17:52 INFO - PROCESS | 3763 | |6;imaging-darkroom;147;146;147;146;147;146;147;147;146;146 09:17:52 INFO - PROCESS | 3763 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;93;95 09:17:52 INFO - PROCESS | 3763 | |8;json-parse-financial;56;54;54;55;56;55;56;54;57;55 09:17:52 INFO - PROCESS | 3763 | |9;json-stringify-tinderbox;52;53;53;53;52;52;52;52;52;52 09:17:52 INFO - PROCESS | 3763 | |10;stanford-crypto-aes;88;76;76;80;76;76;79;84;76;77 09:17:52 INFO - PROCESS | 3763 | |11;stanford-crypto-ccm;122;121;120;121;121;119;118;118;164;121 09:17:52 INFO - PROCESS | 3763 | |12;stanford-crypto-pbkdf2;156;160;156;155;160;159;162;163;162;159 09:17:52 INFO - PROCESS | 3763 | |13;stanford-crypto-sha256-iterative;60;60;59;68;60;61;59;59;58;57 09:17:52 INFO - PROCESS | 3763 | __end_tp_report 09:17:52 INFO - PROCESS | 3763 | __start_cc_report 09:17:52 INFO - PROCESS | 3763 | _x_x_mozilla_cycle_collect,1694 09:17:52 INFO - PROCESS | 3763 | __end_cc_report 09:17:52 INFO - PROCESS | 3763 | __startTimestamp1491495472627__endTimestamp 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | ------- Summary: start ------- 09:17:52 INFO - PROCESS | 3763 | Number of tests: 14 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:3.06 (2.7%) stddev-sans-first:0.73 09:17:52 INFO - PROCESS | 3763 | Values: 103.0 112.0 112.0 113.0 113.0 113.0 113.0 112.0 113.0 111.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:116.00 stddev:16.36 (14.1%) stddev-sans-first:15.12 09:17:52 INFO - PROCESS | 3763 | Values: 147.0 114.0 115.0 159.0 116.0 116.0 115.0 114.0 132.0 114.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 09:17:52 INFO - PROCESS | 3763 | Values: 162.0 161.0 161.0 162.0 160.0 162.0 161.0 161.0 161.0 161.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#3] audio-fft Cycles:10 Average:80.80 Median:76.00 stddev:11.13 (14.6%) stddev-sans-first:11.61 09:17:52 INFO - PROCESS | 3763 | Values: 75.0 75.0 75.0 106.0 76.0 76.0 76.0 77.0 97.0 75.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:82.00 stddev:13.23 (16.1%) stddev-sans-first:13.79 09:17:52 INFO - PROCESS | 3763 | Values: 82.0 82.0 121.0 81.0 82.0 82.0 94.0 82.0 82.0 102.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:17:52 INFO - PROCESS | 3763 | Values: 113.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:17:52 INFO - PROCESS | 3763 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:17:52 INFO - PROCESS | 3763 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 95.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.50 stddev:1.03 (1.9%) stddev-sans-first:1.05 09:17:52 INFO - PROCESS | 3763 | Values: 56.0 54.0 54.0 55.0 56.0 55.0 56.0 54.0 57.0 55.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#9] json-stringify-tinderbox Cycles:10 Average:52.30 Median:52.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 09:17:52 INFO - PROCESS | 3763 | Values: 52.0 53.0 53.0 53.0 52.0 52.0 52.0 52.0 52.0 52.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:4.16 (5.3%) stddev-sans-first:2.77 09:17:52 INFO - PROCESS | 3763 | Values: 88.0 76.0 76.0 80.0 76.0 76.0 79.0 84.0 76.0 77.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:121.00 stddev:13.95 (11.5%) stddev-sans-first:14.76 09:17:52 INFO - PROCESS | 3763 | Values: 122.0 121.0 120.0 121.0 121.0 119.0 118.0 118.0 164.0 121.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.20 Median:160.00 stddev:2.78 (1.7%) stddev-sans-first:2.70 09:17:52 INFO - PROCESS | 3763 | Values: 156.0 160.0 156.0 155.0 160.0 159.0 162.0 163.0 162.0 159.0 09:17:52 INFO - PROCESS | 3763 | 09:17:52 INFO - PROCESS | 3763 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:3.00 (5.0%) stddev-sans-first:3.18 09:17:52 INFO - PROCESS | 3763 | Values: 60.0 60.0 59.0 68.0 60.0 61.0 59.0 59.0 58.0 57.0 09:17:52 INFO - PROCESS | 3763 | -------- Summary: end -------- 09:17:52 INFO - PROCESS | 3763 | 09:17:53 INFO - TEST-INFO | 3763: exit 0 09:17:53 INFO - TEST-OK | kraken | took 60003ms 09:17:53 INFO - SUITE-END | took 1175s 09:17:53 INFO - Completed test suite (00:19:35) 09:17:53 INFO - javascript benchmark 09:17:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7840.103443498012, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.882474113406, 3391.4573668213084, 3406.9488957665626, 3429.074149979504, 3448.086257141858, 5626.043572592659, 5698.0, 5707.3721890592005, 5722.685252311121, 5727.312722473299, 5754.65472071676, 5787.363390027093, 5795.449432303924, 5795.507381872535, 5806.042003069489, 5159.174532074869, 5160.174372100465, 5201.895962080756, 5204.635675502716, 5228.294180285669, 5025.899482010358, 5075.873103172414, 5234.502722241381, 5253.973730131344, 5296.920546191791, 5068.645194836345, 5112.309838171855, 5160.948390516103, 5175.24958880962, 5187.844364669066, 5238.423773384925, 5250.527452529291, 5256.290400795881, 5259.342582177228, 5278.736063196825, 5040.017196646655, 5115.2327150927285, 5178.352705911761, 5225.738713064369, 5234.162533994542, 5635.098384258499, 5645.943540564583, 5721.599488035839, 5722.799702010451, 5726.856828579277, 6169.321374648785, 6210.347913469066, 6214.906776398358, 6222.222222222223, 6224.937750622481, 6238.585215421324, 6263.749450022039, 6274.121622972787, 6276.435120839146, 6280.246370435531, 5636.154576813511, 5679.744411501492, 5788.0, 5810.564207684441, 5921.851953701106, 6346.270178929482, 6351.555391122577, 6353.174087368612, 6354.3010268870385, 6354.3963323484195, 6072.878542429126, 6121.112438696364, 6131.448169664752, 6132.018876979661, 6135.877282454326, 5914.556408269311, 5943.61366511184, 6031.698415079316, 6053.122297266872, 6219.129321894939, 6074.635521868702, 6076.392360763888, 6083.847903802441, 6114.602550834182, 6128.785492507741, 5895.852603684943, 5974.283086029617, 6018.518518518508, 6076.240469941257, 6127.142200091991, 4661.906761864744, 4743.715377077387, 4759.809607615726, 4761.047790441926, 4779.928301075487, 4112.691548133902, 4123.525794533607, 4155.771432571177, 4224.281872081692, 4224.8732538023905, 5919.052951527821, 5975.103734439782, 5978.0733986231335, 5979.0, 6011.609245399035, 6228.0, 6237.594556353823, 6258.43674069336, 6259.311475737665, 6259.436650701458, 5780.826575202751, 5797.246357973437, 5964.194833697482, 5969.343372229051, 5981.252343457068, 5172.405173405106, 5187.0, 5263.6315457918345, 5300.575953923677, 5311.946880531223, 6465.741370345134, 6471.773487927994, 6481.611103333721, 6488.124103246096, 6489.221293444912, 5914.319853216935, 6179.590289072633, 6223.937760622336, 6225.408586184305, 6225.439710426083, 6292.748290068529, 6344.1118243445035, 6384.521160912857, 6421.550491465552, 6496.317886621837, 6151.231096112986, 6165.84585385369, 6166.691665416801, 6175.536834737323, 6176.474999624902, 6275.6862156892885, 6277.0, 6278.654673992792, 6280.152179455898, 6282.937170628235, 5781.0, 5893.204417403767, 5988.0, 5997.220361353171, 6101.115338276014, 6038.51691864641, 6058.4850287724275, 6083.726232319645, 6096.695165241809, 6113.480354169946, 5863.677497737665, 6066.181065556093, 6070.666113363807, 6078.756849725962, 6079.483243924316, 5935.703214839327, 5999.850003749942, 6025.728842202024, 6067.696615169136, 6136.417040381157, 5960.433758792908, 5964.373740757158, 5965.612235204698, 5970.164177015135, 5997.730102145327], "value": 5687.641212783192, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.3139174742731, 816.1919699497497, 839.5927974932157, 905.0858632780894, 924.6024209589874, 31291.53062704061, 43602.34596481051, 44072.55927440725, 44148.896277593034, 44182.33726494105, 45100.77449612747, 45395.0, 45515.0, 45530.0, 45550.54449455505, 7836.647350869224, 7994.440389172761, 9294.163525282705, 9444.574994125282, 9448.0, 10473.73815654611, 10697.411642359668, 10979.725506862313, 11005.0, 11009.449527523591, 10796.190285728562, 10800.13598912089, 10808.78382432351, 10821.891781082168, 10846.511906964206, 10701.250912436133, 10738.463076846165, 10752.408617526033, 10761.354318740901, 10777.622783202629, 10612.204084693602, 10648.361098334048, 10650.573977040909, 10670.146388288918, 10673.946630266799, 41786.373204401956, 42084.579154208375, 42093.78953105215, 42173.789131054145, 42204.36693449601, 4182.025932733848, 4230.153969206141, 4279.550647182064, 4372.737635741833, 4376.824927002916, 29408.55887161673, 29838.403231935456, 29860.253493662614, 30501.389972200654, 31033.0, 4393.319035549495, 4451.109778044404, 4491.1466821304175, 4530.411046563926, 4560.1335746208115, 239809.0, 240122.0, 240445.0, 241095.0, 241239.0, 53769.462305376444, 53784.73107634437, 53844.461555384725, 53856.73071634695, 53870.730646346514, 56669.14996275059, 56679.0, 56774.43225567774, 56845.71577142088, 56873.0, 15478.845211547965, 15685.529434116996, 15705.842941570667, 15711.450099246471, 15729.44946926852, 13518.729625407437, 13542.390592423168, 13648.385822638005, 13648.590542283748, 13791.241481718602, 12953.352332383532, 13370.532031378854, 13512.527061552995, 13588.456461741618, 13597.32013399326, 5526.364468086141, 5551.666899986014, 5700.201971723962, 5714.314282286069, 5753.568482363839, 1018.6332920148741, 1027.732789474742, 1030.3096925060227, 1034.3070143004206, 1037.9273450858368, 27604.44791104207, 28339.291517712223, 28370.0, 28706.425871482454, 28747.712522874503, 1079.56957031933, 1079.5951518180682, 1100.0979197058334, 1114.849495318138, 1128.3060917535656, 14649.12105273687, 15051.0, 15162.0, 15237.847621523642, 15415.922920385327, 310484.0, 311965.0, 312097.0, 312512.0, 312920.0, 55925.0, 56015.71992140013, 56038.71980640071, 56039.719801401545, 56147.0, 1444.4727674398769, 1499.400239904047, 1502.7370210213169, 1513.5988962924835, 1522.665013696985, 26170.73829261683, 27240.727592724612, 27687.723122768515, 27903.16290511288, 27904.860475697493, 42619.147617048104, 42660.36009459923, 42676.78661606672, 42694.0, 42710.786446068814, 275221.0, 276908.0, 277402.0, 277817.0, 277942.0, 33963.89848564852, 34744.47883281804, 34849.0, 34889.82555087208, 34986.65013349834, 41469.58530414778, 41613.0, 41695.166096678506, 42752.35871461993, 42802.57197427986, 32141.35717285688, 32753.181170469976, 32895.0, 33015.0, 33559.83220083884, 32030.679693203703, 32153.196170094998, 32672.34655306833, 32991.41030763046, 33343.49984750279, 36969.81515092407, 37632.81183594064, 37696.0, 37991.0, 38070.809645951595, 31185.8440707795, 31255.030772076618, 31277.218069548442, 31398.372032559677, 31863.450923925568, 25297.367565811, 25317.0, 25331.113411030525, 25379.61930571006, 25564.23307300784], "value": 18988.267982563244, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.64542266537455, 446.14785759199924, 452.87772301478583, 468.4098036474044, 472.275057786298, 19186.136623851926, 19441.51396215095, 21749.782502174974, 21792.89103554484, 22018.669719954214, 21143.365699029015, 21733.782662173373, 22160.88919555404, 22197.0, 22384.0, 6596.505262105361, 6634.469242460604, 6702.0, 6761.087253220826, 6800.183977922631, 6506.674666266667, 6532.444742196919, 6539.574927629689, 6542.41118299353, 6603.801885943405, 4141.213169497801, 4452.666050046259, 4615.261558150696, 7502.099748030244, 7636.541807491541, 7375.668094935741, 7479.289467500633, 7622.656980435893, 7626.809329766773, 7632.542047477169, 7296.124465064173, 7308.598027108507, 7313.597752123631, 7330.450216233804, 7338.046054012944, 23720.88139559291, 24470.0, 25627.231183064538, 25695.48609027828, 26027.0, 3115.190050586841, 3174.6666600006897, 3178.618565772099, 3182.5067114597273, 3246.5779448671756, 16254.83745162545, 16267.674646507123, 16275.83724162755, 16398.508044758677, 16678.916605416896, 2206.4925067234467, 2267.8299127565497, 2272.409173614872, 2292.289390289016, 2347.33101066197, 109753.0, 115053.42473287664, 115067.0, 115656.0, 116871.0, 14286.82638226646, 16385.672286554203, 18330.541736456697, 18447.354342597944, 18492.167852446673, 32603.02190934276, 32631.184220394207, 32687.18282042968, 32738.67261327404, 33105.50341744876, 9989.550470228856, 10097.545610447547, 10178.745531361776, 10229.48852557384, 10430.113440357503, 8477.448965817326, 8497.277731392776, 8497.320214382959, 8639.092895246034, 8643.827123457622, 9226.630934762668, 9235.861462078074, 9395.201407880406, 9626.422414655142, 9644.662436814679, 3324.4182268102986, 3566.732495062881, 3652.579953305351, 3803.7527560708463, 3871.4773505576386, 953.8092381523584, 968.9467079310706, 969.6557722008727, 972.9270304727174, 975.9072888075622, 20548.178072877217, 21591.460213494473, 21803.890980544995, 21835.344939651837, 22118.33644990653, 976.0873583199731, 985.2905907746411, 994.4033579852176, 995.144176008632, 997.7804882925744, 11342.773144537063, 11516.251443656303, 11558.94220528892, 12068.456919438471, 12113.757724845455, 583404.0, 707384.0, 714873.0, 716048.0, 749565.0, 112705.0, 120049.0, 121673.0, 123476.0, 124992.0, 1365.2422905287463, 1404.487362112842, 1407.289318893952, 1419.6947656253749, 1421.1970236816167, 14918.552443426715, 19779.70330445016, 19897.204111835363, 19965.800341996393, 19990.300339488047, 51608.0, 51745.0, 52188.0, 52610.473895260555, 52872.0, 65832.67083664551, 65932.0, 66716.0, 67348.3265167342, 68117.3188268111, 12679.049071319872, 12785.61643150707, 12907.935460322638, 12934.676633084247, 12985.350732463528, 14522.782158267846, 14567.053141545766, 14568.198749068903, 14718.852811471748, 14799.704005920037, 12561.43473543711, 12645.620631381073, 12654.683632909251, 12889.871101289242, 12989.0, 11125.888741112485, 11336.263142895685, 11483.48324325424, 11739.413029348669, 11760.82358764602, 12204.206726562745, 12315.753684926072, 12717.173383730027, 13066.477340906258, 13156.671083222996, 12695.873041269839, 12736.490540378281, 12777.105602607728, 12804.29576373271, 13099.410526526139, 7083.0, 12439.0, 12514.687132821753, 12854.228746275254, 13053.673658158623], "value": 11508.83059472907, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.2083377060808, 1545.6908618276348, 1568.4980806142034, 1578.1083687716443, 1580.2572790788327, 10880.0, 11565.942170289158, 11567.305961642296, 11576.073914086874, 11674.591389301377, 11275.66173014811, 11423.143264255194, 11595.768084638303, 11939.701507462318, 11946.522139114446, 2405.1581946318825, 2431.63525471179, 2437.1591800828687, 2437.5124975004983, 2440.5973014452684, 2392.724836643782, 2442.8534287942693, 2482.7889629381525, 2488.4774197418565, 2492.102842976527, 2387.128698025217, 2432.8297019208662, 2444.633305004255, 2453.7055553333626, 2455.631655251718, 2316.745158032615, 2359.4101474631343, 2363.598188307983, 2371.4071482129466, 2435.0503303711566, 2402.0, 2429.5748244057395, 2430.0887167312258, 2432.2338463383976, 2440.2679196241234, 11278.097752179807, 11550.942245288803, 11565.248258863232, 11568.479418426192, 11574.305541667527, 5776.104703770922, 5877.4122587740885, 5882.6764527950945, 5887.676177810219, 5910.645361278294, 3474.5483087198754, 3528.576570811519, 3569.446735755962, 3597.2733088117852, 3602.6937710294656, 1342.8455727591256, 1350.6825895914453, 1359.6125104345313, 1391.5268808605124, 1409.105218186459, 17342.393016244496, 17510.64978700419, 17623.206955687026, 17813.0, 17884.105794710213, 4554.0891821635805, 4699.953000469952, 4771.4512831024185, 4797.136515427187, 4798.832040878552, 12933.224006559636, 12963.416646250942, 13022.804657930139, 13048.217106973612, 13070.150440221356, 5819.6614778600315, 5828.0, 5833.183354330397, 5833.649981001154, 5842.503387212049, 5422.783088676409, 5469.453054694578, 5512.5589952803675, 5552.52803511706, 5596.552275817925, 3992.201559688016, 4090.9181816363507, 4100.5489396166995, 4133.6693064554765, 4175.415441838145, 1033.1476531861244, 1036.290141253244, 1036.6423583863555, 1054.752133248686, 1055.1189756553365, 946.4747065378643, 977.6333874796951, 978.6330126202674, 981.7398389426808, 993.1607791416242, 6794.286599906938, 6869.896951545731, 6875.3812156906115, 6909.689063992032, 7048.224695283515, 1009.1976878381557, 1037.5486663301488, 1039.3296323871061, 1039.4958445154093, 1073.973150671224, 4480.215962206601, 4750.619950404029, 4905.656604037683, 4929.778159982738, 5046.243063540498, 14339.569812905629, 14383.640408989859, 14586.124832510084, 14710.852891471162, 14910.627234319229, 14308.0, 14481.420743170365, 14611.123332600078, 14675.266236688123, 14730.263486825615, 10577.524011419504, 10655.786884262272, 10676.57293708243, 10746.355218686904, 10788.568457261621, 6815.556988795713, 6873.5875847449315, 6916.273791252047, 6944.756933507303, 6967.616781077089, 12766.489340426278, 12913.418896149507, 13109.082364234411, 13121.868781312065, 13247.138935969131, 13128.409221585243, 13329.933605311358, 13330.666733331744, 13403.262820544574, 13481.460741570227, 9151.86272205904, 9269.490178040272, 9360.20438262728, 9373.484458354857, 9375.203107735919, 10712.035916767529, 10913.290636108944, 10932.508037138188, 11039.227254092137, 11097.722556936142, 8955.776105597412, 9166.17504424605, 9224.215941645036, 9234.492102934402, 9507.286953478655, 9147.86278205814, 9160.267178625561, 9183.311251656287, 9219.44683319003, 9482.38364506305, 8474.449160804528, 8607.698730544402, 8608.569571521524, 8635.568221589021, 8641.827163456821, 6348.809535713936, 6354.110424540476, 6355.968220158869, 6445.613263204035, 6496.545241833026, 6036.456718895321, 6134.079888016833, 6151.6001459904965, 6242.719077641608, 6391.520635952229], "value": 5399.938591056159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.4751094843123, 426.79087247248845, 428.70317290197147, 433.3932494507689, 437.78110944527737, 5134.589232861372, 5187.9740601297035, 5219.660722053069, 5225.764840582174, 5267.315249017632, 4803.375561177042, 5168.0180765654495, 5180.222966555009, 5185.662931909433, 5201.5838732901375, 4271.594198551133, 4280.8013756148175, 4284.635805956497, 4292.441982542266, 4294.742315461067, 4252.787360631972, 4261.105167914741, 4263.467066616673, 4282.443282373287, 4293.849715259967, 4282.665947058845, 4302.483701955754, 4310.482742070956, 4326.913461730764, 4384.780760961939, 4089.243489954353, 4242.53332133465, 4256.361545768129, 4280.379344994958, 4314.137172565468, 4047.1500984792933, 4050.453188819501, 4058.695597830145, 4060.5127384714024, 4086.1419101988618, 5070.6957582545165, 5077.847664570068, 5102.081625307444, 5113.948860511385, 5117.360329958755, 4868.951310486886, 5030.471800460936, 5036.388355726169, 5040.42035165957, 5051.333060090162, 5441.428649991773, 5457.536109430703, 5478.58910581708, 5499.230107784913, 5508.944910550883, 4496.4487251898045, 4552.180607490651, 4552.704074235197, 4574.931376029363, 4591.655625828076, 5433.293671822677, 5653.4911857932575, 5655.745491452894, 5676.574256930706, 5708.257926469574, 4656.278276867091, 4676.883077923011, 4678.836240731626, 4685.882852928636, 4689.718616882998, 4755.690880092783, 4770.284457331359, 4771.4512831024185, 4778.5699287063635, 4784.784684689197, 4935.90128197434, 4937.530934561211, 5031.0, 5065.924011139836, 5070.340855688737, 5413.837584872382, 5424.213489044067, 5444.727763611803, 5445.264889239981, 5468.7539060742365, 1627.7314243149985, 1639.5327331710405, 1639.877009224313, 1646.4237516869, 1649.4062137630444, 1235.407004637761, 1276.95289862312, 1282.5318758653025, 1284.4926254129566, 1307.6073981209981, 5117.71852548106, 5390.272313237741, 5408.538535337388, 5450.809221677222, 5462.918056229159, 5564.4713752193475, 5582.078956972054, 5600.355959064678, 5603.411641777555, 5610.691411972299, 5377.418838957323, 5405.270288511079, 5406.675599464044, 5419.430959749248, 5437.673739575638, 2819.4502072095743, 2921.182069020678, 2938.985305073461, 2941.955870661942, 2943.484890144216, 5697.601167918206, 5720.596245234079, 5735.369109397963, 5744.856378590569, 5750.769969201185, 5444.40111587725, 5585.218069470277, 5702.372738998707, 5703.686297253608, 5737.770489180386, 5327.786888524493, 5586.91619625706, 5828.417158284223, 5833.774907269521, 5842.503387212049, 5611.410801865745, 5619.8198378339375, 5624.156376543551, 5628.296462942132, 5640.0, 5261.921071184011, 5496.395396506301, 5564.860878478071, 5591.27313449249, 5628.85927851807, 5763.394843541368, 5772.7402266898935, 5781.94218057814, 5790.378693965697, 5798.82603521895, 4631.166390049689, 4680.344751734828, 4719.0, 4762.761861906822, 4783.449903261169, 5443.537299329443, 5555.250041244381, 5605.383407825218, 5606.943930560642, 5690.630109042899, 5458.426865179099, 5459.344878614433, 5482.643628164156, 5490.917636235539, 5524.922640085145, 5396.83809485716, 5488.341399032141, 5516.393196748435, 5553.639358357228, 5573.770491803311, 5386.676799392049, 5443.374011988672, 5465.578949473086, 5469.42571030052, 5492.6268432891775, 5464.590155738256, 5467.152591348347, 5498.4981833266565, 5507.531859791802, 5568.49883510486, 5129.487051294841, 5337.9466205339, 5383.650062745909, 5409.648372855751, 5467.17992301158], "value": 4394.717743288471, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.8006188483819, 844.923956843884, 905.6694306578099, 927.536231884058, 934.2385955446313, 15293.388264469408, 15920.681586368266, 16207.027578345293, 16248.51254462368, 16471.423500177498, 15716.292766825492, 15858.36566537337, 16004.199790010482, 16566.66866662666, 16591.50225493234, 863.5941107679396, 884.5046773806689, 886.9512176830272, 887.3211992825494, 888.9911100889005, 868.444195714743, 890.9242714369286, 898.8157427727333, 904.0146240597747, 905.9637614495413, 923.201430762389, 924.1082355526916, 924.306769922558, 925.2967744514184, 925.8703781470599, 918.7703074231442, 919.3702313914989, 920.2637889688256, 920.3327587499076, 920.7237828651412, 677.6848765324098, 679.2901418018183, 679.3851564334285, 679.9830004249884, 680.1566058087935, 17391.1304434779, 17426.564335891577, 17557.20992555338, 18504.90747546267, 18681.626367472574, 16064.59838504035, 16272.18639068042, 16378.344866205338, 16412.589685257844, 16595.17024148788, 13404.329783510882, 13529.32353382327, 13609.31953402326, 13713.0400871939, 13830.446782128703, 4044.2315959967514, 4091.754494730326, 4104.753714777093, 4116.526599441043, 4186.727862688946, 88164.0, 88255.0, 88740.55629721875, 89152.0, 91539.0, 11322.490487928064, 11790.410479475991, 12699.619011429671, 13049.217046977212, 13223.140495867738, 20900.477488062617, 21499.46251343729, 21503.56992860134, 21506.462338441663, 23859.64210536843, 9754.609815607439, 9892.505374731234, 9959.751006224902, 10025.749356266151, 10052.0, 5109.923351149736, 5178.326817513775, 5270.130428479258, 5323.787048518094, 5338.492843179892, 4128.2156390285745, 4270.61564459194, 4273.67947403946, 4279.037216626234, 4281.422008028876, 676.0400231670941, 676.3709749932511, 684.0628339175362, 691.1671435919704, 698.3156506623537, 740.6481921087441, 753.5817621220166, 758.4956004257217, 769.4267770511005, 778.1246098139593, 11253.212275140662, 11793.0, 11846.289222646668, 11846.466908989116, 12123.454444550016, 746.1829296919864, 749.539033494397, 749.865024295632, 766.3945483068425, 773.8839174123814, 5578.497935185853, 5585.106382978704, 5668.943310566924, 5721.284839395075, 5731.226284451629, 73284.63357683178, 73465.0, 73525.0, 75811.0, 81685.59157204175, 46970.0, 60988.69505652532, 62970.685146573975, 64996.0, 69462.65268673726, 59466.702666487254, 59719.104213437706, 60172.69913650404, 60187.69906150441, 61387.38612613906, 10949.721781592283, 11331.603393881174, 11368.147388945697, 11580.594679186188, 11604.0, 41938.79030604827, 42392.788036059625, 42720.572794272906, 42942.35586466268, 43523.34714979214, 49849.0, 49922.25116623326, 50102.49897500978, 50787.49212507828, 52371.21443178279, 13685.589432317047, 13807.723845523235, 13869.0, 13912.791308130183, 14326.0, 16156.67686646237, 16249.675006499567, 16563.503094907173, 16651.750223746894, 16818.831811682216, 15395.923020384826, 15450.922745386652, 15547.611309717347, 16552.0, 16606.086665233044, 14048.578542643738, 14324.57026289213, 14554.0, 15221.391144354102, 15255.771163432335, 15024.098554086353, 15408.460703875311, 16002.279897404413, 16182.757258641364, 16222.10778407199, 10567.841482377617, 10675.466226688479, 11213.439328033728, 11333.659990200307, 11352.602658906899, 11543.4805433754, 11722.94138529336, 11828.76342473163, 11970.401479926142, 11984.340861252715], "value": 7872.690949808501, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1450.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 114.0, 115.0, 159.0, 116.0, 116.0, 115.0, 114.0, 132.0, 114.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 160.0, 162.0, 161.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 106.0, 76.0, 76.0, 76.0, 77.0, 97.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 121.0, 81.0, 82.0, 82.0, 94.0, 82.0, 82.0, 102.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 56.0, 55.0, 56.0, 54.0, 57.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 76.0, 76.0, 80.0, 76.0, 76.0, 79.0, 84.0, 76.0, 77.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 120.0, 121.0, 121.0, 119.0, 118.0, 118.0, 164.0, 121.0], "value": 124.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 156.0, 155.0, 160.0, 159.0, 162.0, 163.0, 162.0, 159.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 68.0, 60.0, 61.0, 59.0, 59.0, 58.0, 57.0], "value": 60.1, "unit": "score"}]}]} 09:17:53 INFO - Return code: 0 09:17:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:53 ERROR - # TBPL SUCCESS # 09:17:53 INFO - Running post-action listener: _resource_record_post_action 09:17:53 INFO - [mozharness: 2017-04-06 16:17:53.972619Z] Finished run-tests step (success) 09:17:53 INFO - Running post-run listener: _resource_record_post_run 09:17:54 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366813184; Read time: 24; Write time: 257224 09:17:54 INFO - TinderboxPrint: CPU usage
13.1% 09:17:54 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 09:17:54 INFO - TinderboxPrint: I/O write bytes / time
366,813,184 / 257,224 09:17:54 INFO - TinderboxPrint: CPU idle
8,264.0 (86.9%) 09:17:54 INFO - TinderboxPrint: CPU user
1,203.4 (12.6%) 09:17:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:17:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110792704; Read time: 0; Write time: 140724 09:17:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256020480; Read time: 24; Write time: 116500 09:17:54 INFO - Running post-run listener: _upload_blobber_files 09:17:54 INFO - Blob upload gear active. 09:17:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:54 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 09:17:54 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'] 09:17:54 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 09:17:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:17:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:55 INFO - (blobuploader) - INFO - Done attempting. 09:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:17:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:56 INFO - (blobuploader) - INFO - Done attempting. 09:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:59 INFO - (blobuploader) - INFO - Done attempting. 09:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:18:00 INFO - (blobuploader) - INFO - Done attempting. 09:18:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:18:00 INFO - Return code: 0 09:18:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:18:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:18:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8edf7f2f368ad22551496ac783303b51061203de05cdaa31004ec3b1c0f96cdd3fcce65c134fa0d4adaee10106a5b7bf900fe09472e11236f99a5813e24f8ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c14f21d4882e1af9a7dbe58fd551d1c31517b4b7ded82f82557cdd625ddfd93d3429a5f286ff427f6a5a3aab28804489a25b751f304d5ef239c16c6765038bfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7aed19eb4aab4486f26782786dc99ad1b839f24b586838c964b9ef73d02fb856e300d977620231ccfccce6040b3e9d553634f62fc4505e1977c73f2c1c4e4edd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff654f81c3323ad8dc0f8170a96cbd0ea555a0de65bad67e044aef67abd8f8f8b69ab0e11b76964d9c00cb675375a11b853ea5dddb7a9a11b407b620023a9858"} 09:18:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:18:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:18:00 INFO - Contents: 09:18:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8edf7f2f368ad22551496ac783303b51061203de05cdaa31004ec3b1c0f96cdd3fcce65c134fa0d4adaee10106a5b7bf900fe09472e11236f99a5813e24f8ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c14f21d4882e1af9a7dbe58fd551d1c31517b4b7ded82f82557cdd625ddfd93d3429a5f286ff427f6a5a3aab28804489a25b751f304d5ef239c16c6765038bfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7aed19eb4aab4486f26782786dc99ad1b839f24b586838c964b9ef73d02fb856e300d977620231ccfccce6040b3e9d553634f62fc4505e1977c73f2c1c4e4edd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff654f81c3323ad8dc0f8170a96cbd0ea555a0de65bad67e044aef67abd8f8f8b69ab0e11b76964d9c00cb675375a11b853ea5dddb7a9a11b407b620023a9858"} 09:18:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:18:00 INFO - Copying logs to upload dir... 09:18:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:18:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.048547 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-04-06 09:18:00.399467) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 09:18:00.404112) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 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/8edf7f2f368ad22551496ac783303b51061203de05cdaa31004ec3b1c0f96cdd3fcce65c134fa0d4adaee10106a5b7bf900fe09472e11236f99a5813e24f8ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c14f21d4882e1af9a7dbe58fd551d1c31517b4b7ded82f82557cdd625ddfd93d3429a5f286ff427f6a5a3aab28804489a25b751f304d5ef239c16c6765038bfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7aed19eb4aab4486f26782786dc99ad1b839f24b586838c964b9ef73d02fb856e300d977620231ccfccce6040b3e9d553634f62fc4505e1977c73f2c1c4e4edd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff654f81c3323ad8dc0f8170a96cbd0ea555a0de65bad67e044aef67abd8f8f8b69ab0e11b76964d9c00cb675375a11b853ea5dddb7a9a11b407b620023a9858"} build_url:https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/IZYHO1zxQcmA7_9A5e6fiA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/8edf7f2f368ad22551496ac783303b51061203de05cdaa31004ec3b1c0f96cdd3fcce65c134fa0d4adaee10106a5b7bf900fe09472e11236f99a5813e24f8ec6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/c14f21d4882e1af9a7dbe58fd551d1c31517b4b7ded82f82557cdd625ddfd93d3429a5f286ff427f6a5a3aab28804489a25b751f304d5ef239c16c6765038bfd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/7aed19eb4aab4486f26782786dc99ad1b839f24b586838c964b9ef73d02fb856e300d977620231ccfccce6040b3e9d553634f62fc4505e1977c73f2c1c4e4edd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ff654f81c3323ad8dc0f8170a96cbd0ea555a0de65bad67e044aef67abd8f8f8b69ab0e11b76964d9c00cb675375a11b853ea5dddb7a9a11b407b620023a9858"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 09:18:00.432117) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 09:18:00.432437) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1491494228.360142-835456217 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 09:18:00.512557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 09:18:00.512924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 09:18:00.513209) ========= ========= Total master_lag: 0.24 =========