builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1486327381.7 results: success (0) revision: a6790a55b4b3e96b98512facd548b228ea8cda67 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.697545) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.698006) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.698290) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.714597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.714872) ========= 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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 12:43:02-- 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% 108M=0s 2017-02-05 12:43:02 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131829 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.860502) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.860846) ========= 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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013429 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.911890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:01.912423) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6790a55b4b3e96b98512facd548b228ea8cda67 --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 a6790a55b4b3e96b98512facd548b228ea8cda67 --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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 12:43:03,103 truncating revision to first 12 chars 2017-02-05 12:43:03,103 Setting DEBUG logging. 2017-02-05 12:43:03,103 attempt 1/10 2017-02-05 12:43:03,103 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6790a55b4b3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 12:43:03,399 unpacking tar archive at: mozilla-aurora-a6790a55b4b3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:02.529645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:02.529968) ========= script_repo_revision: a6790a55b4b3e96b98512facd548b228ea8cda67 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:02.530396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:02.530681) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 12:43:02.540219) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-05 12:43:02.540537) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:43:03 INFO - MultiFileLogger online at 20170205 12:43:03 in /builds/slave/test 12:43:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:43:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:43:03 INFO - {'append_to_log': False, 12:43:03 INFO - 'base_work_dir': '/builds/slave/test', 12:43:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:43:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:43:03 INFO - 'branch': 'Mozilla-Aurora', 12:43:03 INFO - 'buildbot_json_path': 'buildprops.json', 12:43:03 INFO - 'config_files': ('talos/linux_config.py',), 12:43:03 INFO - 'default_actions': ('clobber', 12:43:03 INFO - 'read-buildbot-config', 12:43:03 INFO - 'download-and-extract', 12:43:03 INFO - 'populate-webroot', 12:43:03 INFO - 'create-virtualenv', 12:43:03 INFO - 'install', 12:43:03 INFO - 'run-tests'), 12:43:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:43:03 INFO - 'download_minidump_stackwalk': True, 12:43:03 INFO - 'download_symbols': 'ondemand', 12:43:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:43:03 INFO - 'tooltool.py': '/tools/tooltool.py', 12:43:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:43:03 INFO - '/tools/misc-python/virtualenv.py')}, 12:43:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:43:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:43:03 INFO - 'installer_path': 'installer.exe', 12:43:03 INFO - 'log_level': 'info', 12:43:03 INFO - 'log_name': 'talos', 12:43:03 INFO - 'log_to_console': True, 12:43:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:43:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:43:03 INFO - 'opt_config_files': (), 12:43:03 INFO - 'pip_index': False, 12:43:03 INFO - 'sps_profile': False, 12:43:03 INFO - 'sps_profile_interval': 0, 12:43:03 INFO - 'suite': 'dromaeojs-e10s', 12:43:03 INFO - 'system_bits': '32', 12:43:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:43:03 INFO - 'title': 'talos-linux64-ix-053', 12:43:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:43:03 INFO - 'use_talos_json': True, 12:43:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:43:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:43:03 INFO - 'work_dir': 'build'} 12:43:03 INFO - [mozharness: 2017-02-05 20:43:03.828009Z] Running clobber step. 12:43:03 INFO - Running pre-action listener: _resource_record_pre_action 12:43:03 INFO - Running main action method: clobber 12:43:03 INFO - rmtree: /builds/slave/test/build 12:43:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:43:04 INFO - Running post-action listener: _resource_record_post_action 12:43:04 INFO - [mozharness: 2017-02-05 20:43:04.300423Z] Finished clobber step (success) 12:43:04 INFO - [mozharness: 2017-02-05 20:43:04.300523Z] Running read-buildbot-config step. 12:43:04 INFO - Running pre-action listener: _resource_record_pre_action 12:43:04 INFO - Running main action method: read_buildbot_config 12:43:04 INFO - Using buildbot properties: 12:43:04 INFO - { 12:43:04 INFO - "project": "", 12:43:04 INFO - "product": "firefox", 12:43:04 INFO - "who": "ryanvm@gmail.com", 12:43:04 INFO - "installer_path": "public/build/target.tar.bz2", 12:43:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 12:43:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 12:43:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 12:43:04 INFO - "stage_platform": "linux64-pgo", 12:43:04 INFO - "basedir": "/builds/slave/test", 12:43:04 INFO - "buildnumber": 806, 12:43:04 INFO - "platform": "ubuntu64_hw", 12:43:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:43:04 INFO - "slavebuilddir": "test", 12:43:04 INFO - "taskId": "QiMhpxysThq70JD2bIzblw", 12:43:04 INFO - "branch": "mozilla-aurora", 12:43:04 INFO - "script_repo_revision": "production", 12:43:04 INFO - "revision": "a6790a55b4b3e96b98512facd548b228ea8cda67", 12:43:04 INFO - "slavename": "talos-linux64-ix-053", 12:43:04 INFO - "repo_path": "releases/mozilla-aurora" 12:43:04 INFO - } 12:43:04 INFO - Finding installer, test and symbols from parent task. 12:43:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiMhpxysThq70JD2bIzblw'}, attempt #1 12:43:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QiMhpxysThq70JD2bIzblw'}, attempt #1 12:43:05 INFO - Task dependencies: PlSR271pQS6rgSwu6hQVDA 12:43:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA'}, attempt #1 12:43:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 12:43:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/test_packages.json 12:43:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.crashreporter-symbols.zip 12:43:05 INFO - Running post-action listener: _resource_record_post_action 12:43:05 INFO - [mozharness: 2017-02-05 20:43:05.680283Z] Finished read-buildbot-config step (success) 12:43:05 INFO - [mozharness: 2017-02-05 20:43:05.680501Z] Running download-and-extract step. 12:43:05 INFO - Running pre-action listener: _resource_record_pre_action 12:43:05 INFO - Running main action method: download_and_extract 12:43:05 INFO - mkdir: /builds/slave/test/build/tests 12:43:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:05 INFO - trying https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.test_packages.json 12:43:05 INFO - Downloading https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:43:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:43:06 INFO - Downloaded 896 bytes. 12:43:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:43:06 INFO - Using the following test package requirements: 12:43:06 INFO - {u'common': [u'target.common.tests.zip'], 12:43:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:43:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:43:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:43:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:43:06 INFO - u'mozbase': [u'target.common.tests.zip'], 12:43:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:43:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:43:06 INFO - u'web-platform': [u'target.common.tests.zip', 12:43:06 INFO - u'target.web-platform.tests.zip'], 12:43:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:43:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:43:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip 12:43:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:43:06 INFO - Fetch https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip into memory 12:43:07 INFO - Expected file size: 21854477 12:43:07 INFO - Obtained file size: 21854477 12:43:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:43:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip 12:43:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:43:11 INFO - Fetch https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.common.tests.zip into memory 12:43:12 INFO - Expected file size: 21854477 12:43:12 INFO - Obtained file size: 21854477 12:43:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.talos.tests.zip 12:43:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:43:16 INFO - Fetch https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.talos.tests.zip into memory 12:43:17 INFO - Expected file size: 14403485 12:43:17 INFO - Obtained file size: 14403485 12:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:17 INFO - trying https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 12:43:17 INFO - Downloading https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:43:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:43:18 INFO - Downloaded 66093962 bytes. 12:43:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 12:43:18 INFO - mkdir: /builds/slave/test/properties 12:43:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:43:18 INFO - Writing to file /builds/slave/test/properties/build_url 12:43:18 INFO - Contents: 12:43:18 INFO - build_url:https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 12:43:18 INFO - Running post-action listener: _resource_record_post_action 12:43:18 INFO - Running post-action listener: set_extra_try_arguments 12:43:18 INFO - [mozharness: 2017-02-05 20:43:18.632819Z] Finished download-and-extract step (success) 12:43:18 INFO - [mozharness: 2017-02-05 20:43:18.632915Z] Running populate-webroot step. 12:43:18 INFO - Running pre-action listener: _resource_record_pre_action 12:43:18 INFO - Running main action method: populate_webroot 12:43:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:43:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:43:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:43:18 INFO - '--tppagecycles', 12:43:18 INFO - '7'], 12:43:18 INFO - 'tests': ['tsvgm']}}, 12:43:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:43:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:43:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:43:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:43:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:43:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['damp', 'tps']}, 12:43:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'tests': ['damp', 'tps']}, 12:43:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['dromaeo_dom']}, 12:43:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:43:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['basic_compositor_video']}, 12:43:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:43:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'other-e10s': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['a11yr', 12:43:18 INFO - 'ts_paint', 12:43:18 INFO - 'tpaint', 12:43:18 INFO - 'sessionrestore', 12:43:18 INFO - 'sessionrestore_no_auto_restore', 12:43:18 INFO - 'tabpaint']}, 12:43:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['tsvgx', 12:43:18 INFO - 'tsvgr_opacity', 12:43:18 INFO - 'tart', 12:43:18 INFO - 'tscrollx', 12:43:18 INFO - 'cart', 12:43:18 INFO - 'tsvg_static']}, 12:43:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:43:18 INFO - 'tsvgr_opacity', 12:43:18 INFO - 'tart', 12:43:18 INFO - 'tscrollx', 12:43:18 INFO - 'cart', 12:43:18 INFO - 'tsvg_static']}, 12:43:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'talos_options': ['--disable-e10s'], 12:43:18 INFO - 'tests': ['tp5o']}, 12:43:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:43:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'talos_options': ['--disable-e10s', 12:43:18 INFO - '--xperf_path', 12:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:18 INFO - 'tests': ['tp5n']}, 12:43:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:43:18 INFO - 'talos_options': ['--xperf_path', 12:43:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:43:18 INFO - 'tests': ['tp5n']}}, 12:43:18 INFO - 'talos.zip': {'path': '', 12:43:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:43:18 INFO - Running post-action listener: _resource_record_post_action 12:43:18 INFO - [mozharness: 2017-02-05 20:43:18.646037Z] Finished populate-webroot step (success) 12:43:18 INFO - [mozharness: 2017-02-05 20:43:18.646127Z] Running create-virtualenv step. 12:43:18 INFO - Running pre-action listener: _resource_record_pre_action 12:43:18 INFO - Running main action method: create_virtualenv 12:43:18 INFO - Creating virtualenv /builds/slave/test/build/venv 12:43:18 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 12:43:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:43:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:43:18 INFO - Using real prefix '/usr' 12:43:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:43:19 INFO - Installing distribute.............................................................................................................................................................................................done. 12:43:21 INFO - Installing pip.................done. 12:43:21 INFO - Return code: 0 12:43:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:43:21 INFO - Reading from file tmpfile_stdout 12:43:21 INFO - Output received: 12:43:21 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) 12:43:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:43:21 INFO - Using env: {'DISPLAY': ':0', 12:43:21 INFO - 'HOME': '/home/cltbld', 12:43:21 INFO - 'LANG': 'en_US.UTF-8', 12:43:21 INFO - 'LANGUAGE': 'en_US:en', 12:43:21 INFO - 'LOGNAME': 'cltbld', 12:43:21 INFO - 'MAIL': '/var/mail/cltbld', 12:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:21 INFO - 'MOZ_NO_REMOTE': '1', 12:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:21 INFO - 'NO_EM_RESTART': '1', 12:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:21 INFO - 'PWD': '/builds/slave/test', 12:43:21 INFO - 'SHELL': '/bin/bash', 12:43:21 INFO - 'SHLVL': '1', 12:43:21 INFO - 'TERM': 'linux', 12:43:21 INFO - 'TMOUT': '86400', 12:43:21 INFO - 'USER': 'cltbld', 12:43:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:21 INFO - '_': '/tools/buildbot/bin/python'} 12:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:21 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 12:43:21 INFO - Cleaning up... 12:43:21 INFO - Return code: 0 12:43:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:43:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:43:21 INFO - Using env: {'DISPLAY': ':0', 12:43:21 INFO - 'HOME': '/home/cltbld', 12:43:21 INFO - 'LANG': 'en_US.UTF-8', 12:43:21 INFO - 'LANGUAGE': 'en_US:en', 12:43:21 INFO - 'LOGNAME': 'cltbld', 12:43:21 INFO - 'MAIL': '/var/mail/cltbld', 12:43:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:21 INFO - 'MOZ_NO_REMOTE': '1', 12:43:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:21 INFO - 'NO_EM_RESTART': '1', 12:43:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:21 INFO - 'PWD': '/builds/slave/test', 12:43:21 INFO - 'SHELL': '/bin/bash', 12:43:21 INFO - 'SHLVL': '1', 12:43:21 INFO - 'TERM': 'linux', 12:43:21 INFO - 'TMOUT': '86400', 12:43:21 INFO - 'USER': 'cltbld', 12:43:21 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:21 INFO - '_': '/tools/buildbot/bin/python'} 12:43:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:21 INFO - Downloading/unpacking psutil>=3.1.1 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:43:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:23 INFO - Installing collected packages: psutil 12:43:23 INFO - Running setup.py install for psutil 12:43:24 INFO - building 'psutil._psutil_linux' extension 12:43:24 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 12:43:24 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 12:43:24 INFO - building 'psutil._psutil_posix' extension 12:43:24 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 12:43:24 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 12:43:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:43:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:43:24 INFO - Successfully installed psutil 12:43:24 INFO - Cleaning up... 12:43:24 INFO - Return code: 0 12:43:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:43:24 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')]} 12:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:24 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')]} 12:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:24 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:24 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 12:43:24 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 12:43:24 INFO - Using env: {'DISPLAY': ':0', 12:43:24 INFO - 'HOME': '/home/cltbld', 12:43:24 INFO - 'LANG': 'en_US.UTF-8', 12:43:24 INFO - 'LANGUAGE': 'en_US:en', 12:43:24 INFO - 'LOGNAME': 'cltbld', 12:43:24 INFO - 'MAIL': '/var/mail/cltbld', 12:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:24 INFO - 'MOZ_NO_REMOTE': '1', 12:43:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:24 INFO - 'NO_EM_RESTART': '1', 12:43:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:24 INFO - 'PWD': '/builds/slave/test', 12:43:24 INFO - 'SHELL': '/bin/bash', 12:43:24 INFO - 'SHLVL': '1', 12:43:24 INFO - 'TERM': 'linux', 12:43:24 INFO - 'TMOUT': '86400', 12:43:24 INFO - 'USER': 'cltbld', 12:43:24 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:24 INFO - '_': '/tools/buildbot/bin/python'} 12:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:43:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:43:26 INFO - Installing collected packages: mozsystemmonitor 12:43:26 INFO - Running setup.py install for mozsystemmonitor 12:43:26 INFO - Successfully installed mozsystemmonitor 12:43:26 INFO - Cleaning up... 12:43:26 INFO - Return code: 0 12:43:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:43:26 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')]} 12:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 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')]} 12:43:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:26 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:26 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 12:43:26 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 12:43:27 INFO - Using env: {'DISPLAY': ':0', 12:43:27 INFO - 'HOME': '/home/cltbld', 12:43:27 INFO - 'LANG': 'en_US.UTF-8', 12:43:27 INFO - 'LANGUAGE': 'en_US:en', 12:43:27 INFO - 'LOGNAME': 'cltbld', 12:43:27 INFO - 'MAIL': '/var/mail/cltbld', 12:43:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:27 INFO - 'MOZ_NO_REMOTE': '1', 12:43:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:27 INFO - 'NO_EM_RESTART': '1', 12:43:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:27 INFO - 'PWD': '/builds/slave/test', 12:43:27 INFO - 'SHELL': '/bin/bash', 12:43:27 INFO - 'SHLVL': '1', 12:43:27 INFO - 'TERM': 'linux', 12:43:27 INFO - 'TMOUT': '86400', 12:43:27 INFO - 'USER': 'cltbld', 12:43:27 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:27 INFO - '_': '/tools/buildbot/bin/python'} 12:43:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:27 INFO - Downloading/unpacking jsonschema==2.5.1 12:43:27 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 12:43:27 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 12:43:27 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 12:43:27 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 12:43:27 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 12:43:27 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 12:43:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:43:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:43:29 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 12:43:29 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 12:43:29 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 12:43:29 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 12:43:29 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 12:43:29 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 12:43:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:43:29 INFO - warning: no files found matching '*.txt' 12:43:29 INFO - no previously-included directories found matching 'build' 12:43:29 INFO - no previously-included directories found matching 'dist' 12:43:29 INFO - no previously-included directories found matching '.git*' 12:43:29 INFO - Installing collected packages: jsonschema, functools32 12:43:29 INFO - Running setup.py install for functools32 12:43:29 INFO - warning: no files found matching '*.txt' 12:43:29 INFO - no previously-included directories found matching 'build' 12:43:29 INFO - no previously-included directories found matching 'dist' 12:43:29 INFO - no previously-included directories found matching '.git*' 12:43:29 INFO - Successfully installed jsonschema functools32 12:43:29 INFO - Cleaning up... 12:43:29 INFO - Return code: 0 12:43:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:43:29 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')]} 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 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')]} 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:29 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 12:43:29 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 12:43:29 INFO - Using env: {'DISPLAY': ':0', 12:43:29 INFO - 'HOME': '/home/cltbld', 12:43:29 INFO - 'LANG': 'en_US.UTF-8', 12:43:29 INFO - 'LANGUAGE': 'en_US:en', 12:43:29 INFO - 'LOGNAME': 'cltbld', 12:43:29 INFO - 'MAIL': '/var/mail/cltbld', 12:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:29 INFO - 'MOZ_NO_REMOTE': '1', 12:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:29 INFO - 'NO_EM_RESTART': '1', 12:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:29 INFO - 'PWD': '/builds/slave/test', 12:43:29 INFO - 'SHELL': '/bin/bash', 12:43:29 INFO - 'SHLVL': '1', 12:43:29 INFO - 'TERM': 'linux', 12:43:29 INFO - 'TMOUT': '86400', 12:43:29 INFO - 'USER': 'cltbld', 12:43:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:29 INFO - '_': '/tools/buildbot/bin/python'} 12:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:43:29 INFO - Cleaning up... 12:43:29 INFO - Return code: 0 12:43:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:43:29 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')]} 12:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 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')]} 12:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:29 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:29 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 12:43:29 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 12:43:29 INFO - Using env: {'DISPLAY': ':0', 12:43:29 INFO - 'HOME': '/home/cltbld', 12:43:29 INFO - 'LANG': 'en_US.UTF-8', 12:43:29 INFO - 'LANGUAGE': 'en_US:en', 12:43:29 INFO - 'LOGNAME': 'cltbld', 12:43:29 INFO - 'MAIL': '/var/mail/cltbld', 12:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:29 INFO - 'MOZ_NO_REMOTE': '1', 12:43:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:29 INFO - 'NO_EM_RESTART': '1', 12:43:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:29 INFO - 'PWD': '/builds/slave/test', 12:43:29 INFO - 'SHELL': '/bin/bash', 12:43:29 INFO - 'SHLVL': '1', 12:43:29 INFO - 'TERM': 'linux', 12:43:29 INFO - 'TMOUT': '86400', 12:43:29 INFO - 'USER': 'cltbld', 12:43:29 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:29 INFO - '_': '/tools/buildbot/bin/python'} 12:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:43:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:43:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:43:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:43:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 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 12:43:32 INFO - Downloading docopt-0.6.1.tar.gz 12:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:43:32 INFO - Installing collected packages: blobuploader, requests, docopt 12:43:32 INFO - Running setup.py install for blobuploader 12:43:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:43:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:43:33 INFO - Running setup.py install for requests 12:43:33 INFO - Running setup.py install for docopt 12:43:33 INFO - Successfully installed blobuploader requests docopt 12:43:33 INFO - Cleaning up... 12:43:33 INFO - Return code: 0 12:43:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:33 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')]} 12:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:33 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')]} 12:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:33 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:33 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 12:43:33 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 12:43:33 INFO - Using env: {'DISPLAY': ':0', 12:43:33 INFO - 'HOME': '/home/cltbld', 12:43:33 INFO - 'LANG': 'en_US.UTF-8', 12:43:33 INFO - 'LANGUAGE': 'en_US:en', 12:43:33 INFO - 'LOGNAME': 'cltbld', 12:43:33 INFO - 'MAIL': '/var/mail/cltbld', 12:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:33 INFO - 'MOZ_NO_REMOTE': '1', 12:43:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:33 INFO - 'NO_EM_RESTART': '1', 12:43:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:33 INFO - 'PWD': '/builds/slave/test', 12:43:33 INFO - 'SHELL': '/bin/bash', 12:43:33 INFO - 'SHLVL': '1', 12:43:33 INFO - 'TERM': 'linux', 12:43:33 INFO - 'TMOUT': '86400', 12:43:33 INFO - 'USER': 'cltbld', 12:43:33 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:33 INFO - '_': '/tools/buildbot/bin/python'} 12:43:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:33 INFO - Running setup.py (path:/tmp/pip-ZcDXNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:33 INFO - Running setup.py (path:/tmp/pip-xYNMzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:33 INFO - Running setup.py (path:/tmp/pip-paqIEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:34 INFO - Running setup.py (path:/tmp/pip-TGJfN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:34 INFO - Running setup.py (path:/tmp/pip-VzflUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:34 INFO - Running setup.py (path:/tmp/pip-177koZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:34 INFO - Running setup.py (path:/tmp/pip-HtZgjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:34 INFO - Running setup.py (path:/tmp/pip-Cbiq7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:34 INFO - Running setup.py (path:/tmp/pip-JD8NSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:34 INFO - Running setup.py (path:/tmp/pip-xnXIkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:34 INFO - Running setup.py (path:/tmp/pip-C_w4dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:34 INFO - Running setup.py (path:/tmp/pip-FdIY5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:34 INFO - Running setup.py (path:/tmp/pip-2Qsmza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:34 INFO - Running setup.py (path:/tmp/pip-k076p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:34 INFO - Running setup.py (path:/tmp/pip-Q8aNSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:34 INFO - Running setup.py (path:/tmp/pip-yEQk__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:34 INFO - Running setup.py (path:/tmp/pip-arTTkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:43:35 INFO - Running setup.py install for manifestparser 12:43:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Running setup.py install for mozcrash 12:43:35 INFO - Running setup.py install for mozdebug 12:43:35 INFO - Running setup.py install for mozdevice 12:43:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Running setup.py install for mozfile 12:43:35 INFO - Running setup.py install for mozhttpd 12:43:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Running setup.py install for mozinfo 12:43:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Running setup.py install for mozInstall 12:43:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:43:35 INFO - Running setup.py install for mozleak 12:43:35 INFO - Running setup.py install for mozlog 12:43:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for moznetwork 12:43:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for mozprocess 12:43:36 INFO - Running setup.py install for mozprofile 12:43:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for mozrunner 12:43:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Running setup.py install for mozscreenshot 12:43:36 INFO - Running setup.py install for moztest 12:43:36 INFO - Running setup.py install for mozversion 12:43:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:43:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:43:36 INFO - Cleaning up... 12:43:36 INFO - Return code: 0 12:43:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:36 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')]} 12:43:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:36 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')]} 12:43:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:36 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:36 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 12:43:36 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 12:43:36 INFO - Using env: {'DISPLAY': ':0', 12:43:36 INFO - 'HOME': '/home/cltbld', 12:43:36 INFO - 'LANG': 'en_US.UTF-8', 12:43:36 INFO - 'LANGUAGE': 'en_US:en', 12:43:36 INFO - 'LOGNAME': 'cltbld', 12:43:36 INFO - 'MAIL': '/var/mail/cltbld', 12:43:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:36 INFO - 'MOZ_NO_REMOTE': '1', 12:43:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:36 INFO - 'NO_EM_RESTART': '1', 12:43:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:36 INFO - 'PWD': '/builds/slave/test', 12:43:36 INFO - 'SHELL': '/bin/bash', 12:43:36 INFO - 'SHLVL': '1', 12:43:36 INFO - 'TERM': 'linux', 12:43:36 INFO - 'TMOUT': '86400', 12:43:36 INFO - 'USER': 'cltbld', 12:43:36 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:36 INFO - '_': '/tools/buildbot/bin/python'} 12:43:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:43:37 INFO - Running setup.py (path:/tmp/pip-iwC2GR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:43:37 INFO - Running setup.py (path:/tmp/pip-aqgFTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:43:37 INFO - Running setup.py (path:/tmp/pip-xXAbb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:43:37 INFO - Running setup.py (path:/tmp/pip-F9aGHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:43:37 INFO - Running setup.py (path:/tmp/pip-wDmCo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:43:37 INFO - Running setup.py (path:/tmp/pip-NTYwkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:43:37 INFO - Running setup.py (path:/tmp/pip-a_BUAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:43:37 INFO - Running setup.py (path:/tmp/pip-0rul29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:43:37 INFO - Running setup.py (path:/tmp/pip-IAbnFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:43:37 INFO - Running setup.py (path:/tmp/pip-vaDJB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:43:37 INFO - Running setup.py (path:/tmp/pip-KxWDdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:43:37 INFO - Running setup.py (path:/tmp/pip-bkrjm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:43:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:43:37 INFO - Running setup.py (path:/tmp/pip-TcEQrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:43:37 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)) 12:43:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:43:37 INFO - Running setup.py (path:/tmp/pip-uwXalz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:43:38 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)) 12:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:38 INFO - Running setup.py (path:/tmp/pip-RW37e4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:43:38 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)) 12:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:43:38 INFO - Running setup.py (path:/tmp/pip-HP8PbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:43:38 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)) 12:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:43:38 INFO - Running setup.py (path:/tmp/pip-IkUo2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:43:38 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)) 12:43:38 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)) 12:43:38 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)) 12:43:38 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)) 12:43:38 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)) 12:43:38 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)) 12:43:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:43:38 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 12:43:38 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 12:43:38 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 12:43:38 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 12:43:38 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 12:43:38 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 12:43:40 INFO - Downloading blessings-1.6.tar.gz 12:43:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:43:40 INFO - Installing collected packages: blessings 12:43:40 INFO - Running setup.py install for blessings 12:43:40 INFO - Successfully installed blessings 12:43:40 INFO - Cleaning up... 12:43:40 INFO - Return code: 0 12:43:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:43:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:40 INFO - Reading from file tmpfile_stdout 12:43:40 INFO - Current package versions: 12:43:40 INFO - argparse == 1.2.1 12:43:40 INFO - blessings == 1.6 12:43:40 INFO - blobuploader == 1.2.4 12:43:40 INFO - docopt == 0.6.1 12:43:40 INFO - functools32 == 3.2.3-2 12:43:40 INFO - jsonschema == 2.5.1 12:43:40 INFO - manifestparser == 1.1 12:43:40 INFO - mozInstall == 1.12 12:43:40 INFO - mozcrash == 1.0 12:43:40 INFO - mozdebug == 0.1 12:43:40 INFO - mozdevice == 0.49 12:43:40 INFO - mozfile == 1.2 12:43:40 INFO - mozhttpd == 0.7 12:43:40 INFO - mozinfo == 0.9 12:43:40 INFO - mozleak == 0.1 12:43:40 INFO - mozlog == 3.4 12:43:40 INFO - moznetwork == 0.27 12:43:40 INFO - mozprocess == 0.24 12:43:40 INFO - mozprofile == 0.28 12:43:40 INFO - mozrunner == 6.13 12:43:40 INFO - mozscreenshot == 0.1 12:43:40 INFO - mozsystemmonitor == 0.3 12:43:40 INFO - moztest == 0.8 12:43:40 INFO - mozversion == 1.4 12:43:40 INFO - psutil == 3.1.1 12:43:40 INFO - requests == 1.2.3 12:43:40 INFO - wsgiref == 0.1.2 12:43:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:43:40 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')]} 12:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:40 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')]} 12:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:40 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:40 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 12:43:40 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 12:43:40 INFO - Using env: {'DISPLAY': ':0', 12:43:40 INFO - 'HOME': '/home/cltbld', 12:43:40 INFO - 'LANG': 'en_US.UTF-8', 12:43:40 INFO - 'LANGUAGE': 'en_US:en', 12:43:40 INFO - 'LOGNAME': 'cltbld', 12:43:40 INFO - 'MAIL': '/var/mail/cltbld', 12:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:40 INFO - 'MOZ_NO_REMOTE': '1', 12:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:40 INFO - 'NO_EM_RESTART': '1', 12:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:40 INFO - 'PWD': '/builds/slave/test', 12:43:40 INFO - 'SHELL': '/bin/bash', 12:43:40 INFO - 'SHLVL': '1', 12:43:40 INFO - 'TERM': 'linux', 12:43:40 INFO - 'TMOUT': '86400', 12:43:40 INFO - 'USER': 'cltbld', 12:43:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:40 INFO - '_': '/tools/buildbot/bin/python'} 12:43:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 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)) 12:43:40 INFO - Cleaning up... 12:43:40 INFO - Return code: 0 12:43:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:43:40 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')]} 12:43:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:43:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:40 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')]} 12:43:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:43:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:43:40 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 0xdcb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xedca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113d480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, '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': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', '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 12:43:40 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 12:43:40 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 12:43:40 INFO - Using env: {'DISPLAY': ':0', 12:43:40 INFO - 'HOME': '/home/cltbld', 12:43:40 INFO - 'LANG': 'en_US.UTF-8', 12:43:40 INFO - 'LANGUAGE': 'en_US:en', 12:43:40 INFO - 'LOGNAME': 'cltbld', 12:43:40 INFO - 'MAIL': '/var/mail/cltbld', 12:43:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:40 INFO - 'MOZ_NO_REMOTE': '1', 12:43:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:40 INFO - 'NO_EM_RESTART': '1', 12:43:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:40 INFO - 'PWD': '/builds/slave/test', 12:43:40 INFO - 'SHELL': '/bin/bash', 12:43:40 INFO - 'SHLVL': '1', 12:43:40 INFO - 'TERM': 'linux', 12:43:40 INFO - 'TMOUT': '86400', 12:43:40 INFO - 'USER': 'cltbld', 12:43:40 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:40 INFO - '_': '/tools/buildbot/bin/python'} 12:43:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:43:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:43:41 INFO - Cleaning up... 12:43:41 INFO - Return code: 0 12:43:41 INFO - Running post-action listener: _resource_record_post_action 12:43:41 INFO - Running post-action listener: _start_resource_monitoring 12:43:41 INFO - Starting resource monitoring. 12:43:41 INFO - [mozharness: 2017-02-05 20:43:41.238501Z] Finished create-virtualenv step (success) 12:43:41 INFO - [mozharness: 2017-02-05 20:43:41.238938Z] Running install step. 12:43:41 INFO - Running pre-action listener: _resource_record_pre_action 12:43:41 INFO - Running main action method: install 12:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:43:41 INFO - Reading from file tmpfile_stdout 12:43:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:43:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:43:41 INFO - Reading from file tmpfile_stdout 12:43:41 INFO - Output received: 12:43:41 INFO - Usage: mozinstall [options] installer 12:43:41 INFO - Options: 12:43:41 INFO - -h, --help show this help message and exit 12:43:41 INFO - -d DEST, --destination=DEST 12:43:41 INFO - Directory to install application into. [default: 12:43:41 INFO - "/builds/slave/test"] 12:43:41 INFO - --app=APP Application being installed. [default: firefox] 12:43:41 INFO - mkdir: /builds/slave/test/build/application 12:43:41 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'] 12:43:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:43:57 INFO - Reading from file tmpfile_stdout 12:43:57 INFO - Output received: 12:43:57 INFO - /builds/slave/test/build/application/firefox/firefox 12:43:57 INFO - Running post-action listener: _resource_record_post_action 12:43:57 INFO - [mozharness: 2017-02-05 20:43:57.964023Z] Finished install step (success) 12:43:57 INFO - [mozharness: 2017-02-05 20:43:57.964296Z] Running run-tests step. 12:43:57 INFO - Running pre-action listener: _resource_record_pre_action 12:43:57 INFO - Running main action method: run_tests 12:43:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:43:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:43:57 INFO - Python 2.7.3 12:43:57 INFO - Return code: 0 12:43:57 INFO - grabbing minidump binary from tooltool 12:43:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:43:57 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 0x113a820>, '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 0x113b520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x113b9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:43:57 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 12:43:57 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 12:43:57 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 12:43:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:43:58 INFO - Return code: 0 12:43:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:43:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:43:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:43:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:43:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:43:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:43:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:43:58 INFO - Using env: {'DISPLAY': ':0', 12:43:58 INFO - 'HOME': '/home/cltbld', 12:43:58 INFO - 'LANG': 'en_US.UTF-8', 12:43:58 INFO - 'LANGUAGE': 'en_US:en', 12:43:58 INFO - 'LOGNAME': 'cltbld', 12:43:58 INFO - 'MAIL': '/var/mail/cltbld', 12:43:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:43:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:43:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:43:58 INFO - 'MOZ_NO_REMOTE': '1', 12:43:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:43:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:43:58 INFO - 'NO_EM_RESTART': '1', 12:43:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:43:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:43:58 INFO - 'PWD': '/builds/slave/test', 12:43:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:43:58 INFO - 'SHELL': '/bin/bash', 12:43:58 INFO - 'SHLVL': '1', 12:43:58 INFO - 'TERM': 'linux', 12:43:58 INFO - 'TMOUT': '86400', 12:43:58 INFO - 'USER': 'cltbld', 12:43:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686', 12:43:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:43:58 INFO - '_': '/tools/buildbot/bin/python'} 12:43:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:43:58 INFO - mozversion application_buildid: 20170205193251 12:43:58 INFO - mozversion application_changeset: a6790a55b4b3e96b98512facd548b228ea8cda67 12:43:58 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:43:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:43:58 INFO - mozversion application_name: Firefox 12:43:58 INFO - mozversion application_remotingname: firefox-dev 12:43:58 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:58 INFO - mozversion application_vendor: Mozilla 12:43:58 INFO - mozversion application_version: 53.0a2 12:43:58 INFO - mozversion platform_buildid: 20170205193251 12:43:58 INFO - mozversion platform_changeset: a6790a55b4b3e96b98512facd548b228ea8cda67 12:43:58 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:43:58 INFO - mozversion platform_version: 53.0a2 12:43:58 INFO - using testdate: 1486327438 12:43:58 INFO - actual date: 1486327438 12:43:58 INFO - starting webserver on 'localhost:56405' 12:43:58 INFO - SUITE-START | Running 2 tests 12:43:58 INFO - TEST-START | dromaeo_css 12:43:58 INFO - operating with platform_type : linux_ 12:43:58 INFO - Initialising browser for dromaeo_css test... 12:43:58 INFO - TEST-INFO | started process 15591 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhlDSy/profile http://localhost:56405/getInfo.html) 12:44:02 INFO - PROCESS | 15591 | __metrics Screen width/height:1600/1200 12:44:02 INFO - PROCESS | 15591 | colorDepth:24 12:44:02 INFO - PROCESS | 15591 | Browser inner width/height: 1024/697 12:44:02 INFO - PROCESS | 15591 | __metrics 12:44:03 INFO - PROCESS | 15591 | 1486327443488 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpyhlDSy/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpyhlDSy/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpyhlDSy/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpyhlDSy/profile/extensions/talos-powers@TalosPowersService.js:55:9 12:44:03 ERROR - PROCESS | 15591 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 12:44:04 INFO - TEST-INFO | 15591: exit 0 12:44:04 INFO - Browser initialized. 12:44:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:44:04 INFO - TEST-INFO | started process 15720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhlDSy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:44:16 INFO - PROCESS | 15720 | RSS: Main: 144809984 12:44:16 INFO - PROCESS | 15720 | 12:47:15 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56405/tests/dromaeo/cssquery-ext.html) 12:47:16 INFO - PROCESS | 15720 | RSS: Main: 152420352 12:47:16 INFO - PROCESS | 15720 | 12:49:04 INFO - PROCESS | 15720 | ************************* 12:49:04 INFO - PROCESS | 15720 | A coding exception was thrown and uncaught in a Task. 12:49:04 INFO - PROCESS | 15720 | 12:49:04 ERROR - PROCESS | 15720 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:49:04 INFO - PROCESS | 15720 | Full stack: 12:49:04 INFO - PROCESS | 15720 | ************************* 12:50:18 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-ext.html (next: http://localhost:56405/tests/dromaeo/cssquery-jquery.html) 12:50:19 INFO - PROCESS | 15720 | RSS: Main: 149618688 12:50:19 INFO - PROCESS | 15720 | 12:53:21 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56405/tests/dromaeo/cssquery-mootools.html) 12:53:21 INFO - PROCESS | 15720 | RSS: Main: 153903104 12:53:21 INFO - PROCESS | 15720 | 12:56:23 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56405/tests/dromaeo/cssquery-prototype.html) 12:56:23 INFO - PROCESS | 15720 | RSS: Main: 149856256 12:56:23 INFO - PROCESS | 15720 | 12:59:26 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56405/tests/dromaeo/cssquery-yui.html) 12:59:27 INFO - PROCESS | 15720 | RSS: Main: 152629248 12:59:27 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | Cycle 1(1): loaded http://localhost:56405/tests/dromaeo/cssquery-yui.html (next: http://localhost:56405/tests/dromaeo/cssquery-dojo.html) 13:02:29 INFO - PROCESS | 15720 | RSS: Main: 153833472 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | __start_tp_report 13:02:29 INFO - PROCESS | 15720 | _x_x_mozilla_page_load 13:02:29 INFO - PROCESS | 15720 | _x_x_mozilla_page_load_details 13:02:29 INFO - PROCESS | 15720 | |i|pagename|runs| 13:02:29 INFO - PROCESS | 15720 | |0;dojo.html;3279.7868138571007;3310.0897253255357;3337.5828021497327;3341.7994920304777;3346.866125354986;5448.782048718052;5465;5483.8080667176655;5508;5542.584306177033;5510.311211098613;5543.390227075029;5558.110702287635;5572.080606699889;5606.159076138581;5047.697138171712;5076.517730815585;5114.872128196787;5130.640855140142;5155.664881782691;5091.923621145667;5126.871828204306;5134.974325128369;5139.58883289336;5152.227165925104;4941.407031156266;4964.205727083668;5150.716710580917;5162.561182299509;5164.251183578379;5042.722650254234;5056.2921191033465;5056.988602279559;5081.949180508222;5125.743712814345;5048.570871475892;5073.568746656501;5083.669561478529;5106.770195341219;5114.539691427789;5503.477169668875;5513.724313784335;5592.972035139798;5600.907822974522;5604.495595396393;5799.3040835100055;5807.709614519257;5826.038703613898;5835;5845.1232315153065;5963.731632076567;5965.642061476326;5970;5976.462118409364;5990.700464976734;5569.610127291091;5573.108302671553;5575.968445837533;5579.0515612346;5579.358373786985;5779.3642699303045;5828.504577110908;5877.206577112121;5892.351841297454;6006.939930600638;5752.913706294409;5786.04530252512;5802.941970580325;5807.8548036299435;5840.065589505743;5865.3254875689845;5879.588428809942;5886.146508756292;5897.085951677497;5910.911336329958;5781.624194427349;5821.592488525847;5830.62100963436;5873.559483038704;5886.117082437669;5844.970775146182;5892.646441213541;5915.201447804578;5917.467427931507;5948.851278718067;4569.634429245652;4572.474165471013;4574.290984897346;4586.059857729158;4602.493725690171;3987.4616926715103;4024.778637174925;4065.8576949807207;4080.81636326366;4094.406311084876;5541.390447050821;5616.045272303718;5726.742296596663;5752.36723960364;5758.395368486249;5891.970540147272;5912.526997840162;5943.07882278239;5971.940280597139;5978.461938425476;5563;5584.246126772915;5586;5698.772049117989;5711.771529138871;5004.124278251292;5020.3724534433195;5058.291839142523;5071.315372424676;5073.797048118034;6049.576529642971;6086.6348019119;6096.664683442365;6112.419320164666;6134.110553969649;5773.595848290579;5821.534277257894;5914.911276330772;5936.7922122725495;5945.881082378241;5961.552883533839;6015.037593984942;6043;6077.027675571887;6108.5723999319625;5705.087186050212;5720.3707592164;5751.079827227623;5757.97121014409;5770.307563092456;5827.155062515996;5850.356460789395;5882;5897.764089436375;5926.703664816656;5759.366469688247;5770.942290577041;5788.479036886701;5804.419558044331;5825.184474173704;5829.067349224104;5859;5864.44287792659;5864.912026319694;5890.381509941394;5541.473560011793;5805;5826.242588463472;5830.679312637676;5843.065109582446;5596.468335508121;5716.5998380113;5766;5799;5892.381299963614;5720.542356611378;5736.225609542658;5769.884602307847;5770.394108618535;5782.971085144547 13:02:29 INFO - PROCESS | 15720 | |1;ext.html;555.372429155055;606.902895536714;614.6588643302968;695.506190604671;706.674929532415;43523.78238108809;44436.555634443685;49082.999999999956;49127.26309105366;49262.50737492624;49500;50609.240861387014;50773;50977.23534146991;51045;9368.110029547217;10494.317869338469;11040.944795276053;11042.558297668083;11290.548378064908;10691.465426728633;10764.73088172798;10777.730556736105;10796.730081747979;10800.189985751062;10784.838227426595;10823.458827058656;10897.945510272437;10915.563377464892;10918.07196388308;10737.570497180104;10746.785064298709;10800.675979720543;10823.621173258898;10907.236493445462;11002.064824489928;11044.392558409285;11057.11543076552;11101.278416902875;11132.554697812078;42716.14567708659;42744.145117097796;42864.35703464419;42878.356824647344;43026;4442.777861106964;4508.819647214107;4552.613027892633;4629.745364004978;4643.3731446255;31759.20601984946;31982;32025.658776128184;32988;33671;4463.933041004388;4665.300204969248;4701;4716.29255611661;4750.097481478508;387244;388043;388077;388205;388665;60852.391476084675;61350.38649613536;61396.69301653552;61501;61766.38233617696;63279;63308.36691633025;63321.36678633155;63385.36614633887;63542.36457635457;17430.65138697219;17846.28614855391;17983.820161798478;18542.629147416978;18549.81450185481;14762.63093422673;15175.16536590476;15198.772018419733;15704.450344237897;15795.21023948821;19487.22051117968;19551.413457596296;19704.507387315145;19728.802711972698;19845.60308793816;7558.886616700644;7809.3752499799875;7839.686412543549;7956.920430795618;8022.438429310009;996.476849653923;1004.0361253197012;1007.6070332570304;1010.8786945566579;1025.092792878308;33342.46807408076;34283.828580856934;34503.30993380118;34574.654253457644;34724.47913281303;1175.9882401175878;1211.787937111002;1220.1215125109907;1226.515526367098;1302.4305711617478;17982.37061702834;18046.368377107;18427;18496.167672454772;18792.71810922837;533532;536677;537540;539181;540196;71373.64313178505;71732;72050.63974680092;72308.63845680738;72558.63720681363;1534.884883633732;1571.787808645841;1585.1994742654886;1590.077754902154;1593.8007749031372;32511;32623.34753304968;32853;33092.669073308956;33105.172370689965;59697.403025969186;60549.39450605438;60634.09048864359;60908.08637870347;61009.69495152496;308807;310051;310316;311595;312165;29832.552511711907;30670.079897603107;30818.150910945416;31993;32330.030099097065;47694.52305476901;47918.28122578094;48232.7588362056;49480.75259623679;52968.73515632397;40313.59686403099;40381.394279086424;40399.59600403958;40991.18017639571;42518.574814251464;39513;40822.795886021566;41094;41394;41723.37414938718;38764.41853372145;41190.38214426846;42567.36148957706;42601.78699106609;42819.78590107154;34046.48930265998;35309.47035794517;35461;36488.635113648525;36686.63313366939;27169.184924452296;28082.438351233268;28106.578401324405;28165.718342816308;28229 13:02:29 INFO - PROCESS | 15720 | |2;jquery.html;434.8478032688557;436.78815774349414;447.65306887162455;449.85379751580734;451.2869665927834;21004.579908401844;21133.894330528365;22583.209587664434;22735.090596376147;22770.089196432124;21098.472538186554;22266.22068227612;22366.440838978993;22574.43563910903;22742.43143921403;5967.134765459016;6076.817695469143;6276.843078923041;6277.1839660844025;6288.339724328948;6010.57925945184;6137.41694539018;6160.19917410736;6163.476104531121;6168.660723660197;5958.433948774859;6086.360932102132;6121.510279177655;6132;6133.141360209552;6104.236970378703;6134;6161.938380616181;6162.352952939922;6184.721687524072;5382.407935127133;5525.972370138164;5556.305461817273;5565.916511252334;5575;25403.237902862944;25920.61119083215;26321;26339.73660263392;26501.602475962874;3271.2966712157;3400.8554116668615;3413.7781044232047;3435.055359776057;3445;15661;16147.919260403623;16173.353065877469;16366.918165409215;16845.15774211297;2075.865068770525;2120.90455929482;2132.6054679884114;2147.0874878176714;2149.4948687058527;84738.57630711868;85735;85771.57114214389;97000.51499742527;101105.99999999926;12528.686782830502;12649;12658.87341126577;12884.162529435556;12901.935490322488;18459.723104153447;18525.258989640533;18530;18596.25614975413;18631.627367452576;9395.718128456158;9470.668526601536;9579.664711735057;9614.471204083842;9623.56693948774;9024.8646270306;9076.636934522678;9150.35947483683;9213.170814626716;9337.346385753068;5230.215467679803;5305.65513241638;5357.499900027999;5367.221752845893;5464.754086066137;2159.5033142377342;2180.6728990651213;2187.8687278763327;2212.811910987552;2258.491839336169;954.4368822394821;963.4315753705207;972.5720682899502;982.749398903275;984.6264461076901;20379.388618341472;23510.17714380023;23827;24101.7589824103;24332.513349732908;1097.3251450358132;1098.0666433531594;1104.0946423932298;1109.4230999880017;1128.9379084150287;11742.647720568397;11869.347185904859;12061.276323420447;12081.335526545949;12087.395630218454;651972;684600;685727;689306;690164;113927;114154.42922785332;114212.42893785478;115506.42246788713;118486;995.124290624246;1008.5108722269694;1027.6146445083093;1038.3665963762098;1043.0508237503834;18470.722939156192;18661.626767464302;18771.71842422392;18855.24579016824;19084;40195.1960960785;42410;46670.53329466662;47511.52488475071;49307.506924931724;58454;64300.678496607215;70968.29031709617;70987;71446;9091.136342047495;9292.791937048141;9299.814003720023;9302.116298951589;9522.52387380642;10316.381017138996;13851.099678520864;13960.092593981359;14045.929770351082;14072.718545629235;11870.881291186977;12012.099092568267;12253.632391028283;12289.938550307192;12829.422675979416;11909.702257443632;11943.343116128697;11969.16215864881;12044.397780111134;12053.57812476559;12035.75928481408;12137.150399471951;12324.568640097554;12380.566680166152;12621.116521843383;9336.97293297723;9359.625614975324;9461.432314061178;9510.191633711212;9558.761030974003;12277.01783857307;12323.198992065487;12390.442430090487;12397.93801030989;12603.684907877376 13:02:29 INFO - PROCESS | 15720 | |3;mootools.html;1528.992355038225;1529.0901913361554;1533.3406635146882;1534.95311806065;1563.1637074165317;7844.803879902991;8114.066882308536;8288.17118288171;8709.695160669378;8766.780830479242;8290.170982901707;8522.53126078067;8592.269657079156;8741.562921853914;8754.606042728077;2392.5883728600124;2440.023990403844;2447.8164137689746;2452.705675318964;2463.4457247119435;2418.637204419342;2432.6107822748363;2460.889259983296;2463.6797216361847;2464.2730394533655;2416.3838221253554;2432.1001229545095;2437.9512409751796;2443.609022556391;2467.6545283660303;2358.693369861924;2374.4538756086113;2389.7968672662932;2401.86789726565;2402.5915594348826;2376.085207195225;2383.6662867198606;2432.3432673178318;2437.585610446228;2447.278052974359;8646.740597782076;8655.740327790114;8712.172343627408;8722.956385218033;8749.956250218707;5326.387465441485;5444.754986025639;5464.9453505464835;5483.972580137113;5485.862853428656;3346.330733853215;3353.094664440587;3418.5214070030215;3418.538497302857;3423.589169299675;1319.7756381415184;1321.4317843327462;1371.9245441500714;1398.286873694423;1481.3482067890093;11783.351915644636;11822.527098916033;11822.940885295604;11836.704082397922;11908;4723.740194289278;4837.685550439211;4911.533404326583;4913.926291105637;4949.208126699711;10113.140383067375;10216.335938163995;10230.335028223142;10232.846507302396;10248.538815753309;5476.698781567052;5526.088195447706;5534.169874518774;5548.0845660465575;5549.750261238254;4947.825652803449;5055.241713742968;5103.693778373309;5104.183330667075;5123.436421993578;4120.814563344657;4187.24629566681;4203.936940945889;4228.9577104228565;4269.124829409963;1292.9679900633;1296;1315.9210447372998;1318.940647670838;1326.0982531878415;802.3541049455127;860.8063185783149;864.2696921101659;870.1733353314377;882.5984177199359;5409.918851217235;5431.538319242909;5510.8071217507195;5532.86167845799;5536.557075433956;660.2440205964144;663.3399767231635;670.5574320948151;671.3420847569312;683.8734834055616;3870.632289932452;3943.408488726714;3959.6436320731273;4012.876394609514;4060.4315395844606;9891.653792117242;10262.332948358333;10263.7434064149;10266.845997310047;10294.382337059651;9732.124108830098;10143.594256229815;10152.593896244067;10189.949050254701;10413.479326033668;7901.841963160819;8091.664875295628;8110;8113.107558168596;8113.391495637851;5930.52555795544;5999.280086389486;6014.188084608697;6057.273127224761;6155.2921414037955;9288.907110928803;9572.282078843975;9573;9650.469224192737;9654.613815447303;9134.497602631918;9525;9577.686621842071;9597.760055998657;9755.414675119515;7343.632818359168;7451.664675089525;7497.362724168507;7525.983992161207;7552.546847189186;8268.793280168044;8288.378371622273;8300.70947516834;8304.875426868723;8333.83332333362;7295.598742069024;7372.741954031798;7384.96307518459;7497.250274972677;7603.505772124794;7438.776836694908;7442.181360050282;7446.813829654302;7535.6985720570565;7735.845283094419;6405.19935008124;6545.901811472737;6552.868942621216;6560.901586476111;6575.309592492719;4903.95096049035;4988.4263309719845;5007.3240112584335;5119.334486516878;5192.27308176848;4765.9046819064115;4815.566599006106;4842.564169224786;4893.266010098371;4969.577585905094 13:02:29 INFO - PROCESS | 15720 | |4;prototype.html;406.29507803960144;412.8435836403322;414.5792021098584;424.583907770385;429.31738535728186;5427.945720542793;5499.862503437416;5660.179274005267;5678.801241956532;5691.800786972457;5363.115086010804;5470.5623550116;5494.230807686917;5519.613627046108;5544.833654990347;4459.308807134891;4496.168208881351;4498.415206023229;4501.897035226374;4539.228331183706;4465.70972886763;4501.662375321864;4511.323301504768;4516.796744146522;4530.343100250462;4436.556344365554;4453.198424283628;4460.843870464534;4483.215437298476;4490.797914093873;4450.421445212101;4471.128130014648;4471.88820279494;4485.910281794362;4490.438695163105;3959.307121253769;4009.558948515661;4013.8795836124673;4038.3942408638645;4103.117829666606;5415.588179446923;5424.918626220609;5427.8058827057985;5431.375391829951;5440.6735595864375;5126.589872810204;5171.948280517222;5181.663191892515;5193.584513238932;5207.323048003773;5641.8589535261535;5802.680852553108;5872.823815285548;5874.827593099721;5898.587098903078;4407.60331570157;4413;4422.29243321067;4424.7123936944;4439.511653718088;5954.851128721773;6008.158857759917;6026.276846778371;6051.515878729691;6078.96960515199;4444.2444784386735;4546.340780586796;4548.545145485425;4566.223741963874;4590.242609969385;4581.9541804582195;4617.884552886205;4622.745748983771;4637.6289896808175;4710.222813235846;5151.6136289778415;5153.433122356538;5157.767900444489;5234.633575649744;5244.160934250502;5688.8862222755315;5826.184334193216;5896.7936122235515;5897.7935772247765;5919.348871624118;1541.6916616676485;1569.411470698488;1580.7549829776403;1581.675756469921;1586.9365225391086;1107.7869732642744;1114.1866437500669;1130.1919127823646;1133.3653154233655;1136.8863113688565;5496.532794712494;5505.6696598204235;5511.476409741068;5544.889102217933;5549.889002219933;5788.305403351625;5790.247267855236;5790.7973220937065;5821.970890145522;5852.824415267549;5386.865328366744;5517.889642207133;5542.722863856791;5559.833205003775;5586.245856809279;3086.891958781432;3094.087244262948;3099.752679307484;3104.286014216743;3126.812391256532;5866.1494083357675;5940.940590594125;5997.690889007677;6025.728842202024;6031.547633927473;5744.253247077853;5806.200077975841;5821.2141360916585;5828.562857785599;5867.596793859551;5922.851928701817;5941.999999999914;5976.252968378953;5980.43185897339;6006.849828754316;5483.13573385051;5737.6557406554075;5765.281393501252;5768.682722450306;5779.422057794187;5645.745941432728;5726.453857458546;5734.311882574118;5738.770449181986;5800.535957123504;5785.739641716049;5918.585699001201;5943.7028148591535;5957.702114894325;5974;4371.366151908019;4377.9781101094295;4400.867973960659;4415.5584441556875;4430.335449682573;5756.5748379714005;5844.444777746107;5855.502282305882;5857.677827719516;6027.156198132177;5883.705814709333;5889.38161493037;5907.734151963258;5909.468147866713;5939.287285525592;5898.20374249488;5899.38056504078;5917.733701983335;5923.703814809329;5956.136360227656;5692.971535142464;5847.561432892465;5863.296404431496;5872.559558033079;5883.676397798162;5948.8810223796145;5968.970155149196;5990.371011043778;5992.340842507234;5998.820035398945;5691.8292451226525;5818.156367326629;5818.418158184317;5848.853778655568;5895.67573783446 13:02:29 INFO - PROCESS | 15720 | |5;yui.html;813.1299509524811;837.6900546797685;849.702604088569;943.0616536546138;969.7236287658014;18152.727709084375;18956.336528221516;19023.239070437165;19042.61914761704;19075.046247687595;17719.114044297767;17830.108494575285;18457.169427375768;18821;18838.775479593816;771.6990373754227;795.5743677132735;796.0089688338028;801.791534201109;803.2168635580292;795.777182388932;798.4849771897123;799.2247519905682;801.4389927051059;802.9317508011826;830.6179157587517;834.0366876257901;839.529863276564;839.9076101628816;840.260570697785;829.2660995019421;832.4838600067997;835.5404527509845;836.7489753074053;838.8951381077366;615.9260888693385;616.848872026352;617.1668247865391;617.6448542088317;619.4394073363613;17766.46700598971;17866.910665446718;18095.909520452315;18235.17941692627;18342.816571834377;16300.755488667679;16306.347746090141;16538.751918721227;16638.25127869249;16883.493495195165;12888.420021099073;12900.419481123372;13053.738925221442;13095.607131786062;13280.601581952556;4057.513098428178;4083.673306135502;4098.610631989956;4117.958820411817;4240.957590424118;85757.57121214416;86819;86869.99999999937;86938;88270;12599.30703811281;12684.746305073846;12685.112042157145;12748.681282967815;12958.28729419891;24564.385890352885;24773.876130619232;25001;25146.622800658006;25275.368115797253;8704.086070962585;8710.52092134926;8710.69512567057;8800.251978581764;8941.731748047569;4596.477790985065;4691.319758634979;4710.29345598163;4774.71351718891;4792.448868380181;3922.195949830335;3998.220347032359;4020.638142567183;4040.8383664653675;4068.105016896278;643.9034144878306;655.6492276631978;658.252882977814;658.5127006015609;667.9298673639295;694.5242508881432;696.0637941968045;703.4021082080191;722.1911459165768;727.8798998165349;11084.61203857861;11343.489542970587;11460.19778615489;11496.827547586792;11611.129165312635;850.3622283287534;868.5917618719192;875.3172525430175;875.5403413207989;877.5349064995562;5410.567154627621;5496.148097044885;5534.418886016991;5632.887342253214;5658.801941932013;86150;86818.13181868101;88049;88118.10477003794;89393.55303223443;60244;61734;72470;74597;75827;60777.69611151916;63226.68386658037;63726.68136659287;63925;64210.357896420435;10263.84604230952;11298.887011129784;11850.170488065753;11873.584424545099;12032.699182520508;43237.3514397278;44071.576063316825;45477.54522454733;46048.309275360225;46121;56640;56785.71607141938;57523.71238143783;59060.11409828942;59568.40431595802;15325.417766051047;15635.76546351783;15692.76460853111;15733;15782.842171578137;16677.749833752747;16919.069451180305;16943.491695249162;16967.321307147577;16975.320987160376;15694.21528923572;15702.136382499073;16042.278097485409;16363.345466181696;16839.24223409925;14635.414583416545;14866.925665371604;14902.552923412315;15250.847491525386;15596.92201538985;15580.532584022498;15744.68510629758;15775;15801.20993950321;15952.601184970468;11029.22795404314;11093.667189984313;11493.597724079616;11589.942050289694;11629.127815413709;10828.945855270673;11360.431978400882;11363.147763917574;11401.315921044765;11569.132315076235 13:02:29 INFO - PROCESS | 15720 | __end_tp_report 13:02:29 INFO - PROCESS | 15720 | __start_cc_report 13:02:29 INFO - PROCESS | 15720 | _x_x_mozilla_cycle_collect,309 13:02:29 INFO - PROCESS | 15720 | __end_cc_report 13:02:29 INFO - PROCESS | 15720 | __startTimestamp1486328549605__endTimestamp 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | ------- Summary: start ------- 13:02:29 INFO - PROCESS | 15720 | Number of tests: 6 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#0] dojo.html Cycles:165 Average:5502.06 Median:5752.91 stddev:590.70 (10.3%) stddev-sans-first:566.20 13:02:29 INFO - PROCESS | 15720 | Values: 3279.8 3310.1 3337.6 3341.8 3346.9 5448.8 5465.0 5483.8 5508.0 5542.6 5510.3 5543.4 5558.1 5572.1 5606.2 5047.7 5076.5 5114.9 5130.6 5155.7 5091.9 5126.9 5135.0 5139.6 5152.2 4941.4 4964.2 5150.7 5162.6 5164.3 5042.7 5056.3 5057.0 5081.9 5125.7 5048.6 5073.6 5083.7 5106.8 5114.5 5503.5 5513.7 5593.0 5600.9 5604.5 5799.3 5807.7 5826.0 5835.0 5845.1 5963.7 5965.6 5970.0 5976.5 5990.7 5569.6 5573.1 5576.0 5579.1 5579.4 5779.4 5828.5 5877.2 5892.4 6006.9 5752.9 5786.0 5802.9 5807.9 5840.1 5865.3 5879.6 5886.1 5897.1 5910.9 5781.6 5821.6 5830.6 5873.6 5886.1 5845.0 5892.6 5915.2 5917.5 5948.9 4569.6 4572.5 4574.3 4586.1 4602.5 3987.5 4024.8 4065.9 4080.8 4094.4 5541.4 5616.0 5726.7 5752.4 5758.4 5892.0 5912.5 5943.1 5971.9 5978.5 5563.0 5584.2 5586.0 5698.8 5711.8 5004.1 5020.4 5058.3 5071.3 5073.8 6049.6 6086.6 6096.7 6112.4 6134.1 5773.6 5821.5 5914.9 5936.8 5945.9 5961.6 6015.0 6043.0 6077.0 6108.6 5705.1 5720.4 5751.1 5758.0 5770.3 5827.2 5850.4 5882.0 5897.8 5926.7 5759.4 5770.9 5788.5 5804.4 5825.2 5829.1 5859.0 5864.4 5864.9 5890.4 5541.5 5805.0 5826.2 5830.7 5843.1 5596.5 5716.6 5766.0 5799.0 5892.4 5720.5 5736.2 5769.9 5770.4 5783.0 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#1] ext.html Cycles:180 Average:59663.97 Median:35974.82 stddev:111715.96 (310.5%) stddev-sans-first:111941.20 13:02:29 INFO - PROCESS | 15720 | Values: 555.4 606.9 614.7 695.5 706.7 43523.8 44436.6 49083.0 49127.3 49262.5 49500.0 50609.2 50773.0 50977.2 51045.0 9368.1 10494.3 11040.9 11042.6 11290.5 10691.5 10764.7 10777.7 10796.7 10800.2 10784.8 10823.5 10897.9 10915.6 10918.1 10737.6 10746.8 10800.7 10823.6 10907.2 11002.1 11044.4 11057.1 11101.3 11132.6 42716.1 42744.1 42864.4 42878.4 43026.0 4442.8 4508.8 4552.6 4629.7 4643.4 31759.2 31982.0 32025.7 32988.0 33671.0 4463.9 4665.3 4701.0 4716.3 4750.1 387244.0 388043.0 388077.0 388205.0 388665.0 60852.4 61350.4 61396.7 61501.0 61766.4 63279.0 63308.4 63321.4 63385.4 63542.4 17430.7 17846.3 17983.8 18542.6 18549.8 14762.6 15175.2 15198.8 15704.5 15795.2 19487.2 19551.4 19704.5 19728.8 19845.6 7558.9 7809.4 7839.7 7956.9 8022.4 996.5 1004.0 1007.6 1010.9 1025.1 33342.5 34283.8 34503.3 34574.7 34724.5 1176.0 1211.8 1220.1 1226.5 1302.4 17982.4 18046.4 18427.0 18496.2 18792.7 533532.0 536677.0 537540.0 539181.0 540196.0 71373.6 71732.0 72050.6 72308.6 72558.6 1534.9 1571.8 1585.2 1590.1 1593.8 32511.0 32623.3 32853.0 33092.7 33105.2 59697.4 60549.4 60634.1 60908.1 61009.7 308807.0 310051.0 310316.0 311595.0 312165.0 29832.6 30670.1 30818.2 31993.0 32330.0 47694.5 47918.3 48232.8 49480.8 52968.7 40313.6 40381.4 40399.6 40991.2 42518.6 39513.0 40822.8 41094.0 41394.0 41723.4 38764.4 41190.4 42567.4 42601.8 42819.8 34046.5 35309.5 35461.0 36488.6 36686.6 27169.2 28082.4 28106.6 28165.7 28229.0 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#2] jquery.html Cycles:180 Average:36585.04 Median:25661.92 stddev:111856.56 (435.9%) stddev-sans-first:112137.41 13:02:29 INFO - PROCESS | 15720 | Values: 434.8 436.8 447.7 449.9 451.3 21004.6 21133.9 22583.2 22735.1 22770.1 21098.5 22266.2 22366.4 22574.4 22742.4 5967.1 6076.8 6276.8 6277.2 6288.3 6010.6 6137.4 6160.2 6163.5 6168.7 5958.4 6086.4 6121.5 6132.0 6133.1 6104.2 6134.0 6161.9 6162.4 6184.7 5382.4 5526.0 5556.3 5565.9 5575.0 25403.2 25920.6 26321.0 26339.7 26501.6 3271.3 3400.9 3413.8 3435.1 3445.0 15661.0 16147.9 16173.4 16366.9 16845.2 2075.9 2120.9 2132.6 2147.1 2149.5 84738.6 85735.0 85771.6 97000.5 101106.0 12528.7 12649.0 12658.9 12884.2 12901.9 18459.7 18525.3 18530.0 18596.3 18631.6 9395.7 9470.7 9579.7 9614.5 9623.6 9024.9 9076.6 9150.4 9213.2 9337.3 5230.2 5305.7 5357.5 5367.2 5464.8 2159.5 2180.7 2187.9 2212.8 2258.5 954.4 963.4 972.6 982.7 984.6 20379.4 23510.2 23827.0 24101.8 24332.5 1097.3 1098.1 1104.1 1109.4 1128.9 11742.6 11869.3 12061.3 12081.3 12087.4 651972.0 684600.0 685727.0 689306.0 690164.0 113927.0 114154.4 114212.4 115506.4 118486.0 995.1 1008.5 1027.6 1038.4 1043.1 18470.7 18661.6 18771.7 18855.2 19084.0 40195.2 42410.0 46670.5 47511.5 49307.5 58454.0 64300.7 70968.3 70987.0 71446.0 9091.1 9292.8 9299.8 9302.1 9522.5 10316.4 13851.1 13960.1 14045.9 14072.7 11870.9 12012.1 12253.6 12289.9 12829.4 11909.7 11943.3 11969.2 12044.4 12053.6 12035.8 12137.2 12324.6 12380.6 12621.1 9337.0 9359.6 9461.4 9510.2 9558.8 12277.0 12323.2 12390.4 12397.9 12603.7 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#3] mootools.html Cycles:180 Average:5670.36 Median:5121.39 stddev:3104.22 (60.6%) stddev-sans-first:3097.33 13:02:29 INFO - PROCESS | 15720 | Values: 1529.0 1529.1 1533.3 1535.0 1563.2 7844.8 8114.1 8288.2 8709.7 8766.8 8290.2 8522.5 8592.3 8741.6 8754.6 2392.6 2440.0 2447.8 2452.7 2463.4 2418.6 2432.6 2460.9 2463.7 2464.3 2416.4 2432.1 2438.0 2443.6 2467.7 2358.7 2374.5 2389.8 2401.9 2402.6 2376.1 2383.7 2432.3 2437.6 2447.3 8646.7 8655.7 8712.2 8723.0 8750.0 5326.4 5444.8 5464.9 5484.0 5485.9 3346.3 3353.1 3418.5 3418.5 3423.6 1319.8 1321.4 1371.9 1398.3 1481.3 11783.4 11822.5 11822.9 11836.7 11908.0 4723.7 4837.7 4911.5 4913.9 4949.2 10113.1 10216.3 10230.3 10232.8 10248.5 5476.7 5526.1 5534.2 5548.1 5549.8 4947.8 5055.2 5103.7 5104.2 5123.4 4120.8 4187.2 4203.9 4229.0 4269.1 1293.0 1296.0 1315.9 1318.9 1326.1 802.4 860.8 864.3 870.2 882.6 5409.9 5431.5 5510.8 5532.9 5536.6 660.2 663.3 670.6 671.3 683.9 3870.6 3943.4 3959.6 4012.9 4060.4 9891.7 10262.3 10263.7 10266.8 10294.4 9732.1 10143.6 10152.6 10189.9 10413.5 7901.8 8091.7 8110.0 8113.1 8113.4 5930.5 5999.3 6014.2 6057.3 6155.3 9288.9 9572.3 9573.0 9650.5 9654.6 9134.5 9525.0 9577.7 9597.8 9755.4 7343.6 7451.7 7497.4 7526.0 7552.5 8268.8 8288.4 8300.7 8304.9 8333.8 7295.6 7372.7 7385.0 7497.3 7603.5 7438.8 7442.2 7446.8 7535.7 7735.8 6405.2 6545.9 6552.9 6560.9 6575.3 4904.0 4988.4 5007.3 5119.3 5192.3 4765.9 4815.6 4842.6 4893.3 4969.6 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#4] prototype.html Cycles:180 Average:4944.49 Median:5518.75 stddev:1378.30 (25.0%) stddev-sans-first:1339.42 13:02:29 INFO - PROCESS | 15720 | Values: 406.3 412.8 414.6 424.6 429.3 5427.9 5499.9 5660.2 5678.8 5691.8 5363.1 5470.6 5494.2 5519.6 5544.8 4459.3 4496.2 4498.4 4501.9 4539.2 4465.7 4501.7 4511.3 4516.8 4530.3 4436.6 4453.2 4460.8 4483.2 4490.8 4450.4 4471.1 4471.9 4485.9 4490.4 3959.3 4009.6 4013.9 4038.4 4103.1 5415.6 5424.9 5427.8 5431.4 5440.7 5126.6 5171.9 5181.7 5193.6 5207.3 5641.9 5802.7 5872.8 5874.8 5898.6 4407.6 4413.0 4422.3 4424.7 4439.5 5954.9 6008.2 6026.3 6051.5 6079.0 4444.2 4546.3 4548.5 4566.2 4590.2 4582.0 4617.9 4622.7 4637.6 4710.2 5151.6 5153.4 5157.8 5234.6 5244.2 5688.9 5826.2 5896.8 5897.8 5919.3 1541.7 1569.4 1580.8 1581.7 1586.9 1107.8 1114.2 1130.2 1133.4 1136.9 5496.5 5505.7 5511.5 5544.9 5549.9 5788.3 5790.2 5790.8 5822.0 5852.8 5386.9 5517.9 5542.7 5559.8 5586.2 3086.9 3094.1 3099.8 3104.3 3126.8 5866.1 5940.9 5997.7 6025.7 6031.5 5744.3 5806.2 5821.2 5828.6 5867.6 5922.9 5942.0 5976.3 5980.4 6006.8 5483.1 5737.7 5765.3 5768.7 5779.4 5645.7 5726.5 5734.3 5738.8 5800.5 5785.7 5918.6 5943.7 5957.7 5974.0 4371.4 4378.0 4400.9 4415.6 4430.3 5756.6 5844.4 5855.5 5857.7 6027.2 5883.7 5889.4 5907.7 5909.5 5939.3 5898.2 5899.4 5917.7 5923.7 5956.1 5693.0 5847.6 5863.3 5872.6 5883.7 5948.9 5969.0 5990.4 5992.3 5998.8 5691.8 5818.2 5818.4 5848.9 5895.7 13:02:29 INFO - PROCESS | 15720 | 13:02:29 INFO - PROCESS | 15720 | [#5] yui.html Cycles:180 Average:19204.95 Median:43654.46 stddev:23840.62 (54.6%) stddev-sans-first:23867.49 13:02:29 INFO - PROCESS | 15720 | Values: 813.1 837.7 849.7 943.1 969.7 18152.7 18956.3 19023.2 19042.6 19075.0 17719.1 17830.1 18457.2 18821.0 18838.8 771.7 795.6 796.0 801.8 803.2 795.8 798.5 799.2 801.4 802.9 830.6 834.0 839.5 839.9 840.3 829.3 832.5 835.5 836.7 838.9 615.9 616.8 617.2 617.6 619.4 17766.5 17866.9 18095.9 18235.2 18342.8 16300.8 16306.3 16538.8 16638.3 16883.5 12888.4 12900.4 13053.7 13095.6 13280.6 4057.5 4083.7 4098.6 4118.0 4241.0 85757.6 86819.0 86870.0 86938.0 88270.0 12599.3 12684.7 12685.1 12748.7 12958.3 24564.4 24773.9 25001.0 25146.6 25275.4 8704.1 8710.5 8710.7 8800.3 8941.7 4596.5 4691.3 4710.3 4774.7 4792.4 3922.2 3998.2 4020.6 4040.8 4068.1 643.9 655.6 658.3 658.5 667.9 694.5 696.1 703.4 722.2 727.9 11084.6 11343.5 11460.2 11496.8 11611.1 850.4 868.6 875.3 875.5 877.5 5410.6 5496.1 5534.4 5632.9 5658.8 86150.0 86818.1 88049.0 88118.1 89393.6 60244.0 61734.0 72470.0 74597.0 75827.0 60777.7 63226.7 63726.7 63925.0 64210.4 10263.8 11298.9 11850.2 11873.6 12032.7 43237.4 44071.6 45477.5 46048.3 46121.0 56640.0 56785.7 57523.7 59060.1 59568.4 15325.4 15635.8 15692.8 15733.0 15782.8 16677.7 16919.1 16943.5 16967.3 16975.3 15694.2 15702.1 16042.3 16363.3 16839.2 14635.4 14866.9 14902.6 15250.8 15596.9 15580.5 15744.7 15775.0 15801.2 15952.6 11029.2 11093.7 11493.6 11589.9 11629.1 10828.9 11360.4 11363.1 11401.3 11569.1 13:02:29 INFO - PROCESS | 15720 | -------- Summary: end -------- 13:02:29 INFO - PROCESS | 15720 | 13:02:30 INFO - TEST-INFO | 15720: exit 0 13:02:30 INFO - TEST-OK | dromaeo_css | took 1112171ms 13:02:30 INFO - TEST-START | kraken 13:02:30 INFO - operating with platform_type : linux_ 13:02:30 INFO - Initialising browser for kraken test... 13:02:30 INFO - TEST-INFO | started process 16087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1koDhX/profile http://localhost:56405/getInfo.html) 13:02:34 INFO - PROCESS | 16087 | __metrics Screen width/height:1600/1200 13:02:34 INFO - PROCESS | 16087 | colorDepth:24 13:02:34 INFO - PROCESS | 16087 | Browser inner width/height: 1024/697 13:02:34 INFO - PROCESS | 16087 | __metrics 13:02:35 INFO - PROCESS | 16087 | 1486328555415 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp1koDhX/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp1koDhX/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp1koDhX/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp1koDhX/profile/extensions/talos-powers@TalosPowersService.js:55:9 13:02:35 ERROR - PROCESS | 16087 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 13:02:36 INFO - TEST-INFO | 16087: exit 0 13:02:36 INFO - Browser initialized. 13:02:36 INFO - Running cycle 1/1 for kraken test... 13:02:36 INFO - TEST-INFO | started process 16214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1koDhX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:02:48 INFO - PROCESS | 16214 | RSS: Main: 144834560 13:02:48 INFO - PROCESS | 16214 | 13:02:50 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56405/tests/kraken/driver.html?testName=audio-beat-detection) 13:02:51 INFO - PROCESS | 16214 | RSS: Main: 151711744 13:02:51 INFO - PROCESS | 16214 | 13:02:54 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56405/tests/kraken/driver.html?testName=audio-dft) 13:02:54 INFO - PROCESS | 16214 | RSS: Main: 150712320 13:02:54 INFO - PROCESS | 16214 | 13:02:57 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56405/tests/kraken/driver.html?testName=audio-fft) 13:02:58 INFO - PROCESS | 16214 | RSS: Main: 150720512 13:02:58 INFO - PROCESS | 16214 | 13:03:00 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56405/tests/kraken/driver.html?testName=audio-oscillator) 13:03:01 INFO - PROCESS | 16214 | RSS: Main: 150966272 13:03:01 INFO - PROCESS | 16214 | 13:03:03 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56405/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:03:03 INFO - PROCESS | 16214 | RSS: Main: 150290432 13:03:03 INFO - PROCESS | 16214 | 13:03:06 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56405/tests/kraken/driver.html?testName=imaging-darkroom) 13:03:07 INFO - PROCESS | 16214 | RSS: Main: 153796608 13:03:07 INFO - PROCESS | 16214 | 13:03:10 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56405/tests/kraken/driver.html?testName=imaging-desaturate) 13:03:11 INFO - PROCESS | 16214 | RSS: Main: 153976832 13:03:11 INFO - PROCESS | 16214 | 13:03:14 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56405/tests/kraken/driver.html?testName=json-parse-financial) 13:03:14 INFO - PROCESS | 16214 | RSS: Main: 152772608 13:03:14 INFO - PROCESS | 16214 | 13:03:16 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56405/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:03:17 INFO - PROCESS | 16214 | RSS: Main: 152240128 13:03:17 INFO - PROCESS | 16214 | 13:03:18 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:03:19 INFO - PROCESS | 16214 | RSS: Main: 152477696 13:03:19 INFO - PROCESS | 16214 | 13:03:21 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:03:22 INFO - PROCESS | 16214 | RSS: Main: 152182784 13:03:22 INFO - PROCESS | 16214 | 13:03:24 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:03:25 INFO - PROCESS | 16214 | RSS: Main: 152150016 13:03:25 INFO - PROCESS | 16214 | 13:03:28 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:03:28 INFO - PROCESS | 16214 | RSS: Main: 152506368 13:03:28 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | Cycle 1(1): loaded http://localhost:56405/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56405/tests/kraken/driver.html?testName=ai-astar) 13:03:30 INFO - PROCESS | 16214 | RSS: Main: 154742784 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | __start_tp_report 13:03:30 INFO - PROCESS | 16214 | _x_x_mozilla_page_load 13:03:30 INFO - PROCESS | 16214 | _x_x_mozilla_page_load_details 13:03:30 INFO - PROCESS | 16214 | |i|pagename|runs| 13:03:30 INFO - PROCESS | 16214 | |0;ai-astar;104;112;113;115;113;114;114;113;114;113 13:03:30 INFO - PROCESS | 16214 | |1;audio-beat-detection;145;121;118;170;120;120;120;119;134;119 13:03:30 INFO - PROCESS | 16214 | |2;audio-dft;162;162;162;160;162;163;160;163;161;162 13:03:30 INFO - PROCESS | 16214 | |3;audio-fft;76;75;76;107;78;78;78;79;103;75 13:03:30 INFO - PROCESS | 16214 | |4;audio-oscillator;84;84;106;83;82;83;91;82;83;98 13:03:30 INFO - PROCESS | 16214 | |5;imaging-gaussian-blur;117;117;118;117;117;118;118;118;117;121 13:03:30 INFO - PROCESS | 16214 | |6;imaging-darkroom;148;149;148;149;148;147;146;149;147;148 13:03:30 INFO - PROCESS | 16214 | |7;imaging-desaturate;96;96;96;96;99;97;96;97;96;96 13:03:30 INFO - PROCESS | 16214 | |8;json-parse-financial;56;55;56;54;55;57;56;56;56;60 13:03:30 INFO - PROCESS | 16214 | |9;json-stringify-tinderbox;65;65;65;65;68;66;66;66;66;66 13:03:30 INFO - PROCESS | 16214 | |10;stanford-crypto-aes;77;76;77;77;77;77;79;77;76;76 13:03:30 INFO - PROCESS | 16214 | |11;stanford-crypto-ccm;123;132;123;124;133;123;128;122;170;125 13:03:30 INFO - PROCESS | 16214 | |12;stanford-crypto-pbkdf2;158;158;161;162;164;159;163;159;161;168 13:03:30 INFO - PROCESS | 16214 | |13;stanford-crypto-sha256-iterative;62;61;61;60;63;60;60;62;60;60 13:03:30 INFO - PROCESS | 16214 | __end_tp_report 13:03:30 INFO - PROCESS | 16214 | __start_cc_report 13:03:30 INFO - PROCESS | 16214 | _x_x_mozilla_cycle_collect,721 13:03:30 INFO - PROCESS | 16214 | __end_cc_report 13:03:30 INFO - PROCESS | 16214 | __startTimestamp1486328610666__endTimestamp 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | ------- Summary: start ------- 13:03:30 INFO - PROCESS | 16214 | Number of tests: 14 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.10 (2.7%) stddev-sans-first:0.88 13:03:30 INFO - PROCESS | 16214 | Values: 104.0 112.0 113.0 115.0 113.0 114.0 114.0 113.0 114.0 113.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:120.50 stddev:16.96 (14.1%) stddev-sans-first:16.92 13:03:30 INFO - PROCESS | 16214 | Values: 145.0 121.0 118.0 170.0 120.0 120.0 120.0 119.0 134.0 119.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 13:03:30 INFO - PROCESS | 16214 | Values: 162.0 162.0 162.0 160.0 162.0 163.0 160.0 163.0 161.0 162.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#3] audio-fft Cycles:10 Average:82.50 Median:77.00 stddev:11.97 (15.6%) stddev-sans-first:12.47 13:03:30 INFO - PROCESS | 16214 | Values: 76.0 75.0 76.0 107.0 78.0 78.0 78.0 79.0 103.0 75.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#4] audio-oscillator Cycles:10 Average:87.60 Median:83.50 stddev:8.24 (9.9%) stddev-sans-first:8.63 13:03:30 INFO - PROCESS | 16214 | Values: 84.0 84.0 106.0 83.0 82.0 83.0 91.0 82.0 83.0 98.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.27 13:03:30 INFO - PROCESS | 16214 | Values: 117.0 117.0 118.0 117.0 117.0 118.0 118.0 118.0 117.0 121.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 13:03:30 INFO - PROCESS | 16214 | Values: 148.0 149.0 148.0 149.0 148.0 147.0 146.0 149.0 147.0 148.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 13:03:30 INFO - PROCESS | 16214 | Values: 96.0 96.0 96.0 96.0 99.0 97.0 96.0 97.0 96.0 96.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.60 (2.8%) stddev-sans-first:1.69 13:03:30 INFO - PROCESS | 16214 | Values: 56.0 55.0 56.0 54.0 55.0 57.0 56.0 56.0 56.0 60.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 13:03:30 INFO - PROCESS | 16214 | Values: 65.0 65.0 65.0 65.0 68.0 66.0 66.0 66.0 66.0 66.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:77.00 stddev:0.88 (1.1%) stddev-sans-first:0.93 13:03:30 INFO - PROCESS | 16214 | Values: 77.0 76.0 77.0 77.0 77.0 77.0 79.0 77.0 76.0 76.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:126.50 stddev:14.48 (11.4%) stddev-sans-first:15.12 13:03:30 INFO - PROCESS | 16214 | Values: 123.0 132.0 123.0 124.0 133.0 123.0 128.0 122.0 170.0 125.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:161.50 stddev:3.13 (1.9%) stddev-sans-first:3.08 13:03:30 INFO - PROCESS | 16214 | Values: 158.0 158.0 161.0 162.0 164.0 159.0 163.0 159.0 161.0 168.0 13:03:30 INFO - PROCESS | 16214 | 13:03:30 INFO - PROCESS | 16214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.90 Median:61.00 stddev:1.10 (1.8%) stddev-sans-first:1.09 13:03:30 INFO - PROCESS | 16214 | Values: 62.0 61.0 61.0 60.0 63.0 60.0 60.0 62.0 60.0 60.0 13:03:30 INFO - PROCESS | 16214 | -------- Summary: end -------- 13:03:30 INFO - PROCESS | 16214 | 13:03:31 INFO - TEST-INFO | 16214: exit 0 13:03:31 INFO - TEST-OK | kraken | took 61270ms 13:03:31 INFO - SUITE-END | took 1173s 13:03:31 INFO - Completed test suite (00:19:33) 13:03:31 INFO - javascript benchmark 13:03:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7664.722192563442, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3279.7868138571007, 3310.0897253255357, 3337.5828021497327, 3341.7994920304777, 3346.866125354986, 5448.782048718052, 5465.0, 5483.8080667176655, 5508.0, 5542.584306177033, 5510.311211098613, 5543.390227075029, 5558.110702287635, 5572.080606699889, 5606.159076138581, 5047.697138171712, 5076.517730815585, 5114.872128196787, 5130.640855140142, 5155.664881782691, 5091.923621145667, 5126.871828204306, 5134.974325128369, 5139.58883289336, 5152.227165925104, 4941.407031156266, 4964.205727083668, 5150.716710580917, 5162.561182299509, 5164.251183578379, 5042.722650254234, 5056.2921191033465, 5056.988602279559, 5081.949180508222, 5125.743712814345, 5048.570871475892, 5073.568746656501, 5083.669561478529, 5106.770195341219, 5114.539691427789, 5503.477169668875, 5513.724313784335, 5592.972035139798, 5600.907822974522, 5604.495595396393, 5799.3040835100055, 5807.709614519257, 5826.038703613898, 5835.0, 5845.1232315153065, 5963.731632076567, 5965.642061476326, 5970.0, 5976.462118409364, 5990.700464976734, 5569.610127291091, 5573.108302671553, 5575.968445837533, 5579.0515612346, 5579.358373786985, 5779.3642699303045, 5828.504577110908, 5877.206577112121, 5892.351841297454, 6006.939930600638, 5752.913706294409, 5786.04530252512, 5802.941970580325, 5807.8548036299435, 5840.065589505743, 5865.3254875689845, 5879.588428809942, 5886.146508756292, 5897.085951677497, 5910.911336329958, 5781.624194427349, 5821.592488525847, 5830.62100963436, 5873.559483038704, 5886.117082437669, 5844.970775146182, 5892.646441213541, 5915.201447804578, 5917.467427931507, 5948.851278718067, 4569.634429245652, 4572.474165471013, 4574.290984897346, 4586.059857729158, 4602.493725690171, 3987.4616926715103, 4024.778637174925, 4065.8576949807207, 4080.81636326366, 4094.406311084876, 5541.390447050821, 5616.045272303718, 5726.742296596663, 5752.36723960364, 5758.395368486249, 5891.970540147272, 5912.526997840162, 5943.07882278239, 5971.940280597139, 5978.461938425476, 5563.0, 5584.246126772915, 5586.0, 5698.772049117989, 5711.771529138871, 5004.124278251292, 5020.3724534433195, 5058.291839142523, 5071.315372424676, 5073.797048118034, 6049.576529642971, 6086.6348019119, 6096.664683442365, 6112.419320164666, 6134.110553969649, 5773.595848290579, 5821.534277257894, 5914.911276330772, 5936.7922122725495, 5945.881082378241, 5961.552883533839, 6015.037593984942, 6043.0, 6077.027675571887, 6108.5723999319625, 5705.087186050212, 5720.3707592164, 5751.079827227623, 5757.97121014409, 5770.307563092456, 5827.155062515996, 5850.356460789395, 5882.0, 5897.764089436375, 5926.703664816656, 5759.366469688247, 5770.942290577041, 5788.479036886701, 5804.419558044331, 5825.184474173704, 5829.067349224104, 5859.0, 5864.44287792659, 5864.912026319694, 5890.381509941394, 5541.473560011793, 5805.0, 5826.242588463472, 5830.679312637676, 5843.065109582446, 5596.468335508121, 5716.5998380113, 5766.0, 5799.0, 5892.381299963614, 5720.542356611378, 5736.225609542658, 5769.884602307847, 5770.394108618535, 5782.971085144547], "value": 5464.53606288508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.372429155055, 606.902895536714, 614.6588643302968, 695.506190604671, 706.674929532415, 43523.78238108809, 44436.555634443685, 49082.999999999956, 49127.26309105366, 49262.50737492624, 49500.0, 50609.240861387014, 50773.0, 50977.23534146991, 51045.0, 9368.110029547217, 10494.317869338469, 11040.944795276053, 11042.558297668083, 11290.548378064908, 10691.465426728633, 10764.73088172798, 10777.730556736105, 10796.730081747979, 10800.189985751062, 10784.838227426595, 10823.458827058656, 10897.945510272437, 10915.563377464892, 10918.07196388308, 10737.570497180104, 10746.785064298709, 10800.675979720543, 10823.621173258898, 10907.236493445462, 11002.064824489928, 11044.392558409285, 11057.11543076552, 11101.278416902875, 11132.554697812078, 42716.14567708659, 42744.145117097796, 42864.35703464419, 42878.356824647344, 43026.0, 4442.777861106964, 4508.819647214107, 4552.613027892633, 4629.745364004978, 4643.3731446255, 31759.20601984946, 31982.0, 32025.658776128184, 32988.0, 33671.0, 4463.933041004388, 4665.300204969248, 4701.0, 4716.29255611661, 4750.097481478508, 387244.0, 388043.0, 388077.0, 388205.0, 388665.0, 60852.391476084675, 61350.38649613536, 61396.69301653552, 61501.0, 61766.38233617696, 63279.0, 63308.36691633025, 63321.36678633155, 63385.36614633887, 63542.36457635457, 17430.65138697219, 17846.28614855391, 17983.820161798478, 18542.629147416978, 18549.81450185481, 14762.63093422673, 15175.16536590476, 15198.772018419733, 15704.450344237897, 15795.21023948821, 19487.22051117968, 19551.413457596296, 19704.507387315145, 19728.802711972698, 19845.60308793816, 7558.886616700644, 7809.3752499799875, 7839.686412543549, 7956.920430795618, 8022.438429310009, 996.476849653923, 1004.0361253197012, 1007.6070332570304, 1010.8786945566579, 1025.092792878308, 33342.46807408076, 34283.828580856934, 34503.30993380118, 34574.654253457644, 34724.47913281303, 1175.9882401175878, 1211.787937111002, 1220.1215125109907, 1226.515526367098, 1302.4305711617478, 17982.37061702834, 18046.368377107, 18427.0, 18496.167672454772, 18792.71810922837, 533532.0, 536677.0, 537540.0, 539181.0, 540196.0, 71373.64313178505, 71732.0, 72050.63974680092, 72308.63845680738, 72558.63720681363, 1534.884883633732, 1571.787808645841, 1585.1994742654886, 1590.077754902154, 1593.8007749031372, 32511.0, 32623.34753304968, 32853.0, 33092.669073308956, 33105.172370689965, 59697.403025969186, 60549.39450605438, 60634.09048864359, 60908.08637870347, 61009.69495152496, 308807.0, 310051.0, 310316.0, 311595.0, 312165.0, 29832.552511711907, 30670.079897603107, 30818.150910945416, 31993.0, 32330.030099097065, 47694.52305476901, 47918.28122578094, 48232.7588362056, 49480.75259623679, 52968.73515632397, 40313.59686403099, 40381.394279086424, 40399.59600403958, 40991.18017639571, 42518.574814251464, 39513.0, 40822.795886021566, 41094.0, 41394.0, 41723.37414938718, 38764.41853372145, 41190.38214426846, 42567.36148957706, 42601.78699106609, 42819.78590107154, 34046.48930265998, 35309.47035794517, 35461.0, 36488.635113648525, 36686.63313366939, 27169.184924452296, 28082.438351233268, 28106.578401324405, 28165.718342816308, 28229.0], "value": 21721.349397072387, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.8478032688557, 436.78815774349414, 447.65306887162455, 449.85379751580734, 451.2869665927834, 21004.579908401844, 21133.894330528365, 22583.209587664434, 22735.090596376147, 22770.089196432124, 21098.472538186554, 22266.22068227612, 22366.440838978993, 22574.43563910903, 22742.43143921403, 5967.134765459016, 6076.817695469143, 6276.843078923041, 6277.1839660844025, 6288.339724328948, 6010.57925945184, 6137.41694539018, 6160.19917410736, 6163.476104531121, 6168.660723660197, 5958.433948774859, 6086.360932102132, 6121.510279177655, 6132.0, 6133.141360209552, 6104.236970378703, 6134.0, 6161.938380616181, 6162.352952939922, 6184.721687524072, 5382.407935127133, 5525.972370138164, 5556.305461817273, 5565.916511252334, 5575.0, 25403.237902862944, 25920.61119083215, 26321.0, 26339.73660263392, 26501.602475962874, 3271.2966712157, 3400.8554116668615, 3413.7781044232047, 3435.055359776057, 3445.0, 15661.0, 16147.919260403623, 16173.353065877469, 16366.918165409215, 16845.15774211297, 2075.865068770525, 2120.90455929482, 2132.6054679884114, 2147.0874878176714, 2149.4948687058527, 84738.57630711868, 85735.0, 85771.57114214389, 97000.51499742527, 101105.99999999926, 12528.686782830502, 12649.0, 12658.87341126577, 12884.162529435556, 12901.935490322488, 18459.723104153447, 18525.258989640533, 18530.0, 18596.25614975413, 18631.627367452576, 9395.718128456158, 9470.668526601536, 9579.664711735057, 9614.471204083842, 9623.56693948774, 9024.8646270306, 9076.636934522678, 9150.35947483683, 9213.170814626716, 9337.346385753068, 5230.215467679803, 5305.65513241638, 5357.499900027999, 5367.221752845893, 5464.754086066137, 2159.5033142377342, 2180.6728990651213, 2187.8687278763327, 2212.811910987552, 2258.491839336169, 954.4368822394821, 963.4315753705207, 972.5720682899502, 982.749398903275, 984.6264461076901, 20379.388618341472, 23510.17714380023, 23827.0, 24101.7589824103, 24332.513349732908, 1097.3251450358132, 1098.0666433531594, 1104.0946423932298, 1109.4230999880017, 1128.9379084150287, 11742.647720568397, 11869.347185904859, 12061.276323420447, 12081.335526545949, 12087.395630218454, 651972.0, 684600.0, 685727.0, 689306.0, 690164.0, 113927.0, 114154.42922785332, 114212.42893785478, 115506.42246788713, 118486.0, 995.124290624246, 1008.5108722269694, 1027.6146445083093, 1038.3665963762098, 1043.0508237503834, 18470.722939156192, 18661.626767464302, 18771.71842422392, 18855.24579016824, 19084.0, 40195.1960960785, 42410.0, 46670.53329466662, 47511.52488475071, 49307.506924931724, 58454.0, 64300.678496607215, 70968.29031709617, 70987.0, 71446.0, 9091.136342047495, 9292.791937048141, 9299.814003720023, 9302.116298951589, 9522.52387380642, 10316.381017138996, 13851.099678520864, 13960.092593981359, 14045.929770351082, 14072.718545629235, 11870.881291186977, 12012.099092568267, 12253.632391028283, 12289.938550307192, 12829.422675979416, 11909.702257443632, 11943.343116128697, 11969.16215864881, 12044.397780111134, 12053.57812476559, 12035.75928481408, 12137.150399471951, 12324.568640097554, 12380.566680166152, 12621.116521843383, 9336.97293297723, 9359.625614975324, 9461.432314061178, 9510.191633711212, 9558.761030974003, 12277.01783857307, 12323.198992065487, 12390.442430090487, 12397.93801030989, 12603.684907877376], "value": 10400.222624760092, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1528.992355038225, 1529.0901913361554, 1533.3406635146882, 1534.95311806065, 1563.1637074165317, 7844.803879902991, 8114.066882308536, 8288.17118288171, 8709.695160669378, 8766.780830479242, 8290.170982901707, 8522.53126078067, 8592.269657079156, 8741.562921853914, 8754.606042728077, 2392.5883728600124, 2440.023990403844, 2447.8164137689746, 2452.705675318964, 2463.4457247119435, 2418.637204419342, 2432.6107822748363, 2460.889259983296, 2463.6797216361847, 2464.2730394533655, 2416.3838221253554, 2432.1001229545095, 2437.9512409751796, 2443.609022556391, 2467.6545283660303, 2358.693369861924, 2374.4538756086113, 2389.7968672662932, 2401.86789726565, 2402.5915594348826, 2376.085207195225, 2383.6662867198606, 2432.3432673178318, 2437.585610446228, 2447.278052974359, 8646.740597782076, 8655.740327790114, 8712.172343627408, 8722.956385218033, 8749.956250218707, 5326.387465441485, 5444.754986025639, 5464.9453505464835, 5483.972580137113, 5485.862853428656, 3346.330733853215, 3353.094664440587, 3418.5214070030215, 3418.538497302857, 3423.589169299675, 1319.7756381415184, 1321.4317843327462, 1371.9245441500714, 1398.286873694423, 1481.3482067890093, 11783.351915644636, 11822.527098916033, 11822.940885295604, 11836.704082397922, 11908.0, 4723.740194289278, 4837.685550439211, 4911.533404326583, 4913.926291105637, 4949.208126699711, 10113.140383067375, 10216.335938163995, 10230.335028223142, 10232.846507302396, 10248.538815753309, 5476.698781567052, 5526.088195447706, 5534.169874518774, 5548.0845660465575, 5549.750261238254, 4947.825652803449, 5055.241713742968, 5103.693778373309, 5104.183330667075, 5123.436421993578, 4120.814563344657, 4187.24629566681, 4203.936940945889, 4228.9577104228565, 4269.124829409963, 1292.9679900633, 1296.0, 1315.9210447372998, 1318.940647670838, 1326.0982531878415, 802.3541049455127, 860.8063185783149, 864.2696921101659, 870.1733353314377, 882.5984177199359, 5409.918851217235, 5431.538319242909, 5510.8071217507195, 5532.86167845799, 5536.557075433956, 660.2440205964144, 663.3399767231635, 670.5574320948151, 671.3420847569312, 683.8734834055616, 3870.632289932452, 3943.408488726714, 3959.6436320731273, 4012.876394609514, 4060.4315395844606, 9891.653792117242, 10262.332948358333, 10263.7434064149, 10266.845997310047, 10294.382337059651, 9732.124108830098, 10143.594256229815, 10152.593896244067, 10189.949050254701, 10413.479326033668, 7901.841963160819, 8091.664875295628, 8110.0, 8113.107558168596, 8113.391495637851, 5930.52555795544, 5999.280086389486, 6014.188084608697, 6057.273127224761, 6155.2921414037955, 9288.907110928803, 9572.282078843975, 9573.0, 9650.469224192737, 9654.613815447303, 9134.497602631918, 9525.0, 9577.686621842071, 9597.760055998657, 9755.414675119515, 7343.632818359168, 7451.664675089525, 7497.362724168507, 7525.983992161207, 7552.546847189186, 8268.793280168044, 8288.378371622273, 8300.70947516834, 8304.875426868723, 8333.83332333362, 7295.598742069024, 7372.741954031798, 7384.96307518459, 7497.250274972677, 7603.505772124794, 7438.776836694908, 7442.181360050282, 7446.813829654302, 7535.6985720570565, 7735.845283094419, 6405.19935008124, 6545.901811472737, 6552.868942621216, 6560.901586476111, 6575.309592492719, 4903.95096049035, 4988.4263309719845, 5007.3240112584335, 5119.334486516878, 5192.27308176848, 4765.9046819064115, 4815.566599006106, 4842.564169224786, 4893.266010098371, 4969.577585905094], "value": 4573.460874522642, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.29507803960144, 412.8435836403322, 414.5792021098584, 424.583907770385, 429.31738535728186, 5427.945720542793, 5499.862503437416, 5660.179274005267, 5678.801241956532, 5691.800786972457, 5363.115086010804, 5470.5623550116, 5494.230807686917, 5519.613627046108, 5544.833654990347, 4459.308807134891, 4496.168208881351, 4498.415206023229, 4501.897035226374, 4539.228331183706, 4465.70972886763, 4501.662375321864, 4511.323301504768, 4516.796744146522, 4530.343100250462, 4436.556344365554, 4453.198424283628, 4460.843870464534, 4483.215437298476, 4490.797914093873, 4450.421445212101, 4471.128130014648, 4471.88820279494, 4485.910281794362, 4490.438695163105, 3959.307121253769, 4009.558948515661, 4013.8795836124673, 4038.3942408638645, 4103.117829666606, 5415.588179446923, 5424.918626220609, 5427.8058827057985, 5431.375391829951, 5440.6735595864375, 5126.589872810204, 5171.948280517222, 5181.663191892515, 5193.584513238932, 5207.323048003773, 5641.8589535261535, 5802.680852553108, 5872.823815285548, 5874.827593099721, 5898.587098903078, 4407.60331570157, 4413.0, 4422.29243321067, 4424.7123936944, 4439.511653718088, 5954.851128721773, 6008.158857759917, 6026.276846778371, 6051.515878729691, 6078.96960515199, 4444.2444784386735, 4546.340780586796, 4548.545145485425, 4566.223741963874, 4590.242609969385, 4581.9541804582195, 4617.884552886205, 4622.745748983771, 4637.6289896808175, 4710.222813235846, 5151.6136289778415, 5153.433122356538, 5157.767900444489, 5234.633575649744, 5244.160934250502, 5688.8862222755315, 5826.184334193216, 5896.7936122235515, 5897.7935772247765, 5919.348871624118, 1541.6916616676485, 1569.411470698488, 1580.7549829776403, 1581.675756469921, 1586.9365225391086, 1107.7869732642744, 1114.1866437500669, 1130.1919127823646, 1133.3653154233655, 1136.8863113688565, 5496.532794712494, 5505.6696598204235, 5511.476409741068, 5544.889102217933, 5549.889002219933, 5788.305403351625, 5790.247267855236, 5790.7973220937065, 5821.970890145522, 5852.824415267549, 5386.865328366744, 5517.889642207133, 5542.722863856791, 5559.833205003775, 5586.245856809279, 3086.891958781432, 3094.087244262948, 3099.752679307484, 3104.286014216743, 3126.812391256532, 5866.1494083357675, 5940.940590594125, 5997.690889007677, 6025.728842202024, 6031.547633927473, 5744.253247077853, 5806.200077975841, 5821.2141360916585, 5828.562857785599, 5867.596793859551, 5922.851928701817, 5941.999999999914, 5976.252968378953, 5980.43185897339, 6006.849828754316, 5483.13573385051, 5737.6557406554075, 5765.281393501252, 5768.682722450306, 5779.422057794187, 5645.745941432728, 5726.453857458546, 5734.311882574118, 5738.770449181986, 5800.535957123504, 5785.739641716049, 5918.585699001201, 5943.7028148591535, 5957.702114894325, 5974.0, 4371.366151908019, 4377.9781101094295, 4400.867973960659, 4415.5584441556875, 4430.335449682573, 5756.5748379714005, 5844.444777746107, 5855.502282305882, 5857.677827719516, 6027.156198132177, 5883.705814709333, 5889.38161493037, 5907.734151963258, 5909.468147866713, 5939.287285525592, 5898.20374249488, 5899.38056504078, 5917.733701983335, 5923.703814809329, 5956.136360227656, 5692.971535142464, 5847.561432892465, 5863.296404431496, 5872.559558033079, 5883.676397798162, 5948.8810223796145, 5968.970155149196, 5990.371011043778, 5992.340842507234, 5998.820035398945, 5691.8292451226525, 5818.156367326629, 5818.418158184317, 5848.853778655568, 5895.67573783446], "value": 4528.9813152109655, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.1299509524811, 837.6900546797685, 849.702604088569, 943.0616536546138, 969.7236287658014, 18152.727709084375, 18956.336528221516, 19023.239070437165, 19042.61914761704, 19075.046247687595, 17719.114044297767, 17830.108494575285, 18457.169427375768, 18821.0, 18838.775479593816, 771.6990373754227, 795.5743677132735, 796.0089688338028, 801.791534201109, 803.2168635580292, 795.777182388932, 798.4849771897123, 799.2247519905682, 801.4389927051059, 802.9317508011826, 830.6179157587517, 834.0366876257901, 839.529863276564, 839.9076101628816, 840.260570697785, 829.2660995019421, 832.4838600067997, 835.5404527509845, 836.7489753074053, 838.8951381077366, 615.9260888693385, 616.848872026352, 617.1668247865391, 617.6448542088317, 619.4394073363613, 17766.46700598971, 17866.910665446718, 18095.909520452315, 18235.17941692627, 18342.816571834377, 16300.755488667679, 16306.347746090141, 16538.751918721227, 16638.25127869249, 16883.493495195165, 12888.420021099073, 12900.419481123372, 13053.738925221442, 13095.607131786062, 13280.601581952556, 4057.513098428178, 4083.673306135502, 4098.610631989956, 4117.958820411817, 4240.957590424118, 85757.57121214416, 86819.0, 86869.99999999937, 86938.0, 88270.0, 12599.30703811281, 12684.746305073846, 12685.112042157145, 12748.681282967815, 12958.28729419891, 24564.385890352885, 24773.876130619232, 25001.0, 25146.622800658006, 25275.368115797253, 8704.086070962585, 8710.52092134926, 8710.69512567057, 8800.251978581764, 8941.731748047569, 4596.477790985065, 4691.319758634979, 4710.29345598163, 4774.71351718891, 4792.448868380181, 3922.195949830335, 3998.220347032359, 4020.638142567183, 4040.8383664653675, 4068.105016896278, 643.9034144878306, 655.6492276631978, 658.252882977814, 658.5127006015609, 667.9298673639295, 694.5242508881432, 696.0637941968045, 703.4021082080191, 722.1911459165768, 727.8798998165349, 11084.61203857861, 11343.489542970587, 11460.19778615489, 11496.827547586792, 11611.129165312635, 850.3622283287534, 868.5917618719192, 875.3172525430175, 875.5403413207989, 877.5349064995562, 5410.567154627621, 5496.148097044885, 5534.418886016991, 5632.887342253214, 5658.801941932013, 86150.0, 86818.13181868101, 88049.0, 88118.10477003794, 89393.55303223443, 60244.0, 61734.0, 72470.0, 74597.0, 75827.0, 60777.69611151916, 63226.68386658037, 63726.68136659287, 63925.0, 64210.357896420435, 10263.84604230952, 11298.887011129784, 11850.170488065753, 11873.584424545099, 12032.699182520508, 43237.3514397278, 44071.576063316825, 45477.54522454733, 46048.309275360225, 46121.0, 56640.0, 56785.71607141938, 57523.71238143783, 59060.11409828942, 59568.40431595802, 15325.417766051047, 15635.76546351783, 15692.76460853111, 15733.0, 15782.842171578137, 16677.749833752747, 16919.069451180305, 16943.491695249162, 16967.321307147577, 16975.320987160376, 15694.21528923572, 15702.136382499073, 16042.278097485409, 16363.345466181696, 16839.24223409925, 14635.414583416545, 14866.925665371604, 14902.552923412315, 15250.847491525386, 15596.92201538985, 15580.532584022498, 15744.68510629758, 15775.0, 15801.20993950321, 15952.601184970468, 11029.22795404314, 11093.667189984313, 11493.597724079616, 11589.942050289694, 11629.127815413709, 10828.945855270673, 11360.431978400882, 11363.147763917574, 11401.315921044765, 11569.132315076235], "value": 7928.725950245229, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1486.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 118.0, 170.0, 120.0, 120.0, 120.0, 119.0, 134.0, 119.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 162.0, 163.0, 160.0, 163.0, 161.0, 162.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 107.0, 78.0, 78.0, 78.0, 79.0, 103.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 106.0, 83.0, 82.0, 83.0, 91.0, 82.0, 83.0, 98.0], "value": 87.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 121.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 149.0, 148.0, 147.0, 146.0, 149.0, 147.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 99.0, 97.0, 96.0, 97.0, 96.0, 96.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 54.0, 55.0, 57.0, 56.0, 56.0, 56.0, 60.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 77.0, 77.0, 77.0, 79.0, 77.0, 76.0, 76.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 132.0, 123.0, 124.0, 133.0, 123.0, 128.0, 122.0, 170.0, 125.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 161.0, 162.0, 164.0, 159.0, 163.0, 159.0, 161.0, 168.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 60.0, 63.0, 60.0, 60.0, 62.0, 60.0, 60.0], "value": 60.9, "unit": "score"}]}]} 13:03:31 INFO - Return code: 0 13:03:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:03:31 ERROR - # TBPL SUCCESS # 13:03:31 INFO - Running post-action listener: _resource_record_post_action 13:03:31 INFO - [mozharness: 2017-02-05 21:03:31.993592Z] Finished run-tests step (success) 13:03:31 INFO - Running post-run listener: _resource_record_post_run 13:03:32 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 361537536; Read time: 28; Write time: 229572 13:03:32 INFO - TinderboxPrint: CPU usage
13.3% 13:03:32 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 13:03:32 INFO - TinderboxPrint: I/O write bytes / time
361,537,536 / 229,572 13:03:32 INFO - TinderboxPrint: CPU idle
8,226.3 (86.6%) 13:03:32 INFO - TinderboxPrint: CPU user
1,210.4 (12.7%) 13:03:32 INFO - TinderboxPrint: Swap in / out
0 / 0 13:03:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110174208; Read time: 0; Write time: 99812 13:03:32 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 266240; Write bytes: 251363328; Read time: 28; Write time: 129760 13:03:32 INFO - Running post-run listener: _upload_blobber_files 13:03:32 INFO - Blob upload gear active. 13:03:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:03:32 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 13:03:32 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:03:32 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:03:33 INFO - (blobuploader) - INFO - Open directory for files ... 13:03:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:03:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:03:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:34 INFO - (blobuploader) - INFO - Done attempting. 13:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:03:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:03:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:34 INFO - (blobuploader) - INFO - Done attempting. 13:03:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:03:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:03:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:35 INFO - (blobuploader) - INFO - Done attempting. 13:03:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:03:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:03:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:03:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:03:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:03:39 INFO - (blobuploader) - INFO - Done attempting. 13:03:39 INFO - (blobuploader) - INFO - Iteration through files over. 13:03:39 INFO - Return code: 0 13:03:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:03:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:03:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e5dc4de655c1c13e27f4ca239520ece34846f7fee41f8b84a2cd6a84ce28d643c9c2af248921dfe08b6f7f5a60aff301c4b2d0913533026580d6731a8f34df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3c7146e02896b49f2d21d3749fa22c635f9d93fc6a745d6c4969fc740f5e732bd2fdb2025091dccb616340c9923b9e12fa925764d7fb4fbb41d488a251ff059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28953a2ad48d17e82dcf3d1bd99d3b806ffd2e357ac8958ebc288168fd4736e1864d0fc6899b2f508a7ec059fc018e6a8494852e34ce9747e841d9a4959e729e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68002a91df3e6b542c043543942af8a51354320e001a5339ffb1ccc186184d62bf6e21113c31026514baa46f59a2ec1023bcb78787cc2ca1ef22cedb6a102d9"} 13:03:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:03:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:03:39 INFO - Contents: 13:03:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e5dc4de655c1c13e27f4ca239520ece34846f7fee41f8b84a2cd6a84ce28d643c9c2af248921dfe08b6f7f5a60aff301c4b2d0913533026580d6731a8f34df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3c7146e02896b49f2d21d3749fa22c635f9d93fc6a745d6c4969fc740f5e732bd2fdb2025091dccb616340c9923b9e12fa925764d7fb4fbb41d488a251ff059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28953a2ad48d17e82dcf3d1bd99d3b806ffd2e357ac8958ebc288168fd4736e1864d0fc6899b2f508a7ec059fc018e6a8494852e34ce9747e841d9a4959e729e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68002a91df3e6b542c043543942af8a51354320e001a5339ffb1ccc186184d62bf6e21113c31026514baa46f59a2ec1023bcb78787cc2ca1ef22cedb6a102d9"} 13:03:39 INFO - Running post-run listener: copy_logs_to_upload_dir 13:03:39 INFO - Copying logs to upload dir... 13:03:39 INFO - mkdir: /builds/slave/test/build/upload/logs 13:03:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.366907 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-02-05 13:03:37.912278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 13:03:37.916008) ========= 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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e5dc4de655c1c13e27f4ca239520ece34846f7fee41f8b84a2cd6a84ce28d643c9c2af248921dfe08b6f7f5a60aff301c4b2d0913533026580d6731a8f34df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3c7146e02896b49f2d21d3749fa22c635f9d93fc6a745d6c4969fc740f5e732bd2fdb2025091dccb616340c9923b9e12fa925764d7fb4fbb41d488a251ff059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28953a2ad48d17e82dcf3d1bd99d3b806ffd2e357ac8958ebc288168fd4736e1864d0fc6899b2f508a7ec059fc018e6a8494852e34ce9747e841d9a4959e729e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68002a91df3e6b542c043543942af8a51354320e001a5339ffb1ccc186184d62bf6e21113c31026514baa46f59a2ec1023bcb78787cc2ca1ef22cedb6a102d9"} build_url:https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/PlSR271pQS6rgSwu6hQVDA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e2e5dc4de655c1c13e27f4ca239520ece34846f7fee41f8b84a2cd6a84ce28d643c9c2af248921dfe08b6f7f5a60aff301c4b2d0913533026580d6731a8f34df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b3c7146e02896b49f2d21d3749fa22c635f9d93fc6a745d6c4969fc740f5e732bd2fdb2025091dccb616340c9923b9e12fa925764d7fb4fbb41d488a251ff059", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/28953a2ad48d17e82dcf3d1bd99d3b806ffd2e357ac8958ebc288168fd4736e1864d0fc6899b2f508a7ec059fc018e6a8494852e34ce9747e841d9a4959e729e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d68002a91df3e6b542c043543942af8a51354320e001a5339ffb1ccc186184d62bf6e21113c31026514baa46f59a2ec1023bcb78787cc2ca1ef22cedb6a102d9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 13:03:37.940097) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 13:03:37.940393) ========= 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=920470bf432669ad7e3a5387000001ca-1486327382.271898-48919686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 13:03:38.022426) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 13:03:38.022736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 13:03:38.023019) ========= ========= Total master_lag: 0.16 =========