builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-067 starttime: 1490829204.04 results: success (0) revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.045090) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.045561) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.045867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.062787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.063152) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-29 16:13:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 98.1M=0s 2017-03-29 16:13:24 (98.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117910 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.197785) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.198352) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014832 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:24.252620) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:13:24.253997) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 60d7a0496a3673450ddbc37ec387525148c32604 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 60d7a0496a3673450ddbc37ec387525148c32604 --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=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-29 16:13:24,928 truncating revision to first 12 chars 2017-03-29 16:13:24,928 Setting DEBUG logging. 2017-03-29 16:13:24,928 attempt 1/10 2017-03-29 16:13:24,929 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/60d7a0496a36?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-29 16:13:26,323 unpacking tar archive at: mozilla-central-60d7a0496a36/testing/mozharness/ program finished with exit code 0 elapsedTime=1.673557 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-29 16:13:25.945518) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:25.945930) ========= script_repo_revision: 60d7a0496a3673450ddbc37ec387525148c32604 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:25.946365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:25.946710) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-29 16:13:25.956193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-29 16:13:25.956563) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:26 INFO - MultiFileLogger online at 20170329 16:13:26 in /builds/slave/test 16:13:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:13:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:26 INFO - {'append_to_log': False, 16:13:26 INFO - 'base_work_dir': '/builds/slave/test', 16:13:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:13:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:26 INFO - 'branch': 'Firefox-Non-PGO', 16:13:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:26 INFO - 'config_files': ('talos/linux_config.py',), 16:13:26 INFO - 'default_actions': ('clobber', 16:13:26 INFO - 'read-buildbot-config', 16:13:26 INFO - 'download-and-extract', 16:13:26 INFO - 'populate-webroot', 16:13:26 INFO - 'create-virtualenv', 16:13:26 INFO - 'install', 16:13:26 INFO - 'run-tests'), 16:13:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:26 INFO - 'download_minidump_stackwalk': True, 16:13:26 INFO - 'download_symbols': 'ondemand', 16:13:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:26 INFO - 'gecko_profile': False, 16:13:26 INFO - 'gecko_profile_interval': 0, 16:13:26 INFO - 'installer_path': 'installer.exe', 16:13:26 INFO - 'log_level': 'info', 16:13:26 INFO - 'log_name': 'talos', 16:13:26 INFO - 'log_to_console': True, 16:13:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:26 INFO - 'opt_config_files': (), 16:13:26 INFO - 'pip_index': False, 16:13:26 INFO - 'suite': 'dromaeojs-e10s', 16:13:26 INFO - 'system_bits': '32', 16:13:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:26 INFO - 'title': 'talos-linux64-ix-067', 16:13:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:26 INFO - 'use_talos_json': True, 16:13:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:26 INFO - 'work_dir': 'build'} 16:13:26 INFO - [mozharness: 2017-03-29 23:13:26.723762Z] Running clobber step. 16:13:26 INFO - Running pre-action listener: _resource_record_pre_action 16:13:26 INFO - Running main action method: clobber 16:13:26 INFO - rmtree: /builds/slave/test/build 16:13:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:28 INFO - Running post-action listener: _resource_record_post_action 16:13:28 INFO - [mozharness: 2017-03-29 23:13:28.183365Z] Finished clobber step (success) 16:13:28 INFO - [mozharness: 2017-03-29 23:13:28.183463Z] Running read-buildbot-config step. 16:13:28 INFO - Running pre-action listener: _resource_record_pre_action 16:13:28 INFO - Running main action method: read_buildbot_config 16:13:28 INFO - Using buildbot properties: 16:13:28 INFO - { 16:13:28 INFO - "project": "", 16:13:28 INFO - "product": "firefox", 16:13:28 INFO - "who": "kwierso@gmail.com", 16:13:28 INFO - "installer_path": "public/build/target.tar.bz2", 16:13:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:13:28 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:13:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:13:28 INFO - "stage_platform": "linux64", 16:13:28 INFO - "basedir": "/builds/slave/test", 16:13:28 INFO - "buildnumber": 742, 16:13:28 INFO - "platform": "ubuntu64_hw", 16:13:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:13:28 INFO - "slavebuilddir": "test", 16:13:28 INFO - "taskId": "W0u7zhKdRrmox49-wnu8iw", 16:13:28 INFO - "branch": "mozilla-central", 16:13:28 INFO - "script_repo_revision": "production", 16:13:28 INFO - "revision": "60d7a0496a3673450ddbc37ec387525148c32604", 16:13:28 INFO - "slavename": "talos-linux64-ix-067", 16:13:28 INFO - "repo_path": "mozilla-central" 16:13:28 INFO - } 16:13:28 INFO - Finding installer, test and symbols from parent task. 16:13:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W0u7zhKdRrmox49-wnu8iw'}, attempt #1 16:13:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W0u7zhKdRrmox49-wnu8iw'}, attempt #1 16:13:29 INFO - Task dependencies: KOQbI6cGSHC6z2G0BEe_2w 16:13:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w'}, attempt #1 16:13:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 16:13:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/test_packages.json 16:13:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.crashreporter-symbols.zip 16:13:29 INFO - Running post-action listener: _resource_record_post_action 16:13:29 INFO - [mozharness: 2017-03-29 23:13:29.601503Z] Finished read-buildbot-config step (success) 16:13:29 INFO - [mozharness: 2017-03-29 23:13:29.601719Z] Running download-and-extract step. 16:13:29 INFO - Running pre-action listener: _resource_record_pre_action 16:13:29 INFO - Running main action method: download_and_extract 16:13:29 INFO - mkdir: /builds/slave/test/build/tests 16:13: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')]} 16:13:29 INFO - trying https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.test_packages.json 16:13:29 INFO - Downloading https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:13:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:13:30 INFO - Downloaded 986 bytes. 16:13:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:13:30 INFO - Using the following test package requirements: 16:13:30 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:13:30 INFO - u'common': [u'target.common.tests.zip'], 16:13:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:13:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:13:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:13:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:13:30 INFO - u'mozbase': [u'target.common.tests.zip'], 16:13:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:13:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:13:30 INFO - u'web-platform': [u'target.common.tests.zip', 16:13:30 INFO - u'target.web-platform.tests.zip'], 16:13:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:13:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:13:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip 16:13:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:13:30 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip into memory 16:13:31 INFO - Expected file size: 58224439 16:13:31 INFO - Obtained file size: 58224439 16:13:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:13:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip 16:13:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:13:41 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.common.tests.zip into memory 16:13:42 INFO - Expected file size: 58224439 16:13:42 INFO - Obtained file size: 58224439 16:13:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.talos.tests.zip 16:13:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:13:52 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.talos.tests.zip into memory 16:13:53 INFO - Expected file size: 14404171 16:13:53 INFO - Obtained file size: 14404171 16:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:53 INFO - trying https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 16:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:13:55 INFO - Downloaded 62526814 bytes. 16:13:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 16:13:55 INFO - mkdir: /builds/slave/test/properties 16:13:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:13:55 INFO - Writing to file /builds/slave/test/properties/build_url 16:13:55 INFO - Contents: 16:13:55 INFO - build_url:https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 16:13:55 INFO - Running post-action listener: _resource_record_post_action 16:13:55 INFO - Running post-action listener: set_extra_try_arguments 16:13:55 INFO - [mozharness: 2017-03-29 23:13:55.051914Z] Finished download-and-extract step (success) 16:13:55 INFO - [mozharness: 2017-03-29 23:13:55.052011Z] Running populate-webroot step. 16:13:55 INFO - Running pre-action listener: _resource_record_pre_action 16:13:55 INFO - Running main action method: populate_webroot 16:13:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:13:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:13:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:13:55 INFO - '--tppagecycles', 16:13:55 INFO - '7'], 16:13:55 INFO - 'tests': ['tsvgm']}}, 16:13:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:13:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:13:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:13:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:13:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:13:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['damp', 'tps']}, 16:13:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'tests': ['damp', 'tps']}, 16:13:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['dromaeo_dom']}, 16:13:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:13:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['basic_compositor_video']}, 16:13:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:13:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'other-e10s': {'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['a11yr', 16:13:55 INFO - 'ts_paint', 16:13:55 INFO - 'tpaint', 16:13:55 INFO - 'sessionrestore', 16:13:55 INFO - 'sessionrestore_no_auto_restore', 16:13:55 INFO - 'tabpaint']}, 16:13:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['tsvgx', 16:13:55 INFO - 'tsvgr_opacity', 16:13:55 INFO - 'tart', 16:13:55 INFO - 'tscrollx', 16:13:55 INFO - 'cart', 16:13:55 INFO - 'tsvg_static']}, 16:13:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:13:55 INFO - 'tsvgr_opacity', 16:13:55 INFO - 'tart', 16:13:55 INFO - 'tscrollx', 16:13:55 INFO - 'cart', 16:13:55 INFO - 'tsvg_static']}, 16:13:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'talos_options': ['--disable-e10s'], 16:13:55 INFO - 'tests': ['tp5o']}, 16:13:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:13:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'talos_options': ['--disable-e10s', 16:13:55 INFO - '--xperf_path', 16:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:55 INFO - 'tests': ['tp5n']}, 16:13:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:13:55 INFO - 'talos_options': ['--xperf_path', 16:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:13:55 INFO - 'tests': ['tp5n']}}, 16:13:55 INFO - 'talos.zip': {'path': '', 16:13:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:13:55 INFO - Running post-action listener: _resource_record_post_action 16:13:55 INFO - [mozharness: 2017-03-29 23:13:55.065221Z] Finished populate-webroot step (success) 16:13:55 INFO - [mozharness: 2017-03-29 23:13:55.065311Z] Running create-virtualenv step. 16:13:55 INFO - Running pre-action listener: _resource_record_pre_action 16:13:55 INFO - Running main action method: create_virtualenv 16:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 16:13:55 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 16:13:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:13:55 INFO - Using real prefix '/usr' 16:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 16:13:57 INFO - Installing pip.................done. 16:13:57 INFO - Return code: 0 16:13:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:13:57 INFO - Reading from file tmpfile_stdout 16:13:57 INFO - Output received: 16:13:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:13:57 INFO - Using env: {'DISPLAY': ':0', 16:13:57 INFO - 'HOME': '/home/cltbld', 16:13:57 INFO - 'LANG': 'en_US.UTF-8', 16:13:57 INFO - 'LANGUAGE': 'en_US:en', 16:13:57 INFO - 'LOGNAME': 'cltbld', 16:13:57 INFO - 'MAIL': '/var/mail/cltbld', 16:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:57 INFO - 'MOZ_NO_REMOTE': '1', 16:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:57 INFO - 'NO_EM_RESTART': '1', 16:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:57 INFO - 'PWD': '/builds/slave/test', 16:13:57 INFO - 'SHELL': '/bin/bash', 16:13:57 INFO - 'SHLVL': '1', 16:13:57 INFO - 'TERM': 'linux', 16:13:57 INFO - 'TMOUT': '86400', 16:13:57 INFO - 'USER': 'cltbld', 16:13:57 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:57 INFO - '_': '/tools/buildbot/bin/python'} 16:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:58 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 16:13:58 INFO - Cleaning up... 16:13:58 INFO - Return code: 0 16:13:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:13:58 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')]} 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:58 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')]} 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:58 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 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:13:58 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 16:13:58 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 16:13:58 INFO - Using env: {'DISPLAY': ':0', 16:13:58 INFO - 'HOME': '/home/cltbld', 16:13:58 INFO - 'LANG': 'en_US.UTF-8', 16:13:58 INFO - 'LANGUAGE': 'en_US:en', 16:13:58 INFO - 'LOGNAME': 'cltbld', 16:13:58 INFO - 'MAIL': '/var/mail/cltbld', 16:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:58 INFO - 'MOZ_NO_REMOTE': '1', 16:13:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:13:58 INFO - 'NO_EM_RESTART': '1', 16:13:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:58 INFO - 'PWD': '/builds/slave/test', 16:13:58 INFO - 'SHELL': '/bin/bash', 16:13:58 INFO - 'SHLVL': '1', 16:13:58 INFO - 'TERM': 'linux', 16:13:58 INFO - 'TMOUT': '86400', 16:13:58 INFO - 'USER': 'cltbld', 16:13:58 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:58 INFO - '_': '/tools/buildbot/bin/python'} 16:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:58 INFO - Downloading/unpacking psutil>=3.1.1 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:00 INFO - Installing collected packages: psutil 16:14:00 INFO - Running setup.py install for psutil 16:14:00 INFO - building 'psutil._psutil_linux' extension 16:14:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:14:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:14:00 INFO - building 'psutil._psutil_posix' extension 16:14:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:14:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:00 INFO - Successfully installed psutil 16:14:00 INFO - Cleaning up... 16:14:00 INFO - Return code: 0 16:14:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:14:01 INFO - Using env: {'DISPLAY': ':0', 16:14:01 INFO - 'HOME': '/home/cltbld', 16:14:01 INFO - 'LANG': 'en_US.UTF-8', 16:14:01 INFO - 'LANGUAGE': 'en_US:en', 16:14:01 INFO - 'LOGNAME': 'cltbld', 16:14:01 INFO - 'MAIL': '/var/mail/cltbld', 16:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:01 INFO - 'MOZ_NO_REMOTE': '1', 16:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:01 INFO - 'NO_EM_RESTART': '1', 16:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:01 INFO - 'PWD': '/builds/slave/test', 16:14:01 INFO - 'SHELL': '/bin/bash', 16:14:01 INFO - 'SHLVL': '1', 16:14:01 INFO - 'TERM': 'linux', 16:14:01 INFO - 'TMOUT': '86400', 16:14:01 INFO - 'USER': 'cltbld', 16:14:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:01 INFO - '_': '/tools/buildbot/bin/python'} 16:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:01 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 16:14:01 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 16:14:01 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 16:14:01 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 16:14:01 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 16:14:01 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 16:14:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:03 INFO - Installing collected packages: mozsystemmonitor 16:14:03 INFO - Running setup.py install for mozsystemmonitor 16:14:03 INFO - Successfully installed mozsystemmonitor 16:14:03 INFO - Cleaning up... 16:14:03 INFO - Return code: 0 16:14:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:14:03 INFO - Using env: {'DISPLAY': ':0', 16:14:03 INFO - 'HOME': '/home/cltbld', 16:14:03 INFO - 'LANG': 'en_US.UTF-8', 16:14:03 INFO - 'LANGUAGE': 'en_US:en', 16:14:03 INFO - 'LOGNAME': 'cltbld', 16:14:03 INFO - 'MAIL': '/var/mail/cltbld', 16:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:03 INFO - 'MOZ_NO_REMOTE': '1', 16:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:03 INFO - 'NO_EM_RESTART': '1', 16:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:03 INFO - 'PWD': '/builds/slave/test', 16:14:03 INFO - 'SHELL': '/bin/bash', 16:14:03 INFO - 'SHLVL': '1', 16:14:03 INFO - 'TERM': 'linux', 16:14:03 INFO - 'TMOUT': '86400', 16:14:03 INFO - 'USER': 'cltbld', 16:14:03 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:03 INFO - '_': '/tools/buildbot/bin/python'} 16:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:03 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:05 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:05 INFO - warning: no files found matching '*.txt' 16:14:05 INFO - no previously-included directories found matching 'build' 16:14:05 INFO - no previously-included directories found matching 'dist' 16:14:05 INFO - no previously-included directories found matching '.git*' 16:14:05 INFO - Installing collected packages: jsonschema, functools32 16:14:06 INFO - Running setup.py install for functools32 16:14:06 INFO - warning: no files found matching '*.txt' 16:14:06 INFO - no previously-included directories found matching 'build' 16:14:06 INFO - no previously-included directories found matching 'dist' 16:14:06 INFO - no previously-included directories found matching '.git*' 16:14:06 INFO - Successfully installed jsonschema functools32 16:14:06 INFO - Cleaning up... 16:14:06 INFO - Return code: 0 16:14:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:14:06 INFO - Using env: {'DISPLAY': ':0', 16:14:06 INFO - 'HOME': '/home/cltbld', 16:14:06 INFO - 'LANG': 'en_US.UTF-8', 16:14:06 INFO - 'LANGUAGE': 'en_US:en', 16:14:06 INFO - 'LOGNAME': 'cltbld', 16:14:06 INFO - 'MAIL': '/var/mail/cltbld', 16:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:06 INFO - 'MOZ_NO_REMOTE': '1', 16:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:06 INFO - 'NO_EM_RESTART': '1', 16:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:06 INFO - 'PWD': '/builds/slave/test', 16:14:06 INFO - 'SHELL': '/bin/bash', 16:14:06 INFO - 'SHLVL': '1', 16:14:06 INFO - 'TERM': 'linux', 16:14:06 INFO - 'TMOUT': '86400', 16:14:06 INFO - 'USER': 'cltbld', 16:14:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:06 INFO - '_': '/tools/buildbot/bin/python'} 16:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:06 INFO - Cleaning up... 16:14:06 INFO - Return code: 0 16:14:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:14:06 INFO - Using env: {'DISPLAY': ':0', 16:14:06 INFO - 'HOME': '/home/cltbld', 16:14:06 INFO - 'LANG': 'en_US.UTF-8', 16:14:06 INFO - 'LANGUAGE': 'en_US:en', 16:14:06 INFO - 'LOGNAME': 'cltbld', 16:14:06 INFO - 'MAIL': '/var/mail/cltbld', 16:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:06 INFO - 'MOZ_NO_REMOTE': '1', 16:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:06 INFO - 'NO_EM_RESTART': '1', 16:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:06 INFO - 'PWD': '/builds/slave/test', 16:14:06 INFO - 'SHELL': '/bin/bash', 16:14:06 INFO - 'SHLVL': '1', 16:14:06 INFO - 'TERM': 'linux', 16:14:06 INFO - 'TMOUT': '86400', 16:14:06 INFO - 'USER': 'cltbld', 16:14:06 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:06 INFO - '_': '/tools/buildbot/bin/python'} 16:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:06 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:09 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 16:14:09 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 16:14:09 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 16:14:09 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 16:14:09 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 16:14:09 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 16:14:09 INFO - Downloading docopt-0.6.1.tar.gz 16:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:09 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:09 INFO - Running setup.py install for blobuploader 16:14:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:09 INFO - Running setup.py install for requests 16:14:09 INFO - Running setup.py install for docopt 16:14:09 INFO - Successfully installed blobuploader requests docopt 16:14:09 INFO - Cleaning up... 16:14:10 INFO - Return code: 0 16:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:10 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')]} 16:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:10 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')]} 16:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:10 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 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:10 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 16:14:10 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 16:14:10 INFO - Using env: {'DISPLAY': ':0', 16:14:10 INFO - 'HOME': '/home/cltbld', 16:14:10 INFO - 'LANG': 'en_US.UTF-8', 16:14:10 INFO - 'LANGUAGE': 'en_US:en', 16:14:10 INFO - 'LOGNAME': 'cltbld', 16:14:10 INFO - 'MAIL': '/var/mail/cltbld', 16:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:10 INFO - 'MOZ_NO_REMOTE': '1', 16:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:10 INFO - 'NO_EM_RESTART': '1', 16:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:10 INFO - 'PWD': '/builds/slave/test', 16:14:10 INFO - 'SHELL': '/bin/bash', 16:14:10 INFO - 'SHLVL': '1', 16:14:10 INFO - 'TERM': 'linux', 16:14:10 INFO - 'TMOUT': '86400', 16:14:10 INFO - 'USER': 'cltbld', 16:14:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:10 INFO - '_': '/tools/buildbot/bin/python'} 16:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:10 INFO - Running setup.py (path:/tmp/pip-5wXOvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:10 INFO - Running setup.py (path:/tmp/pip-xTvjLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:10 INFO - Running setup.py (path:/tmp/pip-_7KeHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:10 INFO - Running setup.py (path:/tmp/pip-bzDH5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:10 INFO - Running setup.py (path:/tmp/pip-4f7ogv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:10 INFO - Running setup.py (path:/tmp/pip-ja8D8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:10 INFO - Running setup.py (path:/tmp/pip-t1CgPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:10 INFO - Running setup.py (path:/tmp/pip-Ayc1uP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:10 INFO - Running setup.py (path:/tmp/pip-DHlTEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:10 INFO - Running setup.py (path:/tmp/pip-I6lhBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:11 INFO - Running setup.py (path:/tmp/pip-Nthpx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:11 INFO - Running setup.py (path:/tmp/pip-CUPuFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:11 INFO - Running setup.py (path:/tmp/pip-6fj9Pq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:11 INFO - Running setup.py (path:/tmp/pip-Xnia3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:11 INFO - Running setup.py (path:/tmp/pip-HDLjd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:11 INFO - Running setup.py (path:/tmp/pip-Pd7ARq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:11 INFO - Running setup.py (path:/tmp/pip-SivZaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:11 INFO - Running setup.py install for manifestparser 16:14:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:11 INFO - Running setup.py install for mozcrash 16:14:11 INFO - Running setup.py install for mozdebug 16:14:11 INFO - Running setup.py install for mozdevice 16:14:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:11 INFO - Running setup.py install for mozfile 16:14:12 INFO - Running setup.py install for mozhttpd 16:14:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for mozinfo 16:14:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for mozInstall 16:14:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for mozleak 16:14:12 INFO - Running setup.py install for mozlog 16:14:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for moznetwork 16:14:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for mozprocess 16:14:12 INFO - Running setup.py install for mozprofile 16:14:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:12 INFO - Running setup.py install for mozrunner 16:14:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:13 INFO - Running setup.py install for mozscreenshot 16:14:13 INFO - Running setup.py install for moztest 16:14:13 INFO - Running setup.py install for mozversion 16:14:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:13 INFO - Cleaning up... 16:14:13 INFO - Return code: 0 16:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:13 INFO - Using env: {'DISPLAY': ':0', 16:14:13 INFO - 'HOME': '/home/cltbld', 16:14:13 INFO - 'LANG': 'en_US.UTF-8', 16:14:13 INFO - 'LANGUAGE': 'en_US:en', 16:14:13 INFO - 'LOGNAME': 'cltbld', 16:14:13 INFO - 'MAIL': '/var/mail/cltbld', 16:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:13 INFO - 'MOZ_NO_REMOTE': '1', 16:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:13 INFO - 'NO_EM_RESTART': '1', 16:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:13 INFO - 'PWD': '/builds/slave/test', 16:14:13 INFO - 'SHELL': '/bin/bash', 16:14:13 INFO - 'SHLVL': '1', 16:14:13 INFO - 'TERM': 'linux', 16:14:13 INFO - 'TMOUT': '86400', 16:14:13 INFO - 'USER': 'cltbld', 16:14:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:13 INFO - '_': '/tools/buildbot/bin/python'} 16:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:13 INFO - Running setup.py (path:/tmp/pip-JrW4pZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:13 INFO - Running setup.py (path:/tmp/pip-odPKkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:13 INFO - Running setup.py (path:/tmp/pip-u39Ker-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:13 INFO - Running setup.py (path:/tmp/pip-D_6KXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:13 INFO - Running setup.py (path:/tmp/pip-gxZGOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:14:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:13 INFO - Running setup.py (path:/tmp/pip-YJJJuf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:14 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)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:14 INFO - Running setup.py (path:/tmp/pip-SIZYa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:14 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)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:14 INFO - Running setup.py (path:/tmp/pip-qr2cPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:14 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)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:14 INFO - Running setup.py (path:/tmp/pip-K2lSJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:14 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)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:14 INFO - Running setup.py (path:/tmp/pip-N8cJOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:14 INFO - Running setup.py (path:/tmp/pip-UYwxda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:14 INFO - Running setup.py (path:/tmp/pip-Cs1Xt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:14 INFO - Running setup.py (path:/tmp/pip-Fr1cxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:14 INFO - Running setup.py (path:/tmp/pip-urfTcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:14 INFO - Running setup.py (path:/tmp/pip-vxjwgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:14 INFO - Running setup.py (path:/tmp/pip-dklCUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:14:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:14 INFO - Running setup.py (path:/tmp/pip-9AmPn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:14:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:16 INFO - Downloading blessings-1.6.tar.gz 16:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:16 INFO - Installing collected packages: blessings 16:14:16 INFO - Running setup.py install for blessings 16:14:17 INFO - Successfully installed blessings 16:14:17 INFO - Cleaning up... 16:14:17 INFO - Return code: 0 16:14:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:17 INFO - Reading from file tmpfile_stdout 16:14:17 INFO - Current package versions: 16:14:17 INFO - argparse == 1.2.1 16:14:17 INFO - blessings == 1.6 16:14:17 INFO - blobuploader == 1.2.4 16:14:17 INFO - docopt == 0.6.1 16:14:17 INFO - functools32 == 3.2.3-2 16:14:17 INFO - jsonschema == 2.5.1 16:14:17 INFO - manifestparser == 1.1 16:14:17 INFO - mozInstall == 1.12 16:14:17 INFO - mozcrash == 1.0 16:14:17 INFO - mozdebug == 0.1 16:14:17 INFO - mozdevice == 0.49 16:14:17 INFO - mozfile == 1.2 16:14:17 INFO - mozhttpd == 0.7 16:14:17 INFO - mozinfo == 0.9 16:14:17 INFO - mozleak == 0.1 16:14:17 INFO - mozlog == 3.4 16:14:17 INFO - moznetwork == 0.27 16:14:17 INFO - mozprocess == 0.25 16:14:17 INFO - mozprofile == 0.28 16:14:17 INFO - mozrunner == 6.13 16:14:17 INFO - mozscreenshot == 0.1 16:14:17 INFO - mozsystemmonitor == 0.3 16:14:17 INFO - moztest == 0.8 16:14:17 INFO - mozversion == 1.4 16:14:17 INFO - psutil == 3.1.1 16:14:17 INFO - requests == 1.2.3 16:14:17 INFO - wsgiref == 0.1.2 16:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:17 INFO - Using env: {'DISPLAY': ':0', 16:14:17 INFO - 'HOME': '/home/cltbld', 16:14:17 INFO - 'LANG': 'en_US.UTF-8', 16:14:17 INFO - 'LANGUAGE': 'en_US:en', 16:14:17 INFO - 'LOGNAME': 'cltbld', 16:14:17 INFO - 'MAIL': '/var/mail/cltbld', 16:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:17 INFO - 'MOZ_NO_REMOTE': '1', 16:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:17 INFO - 'NO_EM_RESTART': '1', 16:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:17 INFO - 'PWD': '/builds/slave/test', 16:14:17 INFO - 'SHELL': '/bin/bash', 16:14:17 INFO - 'SHLVL': '1', 16:14:17 INFO - 'TERM': 'linux', 16:14:17 INFO - 'TMOUT': '86400', 16:14:17 INFO - 'USER': 'cltbld', 16:14:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:17 INFO - '_': '/tools/buildbot/bin/python'} 16:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:14:17 INFO - Cleaning up... 16:14:17 INFO - Return code: 0 16:14:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:14: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')]} 16:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14: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')]} 16:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12251f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14c2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', '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 16:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:14:17 INFO - Using env: {'DISPLAY': ':0', 16:14:17 INFO - 'HOME': '/home/cltbld', 16:14:17 INFO - 'LANG': 'en_US.UTF-8', 16:14:17 INFO - 'LANGUAGE': 'en_US:en', 16:14:17 INFO - 'LOGNAME': 'cltbld', 16:14:17 INFO - 'MAIL': '/var/mail/cltbld', 16:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:17 INFO - 'MOZ_NO_REMOTE': '1', 16:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:17 INFO - 'NO_EM_RESTART': '1', 16:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:17 INFO - 'PWD': '/builds/slave/test', 16:14:17 INFO - 'SHELL': '/bin/bash', 16:14:17 INFO - 'SHLVL': '1', 16:14:17 INFO - 'TERM': 'linux', 16:14:17 INFO - 'TMOUT': '86400', 16:14:17 INFO - 'USER': 'cltbld', 16:14:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:17 INFO - '_': '/tools/buildbot/bin/python'} 16:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:14:17 INFO - Cleaning up... 16:14:17 INFO - Return code: 0 16:14:17 INFO - Running post-action listener: _resource_record_post_action 16:14:17 INFO - Running post-action listener: _start_resource_monitoring 16:14:17 INFO - Starting resource monitoring. 16:14:17 INFO - [mozharness: 2017-03-29 23:14:17.820792Z] Finished create-virtualenv step (success) 16:14:17 INFO - [mozharness: 2017-03-29 23:14:17.821265Z] Running install step. 16:14:17 INFO - Running pre-action listener: _resource_record_pre_action 16:14:17 INFO - Running main action method: install 16:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:18 INFO - Reading from file tmpfile_stdout 16:14:18 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:18 INFO - Reading from file tmpfile_stdout 16:14:18 INFO - Output received: 16:14:18 INFO - Usage: mozinstall [options] installer 16:14:18 INFO - Options: 16:14:18 INFO - -h, --help show this help message and exit 16:14:18 INFO - -d DEST, --destination=DEST 16:14:18 INFO - Directory to install application into. [default: 16:14:18 INFO - "/builds/slave/test"] 16:14:18 INFO - --app=APP Application being installed. [default: firefox] 16:14:18 INFO - mkdir: /builds/slave/test/build/application 16:14:18 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'] 16:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:14:33 INFO - Reading from file tmpfile_stdout 16:14:33 INFO - Output received: 16:14:33 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:33 INFO - Running post-action listener: _resource_record_post_action 16:14:33 INFO - [mozharness: 2017-03-29 23:14:33.779589Z] Finished install step (success) 16:14:33 INFO - [mozharness: 2017-03-29 23:14:33.779734Z] Running run-tests step. 16:14:33 INFO - Running pre-action listener: _resource_record_pre_action 16:14:33 INFO - Running main action method: run_tests 16:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:33 INFO - Python 2.7.3 16:14:33 INFO - Return code: 0 16:14:33 INFO - grabbing minidump binary from tooltool 16:14: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')]} 16:14:33 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 0x14c0290>, '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 0x14c0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14c1040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:33 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 16:14:33 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 16:14:33 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 16:14:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:33 INFO - Return code: 0 16:14:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:33 INFO - ENV: RUST_BACKTRACE is now 1 16:14:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 16:14:33 INFO - Using env: {'DISPLAY': ':0', 16:14:33 INFO - 'HOME': '/home/cltbld', 16:14:33 INFO - 'LANG': 'en_US.UTF-8', 16:14:33 INFO - 'LANGUAGE': 'en_US:en', 16:14:33 INFO - 'LOGNAME': 'cltbld', 16:14:33 INFO - 'MAIL': '/var/mail/cltbld', 16:14:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:33 INFO - 'MOZ_NO_REMOTE': '1', 16:14:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:33 INFO - 'NO_EM_RESTART': '1', 16:14:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:33 INFO - 'PWD': '/builds/slave/test', 16:14:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:33 INFO - 'RUST_BACKTRACE': '1', 16:14:33 INFO - 'SHELL': '/bin/bash', 16:14:33 INFO - 'SHLVL': '1', 16:14:33 INFO - 'TERM': 'linux', 16:14:33 INFO - 'TMOUT': '86400', 16:14:33 INFO - 'USER': 'cltbld', 16:14:33 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962', 16:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:33 INFO - '_': '/tools/buildbot/bin/python'} 16:14:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 16:14:34 INFO - mozversion application_buildid: 20170329224207 16:14:34 INFO - mozversion application_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 16:14:34 INFO - mozversion application_display_name: Nightly 16:14:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:34 INFO - mozversion application_name: Firefox 16:14:34 INFO - mozversion application_remotingname: firefox 16:14:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:14:34 INFO - mozversion application_vendor: Mozilla 16:14:34 INFO - mozversion application_version: 55.0a1 16:14:34 INFO - mozversion platform_buildid: 20170329224207 16:14:34 INFO - mozversion platform_changeset: 60d7a0496a3673450ddbc37ec387525148c32604 16:14:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:14:34 INFO - mozversion platform_version: 55.0a1 16:14:34 INFO - using testdate: 1490829274 16:14:34 INFO - actual date: 1490829274 16:14:34 INFO - starting webserver on 'localhost:51181' 16:14:34 INFO - SUITE-START | Running 2 tests 16:14:34 INFO - TEST-START | dromaeo_css 16:14:34 INFO - operating with platform_type : linux_ 16:14:34 INFO - Initialising browser for dromaeo_css test... 16:14:34 INFO - TEST-INFO | started process 9618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxbfIU5/profile http://localhost:51181/getInfo.html) 16:14:37 INFO - PID 9618 | __metrics Screen width/height:1600/1200 16:14:37 INFO - PID 9618 | colorDepth:24 16:14:37 INFO - PID 9618 | Browser inner width/height: 1024/697 16:14:37 INFO - PID 9618 | __metrics 16:14:38 ERROR - PID 9618 | 1490829278739 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) 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:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpxbfIU5/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpxbfIU5/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpxbfIU5/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpxbfIU5/profile/extensions/talos-powers@TalosPowersService.js:55:9 16:14:38 ERROR - PID 9618 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 16:14:39 INFO - TEST-INFO | 9618: exit 0 16:14:39 INFO - Browser initialized. 16:14:39 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:39 INFO - TEST-INFO | started process 9746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxbfIU5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:51 INFO - PID 9746 | RSS: Main: 155963392 16:14:51 INFO - PID 9746 | 16:17:56 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51181/tests/dromaeo/cssquery-ext.html) 16:18:00 INFO - PID 9746 | RSS: Main: 165875712 16:18:00 INFO - PID 9746 | 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | A coding exception was thrown and uncaught in a Task. 16:19:40 INFO - PID 9746 | 16:19:40 ERROR - PID 9746 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:19:40 INFO - PID 9746 | Full stack: 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | A coding exception was thrown and uncaught in a Task. 16:19:40 INFO - PID 9746 | 16:19:40 ERROR - PID 9746 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:19:40 INFO - PID 9746 | Full stack: 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | A coding exception was thrown and uncaught in a Task. 16:19:40 INFO - PID 9746 | 16:19:40 ERROR - PID 9746 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:19:40 INFO - PID 9746 | Full stack: 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | ************************* 16:19:40 INFO - PID 9746 | A coding exception was thrown and uncaught in a Task. 16:19:40 INFO - PID 9746 | 16:19:40 ERROR - PID 9746 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:19:40 INFO - PID 9746 | Full stack: 16:19:40 INFO - PID 9746 | ************************* 16:21:02 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-ext.html (next: http://localhost:51181/tests/dromaeo/cssquery-jquery.html) 16:21:03 INFO - PID 9746 | RSS: Main: 162217984 16:21:03 INFO - PID 9746 | 16:24:05 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51181/tests/dromaeo/cssquery-mootools.html) 16:24:05 INFO - PID 9746 | RSS: Main: 169013248 16:24:05 INFO - PID 9746 | 16:27:07 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51181/tests/dromaeo/cssquery-prototype.html) 16:27:08 INFO - PID 9746 | RSS: Main: 161935360 16:27:08 INFO - PID 9746 | 16:30:11 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51181/tests/dromaeo/cssquery-yui.html) 16:30:11 INFO - PID 9746 | RSS: Main: 168882176 16:30:11 INFO - PID 9746 | 16:33:14 INFO - PID 9746 | Cycle 1(1): loaded http://localhost:51181/tests/dromaeo/cssquery-yui.html (next: http://localhost:51181/tests/dromaeo/cssquery-dojo.html) 16:33:15 INFO - PID 9746 | RSS: Main: 161677312 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | __start_tp_report 16:33:15 INFO - PID 9746 | _x_x_mozilla_page_load 16:33:15 INFO - PID 9746 | _x_x_mozilla_page_load_details 16:33:15 INFO - PID 9746 | |i|pagename|runs| 16:33:15 INFO - PID 9746 | |0;dojo.html;2724.7002829688736;2729.6314997475333;2769.958450623241;2781.054441489893;2792.357757715724;5074.416442109158;5238.057149713055;5280.2079688046815;5346.946530534694;5364.758585863631;5179.378474583055;5201.427842937273;5273.129933560957;5307.628466007381;5382.946170538294;4773.6897101688455;4809.807607695706;4867.513248675122;4872.366592342991;4899.167141585921;4879.072976134541;4904.730239836807;4929.309896614477;4931.038447502739;4974.950250497503;4669.41632295963;4725.1730947084125;4725.929111063337;4860.1008813369635;4862.076205520975;4724.173269677793;4728.692634978715;4733.810647574093;4735.384400028009;4748.19280722278;4663.836765713184;4677.625789936831;4703.553162449562;4714.2692882602905;4716.693414928019;5077.517635824591;5126.487351264844;5133.486651334874;5140.485951404867;5145.25393817898;5442.455754424526;5442.564594832404;5457.290552228224;5464.1257398816;5548.889022219573;5547.72261386929;5582.274304340451;5588.3573389060375;5597.328320601554;5600.327960644749;5157.948420515821;5165.767540460688;5189.922151167698;5220.243064755589;5229.424763276036;5801.448862358069;5810;5832.066869300891;5838;5841.182234487175;5349.946500534945;5423.132298832168;5464.398916119224;5516.448355164452;5577.079781836032;5695.515881150066;5701.087825947829;5703.771849125988;5721.170430287668;5753.33836608787;5659.547236221092;5659.547236221092;5700.857478563069;5710.257666503411;5712.171735098387;5455.8090466834265;5509.449055094538;5613.803516876971;5619.129034999582;5628.859278517988;4760.666753327303;4761.142994261067;4765.070811191785;4780.593649539758;4812;4033.3344998075577;4038.5759495253164;4047.615476529725;4067.2678917795083;4084.7549147051272;4662.790174442158;4689.531046895351;4880.097182021337;4886.706797592155;4889.63327750413;5704.515116215085;5736.368999410061;5759.85600359986;5788.623739457006;5791.681457519792;4870.95129048705;4893.168161412568;4896.338994235733;4899.093667671492;4953.578945789576;4925.901481970269;4947.431045429822;5062.772175252123;5079.187330027178;5094.821681241138;5138.871528211825;5208.453112423293;5214.32213812202;5219.425863154974;5226.712530810842;5603.35561410443;5614.831555053355;5616.5787565931905;5639.013172694844;5643.463870932255;5201.271821944855;5208.270842082187;5210.843674689765;5211.426743058185;5212.50481204285;5447.673139611636;5473.452654734654;5490.149026900836;5499.065158923073;5515.420880807457;5536.390996990247;5573.16402539606;5616.522595579421;5619.915701264566;5625.803096891753;5383.865403364947;5402.378726446352;5436.864078398072;5493.945060549503;5521.4478552144465;5456.563474921917;5471.863203419946;5504.532114770129;5527.060399732136;5540.612157148961;5370.892582148257;5451.48210919962;5464.316960379952;5470.070088085115;5504.4770746778995;5404.243405923253;5441.401445841034;5441.7279136043835;5443.401225865231;5443.700596467074;5312.362516498045;5314;5325.307709997831;5328.067588172132;5331.600129990344 16:33:15 INFO - PID 9746 | |1;ext.html;655.4854439265177;678.4165617568891;1055.0662663542766;1065.1319174872483;1178.7760325538143;34384.4842327365;35547.82226088872;35589.64410355896;35697.643023569755;35701.82149089257;32914.835425822836;33306.33387332258;33321.50017749736;33339.33321333572;33347.66652333476;6870.484713646484;7042.190148132979;7361.889571656429;7490.737824176155;7501.924980750177;7529.0212272404515;7653.579053152074;7653.808654783619;7657.11943126542;7658.731944381948;7620.352270057052;7661.195574464685;7661.9616901915415;7679.232076792332;7712.460127791057;7598.08822941245;7631.007968964054;7632.465727399084;7655.50239234448;7667.079950405959;7264.309890560388;7340.816479587999;7342.118945726494;7363.705451781922;7379.409647228209;33978;34013.829930850436;34021.489677654856;34113.317733645184;34116;2436.2812970173663;2457.496213276274;2465.395977985387;2508.2851387354517;2548.4775620997652;23062.65406018911;23263.18578849749;23318.76681233183;24189.758102418928;24229.394265143335;2622.541055315331;2625.960610590843;2658.9734102658917;2665.7067722550505;2668.9599656005175;149849.2507537477;150736.2463187688;152069;152421;153011;33739;34018.14954626154;39733.60266397299;39921.60078399237;41140;41896;41947.37078943818;41964.790176048926;41980.37029444561;42064.36903446451;12044.39778011096;12134.27194368323;12157.817632735516;12172.939135304267;12192.329421881705;9624.51877406127;9633.566489507988;9653.131218190396;9661.13049825519;9709.951450242703;12774.105812593029;12818;12838.743225135446;13054.37495951636;13080.149790263602;5214.270002199695;5248.297126979609;5275.446078161738;5330.92003619946;5403.2165336026055;852.4927668037508;882.2324577617513;884.2447741233646;887.6759982606302;916.8899732032065;20076;21092.47268818292;21136.260230891847;21243.150273988867;21353.359399218047;957.9366902737955;958.9520523973773;979.6571200079915;986.4919566423298;991.7619771254991;10923.726906827234;10960.780784384267;11027.17296202788;11058.391788451552;11065.114790816715;224369;224389;225185;225674;227815;41900.790496047324;42121.78939105285;42150;42318.78840605777;42555.78722106432;1164.249059356727;1210.1710328425056;1215.1797536662893;1215.3376409856648;1225.828384026237;19818.50453738668;19966.700499492228;20819.8959005204;21000.894995524926;21294.574108517434;30683.846580766953;30756.231094222825;30879;30881.536776947913;30906.536401953537;207029;207725;207965;208289.95855020627;209114;28347;28428;28440.715592843808;28546.57180142341;29007;34734.65265347314;35028.82485587556;35178.29643407066;35334.116647084025;35452;27091.59362609523;27121.593176102768;27196;27665.723342766316;28038.2990425241;26851.731482685704;27063.72936270691;27095.86452067727;27907.162785116478;28174.43651127007;29432.26419339534;29596.112116636534;29698.257543561584;29875;30104;26157;26486.470270594866;26678.866605666848;26884.731152688222;27704.584431233143;21270.255541055987;21649.567008659422;21717.674234886807;21894.233701821;21972.670409944185 16:33:15 INFO - PID 9746 | |2;jquery.html;408.82420559159567;409.53926832313647;419.48193980434166;424.4439783883112;439.1809275700819;16846.747298790528;18108.637827243463;18776.624467510643;18782.90608546957;18807.623847523042;14811.481598144068;18553.350632727856;18574;18661.16024778885;18830.15264313106;5368.248445217672;5447.536959358459;5536.529395001409;5575.303087114111;5639.7180140993;5544.972275138619;5611.046122159222;5618.494335509803;5618.747156377973;5620.971895140539;5452.91820622691;5540.2243685883805;5550.972245138769;5563.916541251884;5573.665580065189;5472.753726082316;5558.166275058753;5564.304461942257;5566.721663916788;5567.638103523258;4843.685160464559;4986.775595098229;5015.648904576681;5032.370953630796;5036.84889453317;20996.895015524977;21401.57196856054;21685.67471487929;21746.456338591503;21863.562728745495;1473.6684246044554;1475.8893083018816;1478.7633978563379;1494.3798323695762;1506.5781581157294;13789.310534473336;13875.167489950636;13966.092204006707;14038;14482.058666186664;1460.5545308680848;1474.506040476431;1529.3143375698608;1550.395345815133;1562.1642421304662;85156.57421712852;86511.56744216238;86820;87366.56316718439;92214.07785922122;10716.946415267874;10964.725881853017;11045.558177672803;11077.667669969753;11117.833232501518;15236.085834849944;15255.694886102216;15296.388144474096;15352.155631440379;15376.231188440757;6989.965050174716;7178.066851309296;7370.77887663371;7405.1854296027395;7410.481266311414;6431.614103153825;6527;6557;6721.563098398588;6754.898676519856;6821.761238356634;6834.881186832098;6903.206131294865;7003.789886303419;7104.147502299757;2047.9692804607944;2053.969190462144;2061.5672107885175;2109.093089971327;2143.0784762552253;831.9126491718404;838.149278482341;866.8656358264479;879.3580686099183;882.5322579033123;16057.919710401373;16270.83729162717;17073.146342682816;17323.393681221096;17333.47999560015;868.9391742578085;873.2708188662411;873.6199753107419;876.6975393489236;882.9072947340437;8751.256143227896;9197.356185067116;9255.35212535116;9299.442033478013;9444.90555094454;496716;517253;517969;518912;522205.8897055132;90099.54950225339;90519;92526;95425.52287238519;95932;1041.7135287795766;1047.9738006549744;1062.2298833345762;1064.9094826939643;1065.9093977012042;13947.651308717363;14010.229437381042;14025.438982440588;14128.222947737562;14933.253337333308;40330.79834600808;40704.38943415792;40797.592024080564;41017.17965640611;41518.1696366077;53889;55227.44772552223;55892.72053639706;56406.71796641155;56931.43068569427;8024.518528888286;8134.308583770446;8188.426810123472;8313.833723325379;8484.787880303042;12351.629451116482;12992.415341309475;13152.80270795958;13484.258365789976;13499.122557033761;10370.792584148125;10545;10575.78848423012;10586.682399528027;10859.728506787078;10401.58393664245;10639.680809575726;10681.89318106809;10704.250702450754;10759.03168714788;10391;10455.372677639367;10492.842607360742;10584.682459526226;10914.290571112851;7958.681652733826;8131.308838748772;8138;8333.333333333352;8381.264585509169;10358.844617330595;10361.689149325532;10421;10537.89462105369;10568.735781605521 16:33:15 INFO - PID 9746 | |3;mootools.html;1231.3966156583274;1307.56850239421;1317.3808310094253;1317.4335035934548;1318.3869500682188;9332.580033898474;9684.37051591646;9696.56365463554;9964.701058968243;10181.847272290921;9877.60489580416;10061.748456288597;10109.191264698824;10109.696709098738;10116.645917392892;2206.735191776985;2246.2811900191946;2249.0553967333676;2250.8199344052437;2256.627656436686;2152.62329092409;2209.55274295336;2260.5026894083276;2262.6945362376114;2266.614675505168;2148.301801914384;2212.358416059341;2230.4646884747626;2237.9216727414546;2248.1457046322375;2100.9264675736276;2176.260071575664;2184.4757258257982;2184.7378314602192;2195.3962660268394;1834.779826420838;1902.4577995271281;2190.0363839910387;2199.4281486813384;2217.401301648562;9646.565904534313;9955.701328960144;9966.402015878997;9967.850482242773;9968.451735154564;4981.352424184869;5128.615353848476;5134.383873935114;5139.8458046258675;5148.588112950955;3238.5627940228005;3314.850831712579;3326.0520751585923;3327.550780644606;3385.356782211372;1014.0873214107362;1026.650938680852;1043.1602559939247;1051.568856768729;1066.8239740442818;14163.433462661482;14210.786838197435;14210.928945355206;14229.857701422958;14300.356483958247;4699.647526435531;4828.213560982389;4867.805287788519;4917.975410122926;4931.5315045070665;10539.789204215873;10583.84124238137;10632.627858024933;10641.308314959502;10708.411037392862;5112.923306150411;5124.359455068116;5152.5362717354865;5159.2003239497935;5167.147420675622;4465.709728867613;4534.206513860061;4676.672632915731;4696.295555666609;4736.786844592001;3797.240551889633;3804.885853424402;3828.73198876076;3844.557875844258;3948.526176858795;1121.52895783771;1134.2343917855414;1137.2096393006946;1144.8683401408778;1146.7591805720724;671.1509939925998;696.8118607975819;707.1937990690617;707.4093132234642;721.6896734404152;5285.814996475182;5288.788448462095;5317.893642127213;6574.8356291093105;6678.899816502756;823.4071468542639;828.6395417993192;832.3258160889699;833.6498670558381;861.3238607692931;3538.239278555123;3669.174435751988;3683.9079023024638;3697.8705745298785;3770.7360484765804;12058.939705301418;12611.621651350475;12724.618261452171;12771.233725976472;12847.486100555872;12496.437660305308;12735.617931462071;12753.234805911676;12856.164349317265;12998.480060797463;9170.770730731785;9309.022552632012;9314.580843862042;9481.956984731674;9521.952390238004;5891.469767720926;5901.793437229677;5929.140274660236;6098.359672234352;6129.08063790435;11462.197646164688;11508.136889733136;11543.19197656156;11689.240199387013;11721.589744358907;11469.942650286695;11747.47136378848;11751.882481175078;11774.411279435823;11799.882001180222;7836.529808211526;7983.401244906539;7984.121746607984;7990.560519171501;7990.880136797837;9066.09339066088;9229.86155207659;9354.485503297385;9390.624375024923;9405.52972351366;7126.216116227314;7243.022192004223;7279.308465695751;7356.595387253752;7466.962665186639;7016.298370162943;7029.29707029293;7072.575645461289;7114.608696521741;7178.892316615151;7149.857002860018;7220.3501684846515;7258.963705181441;7284.307990740871;7309.634518274172;5366.838994830161;5462.481064298885;5587.972060139673;5655.066913959151;5720.685362305113;5059.266406370982;5071.822486212965;5105.463926287686;5148.407933087593;5324.733763311897 16:33:15 INFO - PID 9746 | |4;prototype.html;361.1747157744554;377.1325950314276;381.61456928502207;381.64697654669425;382.0372660894546;5335.919961200585;5476.616636835423;5606.747696353664;5610.607257491977;5645.604807663465;5335.599830012755;5442.210879422481;5483.862903427416;5485.61600687952;5489.670619762817;4405.339199120133;4426.114777044588;4427.645788336941;4436.844710435135;4437.1125774844995;4338.783060846945;4401.273789824675;4417.249067658506;4422.601965823075;4427.822887084529;4371.759553224571;4379.868603941871;4388.956110438902;4390.253656878338;4399.890002749941;4373.495299841137;4373.628241599468;4380.956190438087;4389.758563279019;4398.054418300049;3852.6339997700175;3978.4430179774854;3982.6216509431556;3986.760794352348;3997;5333.35999680037;5351.866203344908;5372.677639341613;5383.596230282745;5402.432744561804;5072.239164125411;5085.949140508585;5090.261912022736;5091.428828441651;5097.974510127426;5599.692016939067;5755.568332375088;5811.970940145272;5812.88374232513;5829.970850145722;4312;4319.645793042768;4322.697411181219;4326.8269269229195;4334.176506463762;5978.252718410199;6077.905976924152;6090.208272924536;6118.908216376758;6129.816105516842;4049.8380064797666;4064.1058967027207;4065.4714887064492;4081.714280000431;4081.8163182656854;4126.216018956448;4138.213739389506;4140.544540100586;4141.565135660772;4146.37804329347;4607.401037865123;4783.473817880031;4796.400449943757;4797.040591881638;4808.2547205183255;5776.826695199066;5806.361300256968;5810.983077961424;5819.854503637358;5824.213731146326;1447.9420823166956;1462.334637739826;1463.2244910197612;1468.897177197586;1474.3144437836459;923.5733400314937;967.5549247346158;971.2278738402987;978.5841017567506;979.1579241852002;5033.094043072282;5043.899122017612;5051.393832740021;5057.317262169634;5083.771230294572;6002.729877155539;6004.42957918997;6005.489533389711;6033.129729783781;6045.6070355426755;4814.542618451242;5025.321581586439;5033.647644664911;5051;5056.544910957958;3176.634687010977;3207.1982004498877;3223.62928263248;3225.1292151119537;3243.5728279557393;5604.187392828017;5643.35101463337;5645.1532270159805;5650.689212093374;5659.434056594308;5902.84894445579;6112.755489780359;6135.386461353829;6136.478399336017;6161.938380616226;5581.469760372758;5586.497215250647;5589.860253493695;5604.3835178131185;5605.32736071674;5795.652260864362;5932.79235226765;5995.730192141451;6016.939830601813;6029.216201893726;5909.261342332208;5920.526357891445;5931.466168044896;5953.404659534012;5968.253968253968;5426.158945363475;5595.908797784393;5618.52242559387;5630.831075067755;5652.604317697722;4150.377443383517;4169.478815148106;4171.353440216772;4171.416001759695;4173.144505376451;5916.792912248051;6053.243344581927;6072.969635151796;6076.756929722938;6090.9390906090375;5756.65460072397;5806.332271788629;5812.82561523155;5813.883722325445;5819.5635327351465;5718.742656580381;5812.622179558315;5819.447152520504;5820.243368362086;5834.591578589458;5593.328800543961;5693;5733.655980641175;5749.252597162342;5753.108268218432;5859.2382990211;5880.588358815013;5881.73532191061;5886.293644762656;5906.675132867734;5455.645383050089;5669.20631111653;5694.985035549845;5700.629459085146;5716.683903652882 16:33:15 INFO - PID 9746 | |5;yui.html;593.2791658135368;604.3923164382742;613.1018058544232;613.2487702564359;620.5221979076113;11948.163628545994;12151.210171338867;12182.695432614179;12242;13242.668933276673;14487.855121448782;14498.855011449883;14655.120692758443;14662.41350345985;14672.853271467282;627.9560430769859;884.3986089459165;902.747230775384;920.6409500294891;920.8434566123775;926.735880274122;927.0544045074021;929.0384452092086;931.0875342164683;932.4451951089092;974.848898420746;980.5440470181364;983.5868935047297;984.5077461269366;984.950752462374;965.7778710896463;974.7660561465268;976.1068622210669;976.4043933200707;979.0111986893218;716.616610113592;717.2791344698545;717.6089031477857;719.8020544350293;720.697307131001;11771.882281177164;11904.345261010641;11946.223495472766;11987.160898737005;12415.255084694856;12697.809532857014;13274.402651880688;13288.86711132886;13549.627779264709;13612.387442565108;8491.448055876348;8743.431676940978;8775.429597076234;9171.770705732344;9575.138237558653;2361.327021798796;2379.6906402167606;2394.4492766663766;2401.771831675988;2409.2772168349425;54819;56372;56572.43427565754;56926.43073569253;57421;9497.24022078246;9522.190613797904;9594.136527712539;9695.466749328854;10082.546285417175;20289.89855050745;20637.58724825495;20817.1673133076;20866.686999694713;20922.581548368948;5727.77088916447;5752.741126649311;5817.214676018768;5844.532437405082;5901.970490147522;2785.3036740814796;2797.202797202787;2830.066078194232;2844.1751891951517;2882.567614857788;3449.49982252577;3490.267043920754;3497.842597083137;3506.526618906415;3562.358775420449;696.5681277607915;697.5221972948547;707.8088915992756;716.6989864257024;717.5551158281899;433.6682437934982;446.2525270172448;447.9664025198058;461.52462963148014;471.15662963296;7678.270564296383;7929.3217001969115;8073.596320184085;8143.877841832377;8149.918500814916;439.4024127187023;452.40508731018605;455.85184814934615;459.36607481675077;468.7492191677436;3412.4881267809533;3552.431610942237;3574.696150827157;3614.6023937366867;3681.7975011374097;63550.68224658939;64012.67993660095;64860.351396486374;65840.4407427041;65896;39547.40678889819;45313.320300195526;54401.72799135979;54606.45393546093;55244.72377638086;45054.774726126816;45281.320780188325;45787.084258314644;46101.30848037282;47123;7947.483413578099;8595.613197406006;8614.3108551317;8629.309655227442;8683.106761460145;24684.38289042788;24972;25020.49959000846;25552;25603;29518.114456566338;41864.58135418607;43568.34647480354;44924;45202;9806.705798826046;9958.850617240601;9966.202703783825;10018.599256029676;10159.695209143738;11018.724531886446;11150;11313.71715707114;11766.705832354259;11784.82322765142;10462.63380781669;10512.159027277647;10851.565937362417;10887.401192934465;11262.9863312299;10777.838332425177;10913.181511386836;10960.123190144928;11210.103191744804;11431.657050288504;9815.607375704893;10073.748156296151;10151.796964060824;10261.692149235534;10684.679459616224;8052.473658502678;8210.671573137246;8284.627191776504;8471.915280847114;8555.31557475413;8544.109186851614;8627.6980305689;8989;9224;9245.399049061789 16:33:15 INFO - PID 9746 | __end_tp_report 16:33:15 INFO - PID 9746 | __start_cc_report 16:33:15 INFO - PID 9746 | _x_x_mozilla_cycle_collect,368 16:33:15 INFO - PID 9746 | __end_cc_report 16:33:15 INFO - PID 9746 | __startTimestamp1490830395185__endTimestamp 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | ------- Summary: start ------- 16:33:15 INFO - PID 9746 | Number of tests: 6 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#0] dojo.html Cycles:165 Average:5165.76 Median:5312.36 stddev:578.11 (10.9%) stddev-sans-first:547.25 16:33:15 INFO - PID 9746 | Values: 2724.7 2729.6 2770.0 2781.1 2792.4 5074.4 5238.1 5280.2 5346.9 5364.8 5179.4 5201.4 5273.1 5307.6 5382.9 4773.7 4809.8 4867.5 4872.4 4899.2 4879.1 4904.7 4929.3 4931.0 4975.0 4669.4 4725.2 4725.9 4860.1 4862.1 4724.2 4728.7 4733.8 4735.4 4748.2 4663.8 4677.6 4703.6 4714.3 4716.7 5077.5 5126.5 5133.5 5140.5 5145.3 5442.5 5442.6 5457.3 5464.1 5548.9 5547.7 5582.3 5588.4 5597.3 5600.3 5157.9 5165.8 5189.9 5220.2 5229.4 5801.4 5810.0 5832.1 5838.0 5841.2 5349.9 5423.1 5464.4 5516.4 5577.1 5695.5 5701.1 5703.8 5721.2 5753.3 5659.5 5659.5 5700.9 5710.3 5712.2 5455.8 5509.4 5613.8 5619.1 5628.9 4760.7 4761.1 4765.1 4780.6 4812.0 4033.3 4038.6 4047.6 4067.3 4084.8 4662.8 4689.5 4880.1 4886.7 4889.6 5704.5 5736.4 5759.9 5788.6 5791.7 4871.0 4893.2 4896.3 4899.1 4953.6 4925.9 4947.4 5062.8 5079.2 5094.8 5138.9 5208.5 5214.3 5219.4 5226.7 5603.4 5614.8 5616.6 5639.0 5643.5 5201.3 5208.3 5210.8 5211.4 5212.5 5447.7 5473.5 5490.1 5499.1 5515.4 5536.4 5573.2 5616.5 5619.9 5625.8 5383.9 5402.4 5436.9 5493.9 5521.4 5456.6 5471.9 5504.5 5527.1 5540.6 5370.9 5451.5 5464.3 5470.1 5504.5 5404.2 5441.4 5441.7 5443.4 5443.7 5312.4 5314.0 5325.3 5328.1 5331.6 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#1] ext.html Cycles:180 Average:33336.62 Median:29786.63 stddev:51363.99 (172.4%) stddev-sans-first:51449.46 16:33:15 INFO - PID 9746 | Values: 655.5 678.4 1055.1 1065.1 1178.8 34384.5 35547.8 35589.6 35697.6 35701.8 32914.8 33306.3 33321.5 33339.3 33347.7 6870.5 7042.2 7361.9 7490.7 7501.9 7529.0 7653.6 7653.8 7657.1 7658.7 7620.4 7661.2 7662.0 7679.2 7712.5 7598.1 7631.0 7632.5 7655.5 7667.1 7264.3 7340.8 7342.1 7363.7 7379.4 33978.0 34013.8 34021.5 34113.3 34116.0 2436.3 2457.5 2465.4 2508.3 2548.5 23062.7 23263.2 23318.8 24189.8 24229.4 2622.5 2626.0 2659.0 2665.7 2669.0 149849.3 150736.2 152069.0 152421.0 153011.0 33739.0 34018.1 39733.6 39921.6 41140.0 41896.0 41947.4 41964.8 41980.4 42064.4 12044.4 12134.3 12157.8 12172.9 12192.3 9624.5 9633.6 9653.1 9661.1 9710.0 12774.1 12818.0 12838.7 13054.4 13080.1 5214.3 5248.3 5275.4 5330.9 5403.2 852.5 882.2 884.2 887.7 916.9 20076.0 21092.5 21136.3 21243.2 21353.4 957.9 959.0 979.7 986.5 991.8 10923.7 10960.8 11027.2 11058.4 11065.1 224369.0 224389.0 225185.0 225674.0 227815.0 41900.8 42121.8 42150.0 42318.8 42555.8 1164.2 1210.2 1215.2 1215.3 1225.8 19818.5 19966.7 20819.9 21000.9 21294.6 30683.8 30756.2 30879.0 30881.5 30906.5 207029.0 207725.0 207965.0 208290.0 209114.0 28347.0 28428.0 28440.7 28546.6 29007.0 34734.7 35028.8 35178.3 35334.1 35452.0 27091.6 27121.6 27196.0 27665.7 28038.3 26851.7 27063.7 27095.9 27907.2 28174.4 29432.3 29596.1 29698.3 29875.0 30104.0 26157.0 26486.5 26678.9 26884.7 27704.6 21270.3 21649.6 21717.7 21894.2 21972.7 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#2] jquery.html Cycles:180 Average:29386.74 Median:41267.67 stddev:84926.30 (205.8%) stddev-sans-first:85136.67 16:33:15 INFO - PID 9746 | Values: 408.8 409.5 419.5 424.4 439.2 16846.7 18108.6 18776.6 18782.9 18807.6 14811.5 18553.4 18574.0 18661.2 18830.2 5368.2 5447.5 5536.5 5575.3 5639.7 5545.0 5611.0 5618.5 5618.7 5621.0 5452.9 5540.2 5551.0 5563.9 5573.7 5472.8 5558.2 5564.3 5566.7 5567.6 4843.7 4986.8 5015.6 5032.4 5036.8 20996.9 21401.6 21685.7 21746.5 21863.6 1473.7 1475.9 1478.8 1494.4 1506.6 13789.3 13875.2 13966.1 14038.0 14482.1 1460.6 1474.5 1529.3 1550.4 1562.2 85156.6 86511.6 86820.0 87366.6 92214.1 10716.9 10964.7 11045.6 11077.7 11117.8 15236.1 15255.7 15296.4 15352.2 15376.2 6990.0 7178.1 7370.8 7405.2 7410.5 6431.6 6527.0 6557.0 6721.6 6754.9 6821.8 6834.9 6903.2 7003.8 7104.1 2048.0 2054.0 2061.6 2109.1 2143.1 831.9 838.1 866.9 879.4 882.5 16057.9 16270.8 17073.1 17323.4 17333.5 868.9 873.3 873.6 876.7 882.9 8751.3 9197.4 9255.4 9299.4 9444.9 496716.0 517253.0 517969.0 518912.0 522205.9 90099.5 90519.0 92526.0 95425.5 95932.0 1041.7 1048.0 1062.2 1064.9 1065.9 13947.7 14010.2 14025.4 14128.2 14933.3 40330.8 40704.4 40797.6 41017.2 41518.2 53889.0 55227.4 55892.7 56406.7 56931.4 8024.5 8134.3 8188.4 8313.8 8484.8 12351.6 12992.4 13152.8 13484.3 13499.1 10370.8 10545.0 10575.8 10586.7 10859.7 10401.6 10639.7 10681.9 10704.3 10759.0 10391.0 10455.4 10492.8 10584.7 10914.3 7958.7 8131.3 8138.0 8333.3 8381.3 10358.8 10361.7 10421.0 10537.9 10568.7 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#3] mootools.html Cycles:180 Average:6124.37 Median:4499.96 stddev:3882.04 (86.3%) stddev-sans-first:3875.52 16:33:15 INFO - PID 9746 | Values: 1231.4 1307.6 1317.4 1317.4 1318.4 9332.6 9684.4 9696.6 9964.7 10181.8 9877.6 10061.7 10109.2 10109.7 10116.6 2206.7 2246.3 2249.1 2250.8 2256.6 2152.6 2209.6 2260.5 2262.7 2266.6 2148.3 2212.4 2230.5 2237.9 2248.1 2100.9 2176.3 2184.5 2184.7 2195.4 1834.8 1902.5 2190.0 2199.4 2217.4 9646.6 9955.7 9966.4 9967.9 9968.5 4981.4 5128.6 5134.4 5139.8 5148.6 3238.6 3314.9 3326.1 3327.6 3385.4 1014.1 1026.7 1043.2 1051.6 1066.8 14163.4 14210.8 14210.9 14229.9 14300.4 4699.6 4828.2 4867.8 4918.0 4931.5 10539.8 10583.8 10632.6 10641.3 10708.4 5112.9 5124.4 5152.5 5159.2 5167.1 4465.7 4534.2 4676.7 4696.3 4736.8 3797.2 3804.9 3828.7 3844.6 3948.5 1121.5 1134.2 1137.2 1144.9 1146.8 671.2 696.8 707.2 707.4 721.7 5285.8 5288.8 5317.9 6574.8 6678.9 823.4 828.6 832.3 833.6 861.3 3538.2 3669.2 3683.9 3697.9 3770.7 12058.9 12611.6 12724.6 12771.2 12847.5 12496.4 12735.6 12753.2 12856.2 12998.5 9170.8 9309.0 9314.6 9482.0 9522.0 5891.5 5901.8 5929.1 6098.4 6129.1 11462.2 11508.1 11543.2 11689.2 11721.6 11469.9 11747.5 11751.9 11774.4 11799.9 7836.5 7983.4 7984.1 7990.6 7990.9 9066.1 9229.9 9354.5 9390.6 9405.5 7126.2 7243.0 7279.3 7356.6 7467.0 7016.3 7029.3 7072.6 7114.6 7178.9 7149.9 7220.4 7259.0 7284.3 7309.6 5366.8 5462.5 5588.0 5655.1 5720.7 5059.3 5071.8 5105.5 5148.4 5324.7 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#4] prototype.html Cycles:180 Average:4829.65 Median:5480.24 stddev:1397.96 (25.5%) stddev-sans-first:1361.05 16:33:15 INFO - PID 9746 | Values: 361.2 377.1 381.6 381.6 382.0 5335.9 5476.6 5606.7 5610.6 5645.6 5335.6 5442.2 5483.9 5485.6 5489.7 4405.3 4426.1 4427.6 4436.8 4437.1 4338.8 4401.3 4417.2 4422.6 4427.8 4371.8 4379.9 4389.0 4390.3 4399.9 4373.5 4373.6 4381.0 4389.8 4398.1 3852.6 3978.4 3982.6 3986.8 3997.0 5333.4 5351.9 5372.7 5383.6 5402.4 5072.2 5085.9 5090.3 5091.4 5098.0 5599.7 5755.6 5812.0 5812.9 5830.0 4312.0 4319.6 4322.7 4326.8 4334.2 5978.3 6077.9 6090.2 6118.9 6129.8 4049.8 4064.1 4065.5 4081.7 4081.8 4126.2 4138.2 4140.5 4141.6 4146.4 4607.4 4783.5 4796.4 4797.0 4808.3 5776.8 5806.4 5811.0 5819.9 5824.2 1447.9 1462.3 1463.2 1468.9 1474.3 923.6 967.6 971.2 978.6 979.2 5033.1 5043.9 5051.4 5057.3 5083.8 6002.7 6004.4 6005.5 6033.1 6045.6 4814.5 5025.3 5033.6 5051.0 5056.5 3176.6 3207.2 3223.6 3225.1 3243.6 5604.2 5643.4 5645.2 5650.7 5659.4 5902.8 6112.8 6135.4 6136.5 6161.9 5581.5 5586.5 5589.9 5604.4 5605.3 5795.7 5932.8 5995.7 6016.9 6029.2 5909.3 5920.5 5931.5 5953.4 5968.3 5426.2 5595.9 5618.5 5630.8 5652.6 4150.4 4169.5 4171.4 4171.4 4173.1 5916.8 6053.2 6073.0 6076.8 6090.9 5756.7 5806.3 5812.8 5813.9 5819.6 5718.7 5812.6 5819.4 5820.2 5834.6 5593.3 5693.0 5733.7 5749.3 5753.1 5859.2 5880.6 5881.7 5886.3 5906.7 5455.6 5669.2 5695.0 5700.6 5716.7 16:33:15 INFO - PID 9746 | 16:33:15 INFO - PID 9746 | [#5] yui.html Cycles:180 Average:13517.95 Median:23285.03 stddev:16723.09 (71.8%) stddev-sans-first:16741.84 16:33:15 INFO - PID 9746 | Values: 593.3 604.4 613.1 613.2 620.5 11948.2 12151.2 12182.7 12242.0 13242.7 14487.9 14498.9 14655.1 14662.4 14672.9 628.0 884.4 902.7 920.6 920.8 926.7 927.1 929.0 931.1 932.4 974.8 980.5 983.6 984.5 985.0 965.8 974.8 976.1 976.4 979.0 716.6 717.3 717.6 719.8 720.7 11771.9 11904.3 11946.2 11987.2 12415.3 12697.8 13274.4 13288.9 13549.6 13612.4 8491.4 8743.4 8775.4 9171.8 9575.1 2361.3 2379.7 2394.4 2401.8 2409.3 54819.0 56372.0 56572.4 56926.4 57421.0 9497.2 9522.2 9594.1 9695.5 10082.5 20289.9 20637.6 20817.2 20866.7 20922.6 5727.8 5752.7 5817.2 5844.5 5902.0 2785.3 2797.2 2830.1 2844.2 2882.6 3449.5 3490.3 3497.8 3506.5 3562.4 696.6 697.5 707.8 716.7 717.6 433.7 446.3 448.0 461.5 471.2 7678.3 7929.3 8073.6 8143.9 8149.9 439.4 452.4 455.9 459.4 468.7 3412.5 3552.4 3574.7 3614.6 3681.8 63550.7 64012.7 64860.4 65840.4 65896.0 39547.4 45313.3 54401.7 54606.5 55244.7 45054.8 45281.3 45787.1 46101.3 47123.0 7947.5 8595.6 8614.3 8629.3 8683.1 24684.4 24972.0 25020.5 25552.0 25603.0 29518.1 41864.6 43568.3 44924.0 45202.0 9806.7 9958.9 9966.2 10018.6 10159.7 11018.7 11150.0 11313.7 11766.7 11784.8 10462.6 10512.2 10851.6 10887.4 11263.0 10777.8 10913.2 10960.1 11210.1 11431.7 9815.6 10073.7 10151.8 10261.7 10684.7 8052.5 8210.7 8284.6 8471.9 8555.3 8544.1 8627.7 8989.0 9224.0 9245.4 16:33:15 INFO - PID 9746 | -------- Summary: end -------- 16:33:15 INFO - PID 9746 | 16:33:16 INFO - TEST-INFO | 9746: exit 0 16:33:16 INFO - TEST-OK | dromaeo_css | took 1122019ms 16:33:16 INFO - TEST-START | kraken 16:33:16 INFO - operating with platform_type : linux_ 16:33:16 INFO - Initialising browser for kraken test... 16:33:16 INFO - TEST-INFO | started process 10128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ggtF/profile http://localhost:51181/getInfo.html) 16:33:19 INFO - PID 10128 | __metrics Screen width/height:1600/1200 16:33:19 INFO - PID 10128 | colorDepth:24 16:33:19 INFO - PID 10128 | Browser inner width/height: 1024/697 16:33:19 INFO - PID 10128 | __metrics 16:33:20 ERROR - PID 10128 | 1490830400864 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) 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:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmp32ggtF/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp32ggtF/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp32ggtF/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp32ggtF/profile/extensions/talos-powers@TalosPowersService.js:55:9 16:33:20 ERROR - PID 10128 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 16:33:21 INFO - TEST-INFO | 10128: exit 0 16:33:21 INFO - Browser initialized. 16:33:21 INFO - Running cycle 1/1 for kraken test... 16:33:21 INFO - TEST-INFO | started process 10260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ggtF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:34 INFO - PID 10260 | RSS: Main: 155713536 16:33:34 INFO - PID 10260 | 16:33:36 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51181/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:37 INFO - PID 10260 | RSS: Main: 161865728 16:33:37 INFO - PID 10260 | 16:33:40 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51181/tests/kraken/driver.html?testName=audio-dft) 16:33:41 INFO - PID 10260 | RSS: Main: 162013184 16:33:41 INFO - PID 10260 | 16:33:44 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51181/tests/kraken/driver.html?testName=audio-fft) 16:33:44 INFO - PID 10260 | RSS: Main: 158253056 16:33:44 INFO - PID 10260 | 16:33:46 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51181/tests/kraken/driver.html?testName=audio-oscillator) 16:33:47 INFO - PID 10260 | RSS: Main: 159260672 16:33:47 INFO - PID 10260 | 16:33:49 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:50 INFO - PID 10260 | RSS: Main: 159432704 16:33:50 INFO - PID 10260 | 16:33:53 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51181/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:54 INFO - PID 10260 | RSS: Main: 164036608 16:33:54 INFO - PID 10260 | 16:33:57 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51181/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:58 INFO - PID 10260 | RSS: Main: 161267712 16:33:58 INFO - PID 10260 | 16:34:01 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51181/tests/kraken/driver.html?testName=json-parse-financial) 16:34:02 INFO - PID 10260 | RSS: Main: 162590720 16:34:02 INFO - PID 10260 | 16:34:03 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:04 INFO - PID 10260 | RSS: Main: 162746368 16:34:04 INFO - PID 10260 | 16:34:06 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:06 INFO - PID 10260 | RSS: Main: 162942976 16:34:06 INFO - PID 10260 | 16:34:09 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:09 INFO - PID 10260 | RSS: Main: 163483648 16:34:09 INFO - PID 10260 | 16:34:12 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:13 INFO - PID 10260 | RSS: Main: 163700736 16:34:13 INFO - PID 10260 | 16:34:16 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:17 INFO - PID 10260 | RSS: Main: 163708928 16:34:17 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | Cycle 1(1): loaded http://localhost:51181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51181/tests/kraken/driver.html?testName=ai-astar) 16:34:19 INFO - PID 10260 | RSS: Main: 166490112 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | __start_tp_report 16:34:19 INFO - PID 10260 | _x_x_mozilla_page_load 16:34:19 INFO - PID 10260 | _x_x_mozilla_page_load_details 16:34:19 INFO - PID 10260 | |i|pagename|runs| 16:34:19 INFO - PID 10260 | |0;ai-astar;105;111;112;113;113;111;113;113;111;113 16:34:19 INFO - PID 10260 | |1;audio-beat-detection;149;125;126;178;133;126;132;124;153;127 16:34:19 INFO - PID 10260 | |2;audio-dft;167;168;168;174;168;178;166;165;164;168 16:34:19 INFO - PID 10260 | |3;audio-fft;78;76;76;110;77;76;77;77;102;75 16:34:19 INFO - PID 10260 | |4;audio-oscillator;85;84;112;85;85;88;109;86;85;109 16:34:19 INFO - PID 10260 | |5;imaging-gaussian-blur;114;115;114;116;115;119;115;115;116;114 16:34:19 INFO - PID 10260 | |6;imaging-darkroom;151;151;152;151;152;151;153;153;152;151 16:34:19 INFO - PID 10260 | |7;imaging-desaturate;95;95;96;95;95;95;95;96;95;95 16:34:19 INFO - PID 10260 | |8;json-parse-financial;69;70;69;70;70;69;70;70;71;72 16:34:19 INFO - PID 10260 | |9;json-stringify-tinderbox;56;57;56;56;56;56;56;56;56;56 16:34:19 INFO - PID 10260 | |10;stanford-crypto-aes;86;84;95;85;84;84;88;85;84;83 16:34:19 INFO - PID 10260 | |11;stanford-crypto-ccm;142;136;150;146;135;148;161;150;185;139 16:34:19 INFO - PID 10260 | |12;stanford-crypto-pbkdf2;192;190;199;197;194;209;193;199;207;199 16:34:19 INFO - PID 10260 | |13;stanford-crypto-sha256-iterative;73;75;72;76;71;74;69;71;70;83 16:34:19 INFO - PID 10260 | __end_tp_report 16:34:19 INFO - PID 10260 | __start_cc_report 16:34:19 INFO - PID 10260 | _x_x_mozilla_cycle_collect,895 16:34:19 INFO - PID 10260 | __end_cc_report 16:34:19 INFO - PID 10260 | __startTimestamp1490830459406__endTimestamp 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | ------- Summary: start ------- 16:34:19 INFO - PID 10260 | Number of tests: 14 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#0] ai-astar Cycles:10 Average:111.50 Median:113.00 stddev:2.46 (2.2%) stddev-sans-first:0.97 16:34:19 INFO - PID 10260 | Values: 105.0 111.0 112.0 113.0 113.0 111.0 113.0 113.0 111.0 113.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:132.50 stddev:17.56 (13.3%) stddev-sans-first:18.11 16:34:19 INFO - PID 10260 | Values: 149.0 125.0 126.0 178.0 133.0 126.0 132.0 124.0 153.0 127.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#2] audio-dft Cycles:10 Average:168.60 Median:168.00 stddev:4.25 (2.5%) stddev-sans-first:4.47 16:34:19 INFO - PID 10260 | Values: 167.0 168.0 168.0 174.0 168.0 178.0 166.0 165.0 164.0 168.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.50 stddev:12.61 (16.5%) stddev-sans-first:13.27 16:34:19 INFO - PID 10260 | Values: 78.0 76.0 76.0 110.0 77.0 76.0 77.0 77.0 102.0 75.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:85.00 stddev:11.94 (14.0%) stddev-sans-first:12.33 16:34:19 INFO - PID 10260 | Values: 85.0 84.0 112.0 85.0 85.0 88.0 109.0 86.0 85.0 109.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:115.00 stddev:1.49 (1.3%) stddev-sans-first:1.51 16:34:19 INFO - PID 10260 | Values: 114.0 115.0 114.0 116.0 115.0 119.0 115.0 115.0 116.0 114.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:152.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 16:34:19 INFO - PID 10260 | Values: 151.0 151.0 152.0 151.0 152.0 151.0 153.0 153.0 152.0 151.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 16:34:19 INFO - PID 10260 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:0.94 (1.3%) stddev-sans-first:0.93 16:34:19 INFO - PID 10260 | Values: 69.0 70.0 69.0 70.0 70.0 69.0 70.0 70.0 71.0 72.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 16:34:19 INFO - PID 10260 | Values: 56.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:3.52 (4.1%) stddev-sans-first:3.73 16:34:19 INFO - PID 10260 | Values: 86.0 84.0 95.0 85.0 84.0 84.0 88.0 85.0 84.0 83.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:149.00 stddev:14.78 (9.9%) stddev-sans-first:15.44 16:34:19 INFO - PID 10260 | Values: 142.0 136.0 150.0 146.0 135.0 148.0 161.0 150.0 185.0 139.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.90 Median:199.00 stddev:6.21 (3.1%) stddev-sans-first:6.21 16:34:19 INFO - PID 10260 | Values: 192.0 190.0 199.0 197.0 194.0 209.0 193.0 199.0 207.0 199.0 16:34:19 INFO - PID 10260 | 16:34:19 INFO - PID 10260 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.40 Median:73.50 stddev:4.03 (5.5%) stddev-sans-first:4.28 16:34:19 INFO - PID 10260 | Values: 73.0 75.0 72.0 76.0 71.0 74.0 69.0 71.0 70.0 83.0 16:34:19 INFO - PID 10260 | -------- Summary: end -------- 16:34:19 INFO - PID 10260 | 16:34:20 INFO - TEST-INFO | 10260: exit 0 16:34:20 INFO - TEST-OK | kraken | took 64474ms 16:34:20 INFO - SUITE-END | took 1186s 16:34:21 INFO - Completed test suite (00:19:46) 16:34:21 INFO - javascript benchmark 16:34:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6567.684251204779, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2724.7002829688736, 2729.6314997475333, 2769.958450623241, 2781.054441489893, 2792.357757715724, 5074.416442109158, 5238.057149713055, 5280.2079688046815, 5346.946530534694, 5364.758585863631, 5179.378474583055, 5201.427842937273, 5273.129933560957, 5307.628466007381, 5382.946170538294, 4773.6897101688455, 4809.807607695706, 4867.513248675122, 4872.366592342991, 4899.167141585921, 4879.072976134541, 4904.730239836807, 4929.309896614477, 4931.038447502739, 4974.950250497503, 4669.41632295963, 4725.1730947084125, 4725.929111063337, 4860.1008813369635, 4862.076205520975, 4724.173269677793, 4728.692634978715, 4733.810647574093, 4735.384400028009, 4748.19280722278, 4663.836765713184, 4677.625789936831, 4703.553162449562, 4714.2692882602905, 4716.693414928019, 5077.517635824591, 5126.487351264844, 5133.486651334874, 5140.485951404867, 5145.25393817898, 5442.455754424526, 5442.564594832404, 5457.290552228224, 5464.1257398816, 5548.889022219573, 5547.72261386929, 5582.274304340451, 5588.3573389060375, 5597.328320601554, 5600.327960644749, 5157.948420515821, 5165.767540460688, 5189.922151167698, 5220.243064755589, 5229.424763276036, 5801.448862358069, 5810.0, 5832.066869300891, 5838.0, 5841.182234487175, 5349.946500534945, 5423.132298832168, 5464.398916119224, 5516.448355164452, 5577.079781836032, 5695.515881150066, 5701.087825947829, 5703.771849125988, 5721.170430287668, 5753.33836608787, 5659.547236221092, 5659.547236221092, 5700.857478563069, 5710.257666503411, 5712.171735098387, 5455.8090466834265, 5509.449055094538, 5613.803516876971, 5619.129034999582, 5628.859278517988, 4760.666753327303, 4761.142994261067, 4765.070811191785, 4780.593649539758, 4812.0, 4033.3344998075577, 4038.5759495253164, 4047.615476529725, 4067.2678917795083, 4084.7549147051272, 4662.790174442158, 4689.531046895351, 4880.097182021337, 4886.706797592155, 4889.63327750413, 5704.515116215085, 5736.368999410061, 5759.85600359986, 5788.623739457006, 5791.681457519792, 4870.95129048705, 4893.168161412568, 4896.338994235733, 4899.093667671492, 4953.578945789576, 4925.901481970269, 4947.431045429822, 5062.772175252123, 5079.187330027178, 5094.821681241138, 5138.871528211825, 5208.453112423293, 5214.32213812202, 5219.425863154974, 5226.712530810842, 5603.35561410443, 5614.831555053355, 5616.5787565931905, 5639.013172694844, 5643.463870932255, 5201.271821944855, 5208.270842082187, 5210.843674689765, 5211.426743058185, 5212.50481204285, 5447.673139611636, 5473.452654734654, 5490.149026900836, 5499.065158923073, 5515.420880807457, 5536.390996990247, 5573.16402539606, 5616.522595579421, 5619.915701264566, 5625.803096891753, 5383.865403364947, 5402.378726446352, 5436.864078398072, 5493.945060549503, 5521.4478552144465, 5456.563474921917, 5471.863203419946, 5504.532114770129, 5527.060399732136, 5540.612157148961, 5370.892582148257, 5451.48210919962, 5464.316960379952, 5470.070088085115, 5504.4770746778995, 5404.243405923253, 5441.401445841034, 5441.7279136043835, 5443.401225865231, 5443.700596467074, 5312.362516498045, 5314.0, 5325.307709997831, 5328.067588172132, 5331.600129990344], "value": 5125.399455362978, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.4854439265177, 678.4165617568891, 1055.0662663542766, 1065.1319174872483, 1178.7760325538143, 34384.4842327365, 35547.82226088872, 35589.64410355896, 35697.643023569755, 35701.82149089257, 32914.835425822836, 33306.33387332258, 33321.50017749736, 33339.33321333572, 33347.66652333476, 6870.484713646484, 7042.190148132979, 7361.889571656429, 7490.737824176155, 7501.924980750177, 7529.0212272404515, 7653.579053152074, 7653.808654783619, 7657.11943126542, 7658.731944381948, 7620.352270057052, 7661.195574464685, 7661.9616901915415, 7679.232076792332, 7712.460127791057, 7598.08822941245, 7631.007968964054, 7632.465727399084, 7655.50239234448, 7667.079950405959, 7264.309890560388, 7340.816479587999, 7342.118945726494, 7363.705451781922, 7379.409647228209, 33978.0, 34013.829930850436, 34021.489677654856, 34113.317733645184, 34116.0, 2436.2812970173663, 2457.496213276274, 2465.395977985387, 2508.2851387354517, 2548.4775620997652, 23062.65406018911, 23263.18578849749, 23318.76681233183, 24189.758102418928, 24229.394265143335, 2622.541055315331, 2625.960610590843, 2658.9734102658917, 2665.7067722550505, 2668.9599656005175, 149849.2507537477, 150736.2463187688, 152069.0, 152421.0, 153011.0, 33739.0, 34018.14954626154, 39733.60266397299, 39921.60078399237, 41140.0, 41896.0, 41947.37078943818, 41964.790176048926, 41980.37029444561, 42064.36903446451, 12044.39778011096, 12134.27194368323, 12157.817632735516, 12172.939135304267, 12192.329421881705, 9624.51877406127, 9633.566489507988, 9653.131218190396, 9661.13049825519, 9709.951450242703, 12774.105812593029, 12818.0, 12838.743225135446, 13054.37495951636, 13080.149790263602, 5214.270002199695, 5248.297126979609, 5275.446078161738, 5330.92003619946, 5403.2165336026055, 852.4927668037508, 882.2324577617513, 884.2447741233646, 887.6759982606302, 916.8899732032065, 20076.0, 21092.47268818292, 21136.260230891847, 21243.150273988867, 21353.359399218047, 957.9366902737955, 958.9520523973773, 979.6571200079915, 986.4919566423298, 991.7619771254991, 10923.726906827234, 10960.780784384267, 11027.17296202788, 11058.391788451552, 11065.114790816715, 224369.0, 224389.0, 225185.0, 225674.0, 227815.0, 41900.790496047324, 42121.78939105285, 42150.0, 42318.78840605777, 42555.78722106432, 1164.249059356727, 1210.1710328425056, 1215.1797536662893, 1215.3376409856648, 1225.828384026237, 19818.50453738668, 19966.700499492228, 20819.8959005204, 21000.894995524926, 21294.574108517434, 30683.846580766953, 30756.231094222825, 30879.0, 30881.536776947913, 30906.536401953537, 207029.0, 207725.0, 207965.0, 208289.95855020627, 209114.0, 28347.0, 28428.0, 28440.715592843808, 28546.57180142341, 29007.0, 34734.65265347314, 35028.82485587556, 35178.29643407066, 35334.116647084025, 35452.0, 27091.59362609523, 27121.593176102768, 27196.0, 27665.723342766316, 28038.2990425241, 26851.731482685704, 27063.72936270691, 27095.86452067727, 27907.162785116478, 28174.43651127007, 29432.26419339534, 29596.112116636534, 29698.257543561584, 29875.0, 30104.0, 26157.0, 26486.470270594866, 26678.866605666848, 26884.731152688222, 27704.584431233143, 21270.255541055987, 21649.567008659422, 21717.674234886807, 21894.233701821, 21972.670409944185], "value": 14694.672854621029, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.82420559159567, 409.53926832313647, 419.48193980434166, 424.4439783883112, 439.1809275700819, 16846.747298790528, 18108.637827243463, 18776.624467510643, 18782.90608546957, 18807.623847523042, 14811.481598144068, 18553.350632727856, 18574.0, 18661.16024778885, 18830.15264313106, 5368.248445217672, 5447.536959358459, 5536.529395001409, 5575.303087114111, 5639.7180140993, 5544.972275138619, 5611.046122159222, 5618.494335509803, 5618.747156377973, 5620.971895140539, 5452.91820622691, 5540.2243685883805, 5550.972245138769, 5563.916541251884, 5573.665580065189, 5472.753726082316, 5558.166275058753, 5564.304461942257, 5566.721663916788, 5567.638103523258, 4843.685160464559, 4986.775595098229, 5015.648904576681, 5032.370953630796, 5036.84889453317, 20996.895015524977, 21401.57196856054, 21685.67471487929, 21746.456338591503, 21863.562728745495, 1473.6684246044554, 1475.8893083018816, 1478.7633978563379, 1494.3798323695762, 1506.5781581157294, 13789.310534473336, 13875.167489950636, 13966.092204006707, 14038.0, 14482.058666186664, 1460.5545308680848, 1474.506040476431, 1529.3143375698608, 1550.395345815133, 1562.1642421304662, 85156.57421712852, 86511.56744216238, 86820.0, 87366.56316718439, 92214.07785922122, 10716.946415267874, 10964.725881853017, 11045.558177672803, 11077.667669969753, 11117.833232501518, 15236.085834849944, 15255.694886102216, 15296.388144474096, 15352.155631440379, 15376.231188440757, 6989.965050174716, 7178.066851309296, 7370.77887663371, 7405.1854296027395, 7410.481266311414, 6431.614103153825, 6527.0, 6557.0, 6721.563098398588, 6754.898676519856, 6821.761238356634, 6834.881186832098, 6903.206131294865, 7003.789886303419, 7104.147502299757, 2047.9692804607944, 2053.969190462144, 2061.5672107885175, 2109.093089971327, 2143.0784762552253, 831.9126491718404, 838.149278482341, 866.8656358264479, 879.3580686099183, 882.5322579033123, 16057.919710401373, 16270.83729162717, 17073.146342682816, 17323.393681221096, 17333.47999560015, 868.9391742578085, 873.2708188662411, 873.6199753107419, 876.6975393489236, 882.9072947340437, 8751.256143227896, 9197.356185067116, 9255.35212535116, 9299.442033478013, 9444.90555094454, 496716.0, 517253.0, 517969.0, 518912.0, 522205.8897055132, 90099.54950225339, 90519.0, 92526.0, 95425.52287238519, 95932.0, 1041.7135287795766, 1047.9738006549744, 1062.2298833345762, 1064.9094826939643, 1065.9093977012042, 13947.651308717363, 14010.229437381042, 14025.438982440588, 14128.222947737562, 14933.253337333308, 40330.79834600808, 40704.38943415792, 40797.592024080564, 41017.17965640611, 41518.1696366077, 53889.0, 55227.44772552223, 55892.72053639706, 56406.71796641155, 56931.43068569427, 8024.518528888286, 8134.308583770446, 8188.426810123472, 8313.833723325379, 8484.787880303042, 12351.629451116482, 12992.415341309475, 13152.80270795958, 13484.258365789976, 13499.122557033761, 10370.792584148125, 10545.0, 10575.78848423012, 10586.682399528027, 10859.728506787078, 10401.58393664245, 10639.680809575726, 10681.89318106809, 10704.250702450754, 10759.03168714788, 10391.0, 10455.372677639367, 10492.842607360742, 10584.682459526226, 10914.290571112851, 7958.681652733826, 8131.308838748772, 8138.0, 8333.333333333352, 8381.264585509169, 10358.844617330595, 10361.689149325532, 10421.0, 10537.89462105369, 10568.735781605521], "value": 8785.295396817934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1231.3966156583274, 1307.56850239421, 1317.3808310094253, 1317.4335035934548, 1318.3869500682188, 9332.580033898474, 9684.37051591646, 9696.56365463554, 9964.701058968243, 10181.847272290921, 9877.60489580416, 10061.748456288597, 10109.191264698824, 10109.696709098738, 10116.645917392892, 2206.735191776985, 2246.2811900191946, 2249.0553967333676, 2250.8199344052437, 2256.627656436686, 2152.62329092409, 2209.55274295336, 2260.5026894083276, 2262.6945362376114, 2266.614675505168, 2148.301801914384, 2212.358416059341, 2230.4646884747626, 2237.9216727414546, 2248.1457046322375, 2100.9264675736276, 2176.260071575664, 2184.4757258257982, 2184.7378314602192, 2195.3962660268394, 1834.779826420838, 1902.4577995271281, 2190.0363839910387, 2199.4281486813384, 2217.401301648562, 9646.565904534313, 9955.701328960144, 9966.402015878997, 9967.850482242773, 9968.451735154564, 4981.352424184869, 5128.615353848476, 5134.383873935114, 5139.8458046258675, 5148.588112950955, 3238.5627940228005, 3314.850831712579, 3326.0520751585923, 3327.550780644606, 3385.356782211372, 1014.0873214107362, 1026.650938680852, 1043.1602559939247, 1051.568856768729, 1066.8239740442818, 14163.433462661482, 14210.786838197435, 14210.928945355206, 14229.857701422958, 14300.356483958247, 4699.647526435531, 4828.213560982389, 4867.805287788519, 4917.975410122926, 4931.5315045070665, 10539.789204215873, 10583.84124238137, 10632.627858024933, 10641.308314959502, 10708.411037392862, 5112.923306150411, 5124.359455068116, 5152.5362717354865, 5159.2003239497935, 5167.147420675622, 4465.709728867613, 4534.206513860061, 4676.672632915731, 4696.295555666609, 4736.786844592001, 3797.240551889633, 3804.885853424402, 3828.73198876076, 3844.557875844258, 3948.526176858795, 1121.52895783771, 1134.2343917855414, 1137.2096393006946, 1144.8683401408778, 1146.7591805720724, 671.1509939925998, 696.8118607975819, 707.1937990690617, 707.4093132234642, 721.6896734404152, 5285.814996475182, 5288.788448462095, 5317.893642127213, 6574.8356291093105, 6678.899816502756, 823.4071468542639, 828.6395417993192, 832.3258160889699, 833.6498670558381, 861.3238607692931, 3538.239278555123, 3669.174435751988, 3683.9079023024638, 3697.8705745298785, 3770.7360484765804, 12058.939705301418, 12611.621651350475, 12724.618261452171, 12771.233725976472, 12847.486100555872, 12496.437660305308, 12735.617931462071, 12753.234805911676, 12856.164349317265, 12998.480060797463, 9170.770730731785, 9309.022552632012, 9314.580843862042, 9481.956984731674, 9521.952390238004, 5891.469767720926, 5901.793437229677, 5929.140274660236, 6098.359672234352, 6129.08063790435, 11462.197646164688, 11508.136889733136, 11543.19197656156, 11689.240199387013, 11721.589744358907, 11469.942650286695, 11747.47136378848, 11751.882481175078, 11774.411279435823, 11799.882001180222, 7836.529808211526, 7983.401244906539, 7984.121746607984, 7990.560519171501, 7990.880136797837, 9066.09339066088, 9229.86155207659, 9354.485503297385, 9390.624375024923, 9405.52972351366, 7126.216116227314, 7243.022192004223, 7279.308465695751, 7356.595387253752, 7466.962665186639, 7016.298370162943, 7029.29707029293, 7072.575645461289, 7114.608696521741, 7178.892316615151, 7149.857002860018, 7220.3501684846515, 7258.963705181441, 7284.307990740871, 7309.634518274172, 5366.838994830161, 5462.481064298885, 5587.972060139673, 5655.066913959151, 5720.685362305113, 5059.266406370982, 5071.822486212965, 5105.463926287686, 5148.407933087593, 5324.733763311897], "value": 4644.890793118735, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.1747157744554, 377.1325950314276, 381.61456928502207, 381.64697654669425, 382.0372660894546, 5335.919961200585, 5476.616636835423, 5606.747696353664, 5610.607257491977, 5645.604807663465, 5335.599830012755, 5442.210879422481, 5483.862903427416, 5485.61600687952, 5489.670619762817, 4405.339199120133, 4426.114777044588, 4427.645788336941, 4436.844710435135, 4437.1125774844995, 4338.783060846945, 4401.273789824675, 4417.249067658506, 4422.601965823075, 4427.822887084529, 4371.759553224571, 4379.868603941871, 4388.956110438902, 4390.253656878338, 4399.890002749941, 4373.495299841137, 4373.628241599468, 4380.956190438087, 4389.758563279019, 4398.054418300049, 3852.6339997700175, 3978.4430179774854, 3982.6216509431556, 3986.760794352348, 3997.0, 5333.35999680037, 5351.866203344908, 5372.677639341613, 5383.596230282745, 5402.432744561804, 5072.239164125411, 5085.949140508585, 5090.261912022736, 5091.428828441651, 5097.974510127426, 5599.692016939067, 5755.568332375088, 5811.970940145272, 5812.88374232513, 5829.970850145722, 4312.0, 4319.645793042768, 4322.697411181219, 4326.8269269229195, 4334.176506463762, 5978.252718410199, 6077.905976924152, 6090.208272924536, 6118.908216376758, 6129.816105516842, 4049.8380064797666, 4064.1058967027207, 4065.4714887064492, 4081.714280000431, 4081.8163182656854, 4126.216018956448, 4138.213739389506, 4140.544540100586, 4141.565135660772, 4146.37804329347, 4607.401037865123, 4783.473817880031, 4796.400449943757, 4797.040591881638, 4808.2547205183255, 5776.826695199066, 5806.361300256968, 5810.983077961424, 5819.854503637358, 5824.213731146326, 1447.9420823166956, 1462.334637739826, 1463.2244910197612, 1468.897177197586, 1474.3144437836459, 923.5733400314937, 967.5549247346158, 971.2278738402987, 978.5841017567506, 979.1579241852002, 5033.094043072282, 5043.899122017612, 5051.393832740021, 5057.317262169634, 5083.771230294572, 6002.729877155539, 6004.42957918997, 6005.489533389711, 6033.129729783781, 6045.6070355426755, 4814.542618451242, 5025.321581586439, 5033.647644664911, 5051.0, 5056.544910957958, 3176.634687010977, 3207.1982004498877, 3223.62928263248, 3225.1292151119537, 3243.5728279557393, 5604.187392828017, 5643.35101463337, 5645.1532270159805, 5650.689212093374, 5659.434056594308, 5902.84894445579, 6112.755489780359, 6135.386461353829, 6136.478399336017, 6161.938380616226, 5581.469760372758, 5586.497215250647, 5589.860253493695, 5604.3835178131185, 5605.32736071674, 5795.652260864362, 5932.79235226765, 5995.730192141451, 6016.939830601813, 6029.216201893726, 5909.261342332208, 5920.526357891445, 5931.466168044896, 5953.404659534012, 5968.253968253968, 5426.158945363475, 5595.908797784393, 5618.52242559387, 5630.831075067755, 5652.604317697722, 4150.377443383517, 4169.478815148106, 4171.353440216772, 4171.416001759695, 4173.144505376451, 5916.792912248051, 6053.243344581927, 6072.969635151796, 6076.756929722938, 6090.9390906090375, 5756.65460072397, 5806.332271788629, 5812.82561523155, 5813.883722325445, 5819.5635327351465, 5718.742656580381, 5812.622179558315, 5819.447152520504, 5820.243368362086, 5834.591578589458, 5593.328800543961, 5693.0, 5733.655980641175, 5749.252597162342, 5753.108268218432, 5859.2382990211, 5880.588358815013, 5881.73532191061, 5886.293644762656, 5906.675132867734, 5455.645383050089, 5669.20631111653, 5694.985035549845, 5700.629459085146, 5716.683903652882], "value": 4391.812448113982, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.2791658135368, 604.3923164382742, 613.1018058544232, 613.2487702564359, 620.5221979076113, 11948.163628545994, 12151.210171338867, 12182.695432614179, 12242.0, 13242.668933276673, 14487.855121448782, 14498.855011449883, 14655.120692758443, 14662.41350345985, 14672.853271467282, 627.9560430769859, 884.3986089459165, 902.747230775384, 920.6409500294891, 920.8434566123775, 926.735880274122, 927.0544045074021, 929.0384452092086, 931.0875342164683, 932.4451951089092, 974.848898420746, 980.5440470181364, 983.5868935047297, 984.5077461269366, 984.950752462374, 965.7778710896463, 974.7660561465268, 976.1068622210669, 976.4043933200707, 979.0111986893218, 716.616610113592, 717.2791344698545, 717.6089031477857, 719.8020544350293, 720.697307131001, 11771.882281177164, 11904.345261010641, 11946.223495472766, 11987.160898737005, 12415.255084694856, 12697.809532857014, 13274.402651880688, 13288.86711132886, 13549.627779264709, 13612.387442565108, 8491.448055876348, 8743.431676940978, 8775.429597076234, 9171.770705732344, 9575.138237558653, 2361.327021798796, 2379.6906402167606, 2394.4492766663766, 2401.771831675988, 2409.2772168349425, 54819.0, 56372.0, 56572.43427565754, 56926.43073569253, 57421.0, 9497.24022078246, 9522.190613797904, 9594.136527712539, 9695.466749328854, 10082.546285417175, 20289.89855050745, 20637.58724825495, 20817.1673133076, 20866.686999694713, 20922.581548368948, 5727.77088916447, 5752.741126649311, 5817.214676018768, 5844.532437405082, 5901.970490147522, 2785.3036740814796, 2797.202797202787, 2830.066078194232, 2844.1751891951517, 2882.567614857788, 3449.49982252577, 3490.267043920754, 3497.842597083137, 3506.526618906415, 3562.358775420449, 696.5681277607915, 697.5221972948547, 707.8088915992756, 716.6989864257024, 717.5551158281899, 433.6682437934982, 446.2525270172448, 447.9664025198058, 461.52462963148014, 471.15662963296, 7678.270564296383, 7929.3217001969115, 8073.596320184085, 8143.877841832377, 8149.918500814916, 439.4024127187023, 452.40508731018605, 455.85184814934615, 459.36607481675077, 468.7492191677436, 3412.4881267809533, 3552.431610942237, 3574.696150827157, 3614.6023937366867, 3681.7975011374097, 63550.68224658939, 64012.67993660095, 64860.351396486374, 65840.4407427041, 65896.0, 39547.40678889819, 45313.320300195526, 54401.72799135979, 54606.45393546093, 55244.72377638086, 45054.774726126816, 45281.320780188325, 45787.084258314644, 46101.30848037282, 47123.0, 7947.483413578099, 8595.613197406006, 8614.3108551317, 8629.309655227442, 8683.106761460145, 24684.38289042788, 24972.0, 25020.49959000846, 25552.0, 25603.0, 29518.114456566338, 41864.58135418607, 43568.34647480354, 44924.0, 45202.0, 9806.705798826046, 9958.850617240601, 9966.202703783825, 10018.599256029676, 10159.695209143738, 11018.724531886446, 11150.0, 11313.71715707114, 11766.705832354259, 11784.82322765142, 10462.63380781669, 10512.159027277647, 10851.565937362417, 10887.401192934465, 11262.9863312299, 10777.838332425177, 10913.181511386836, 10960.123190144928, 11210.103191744804, 11431.657050288504, 9815.607375704893, 10073.748156296151, 10151.796964060824, 10261.692149235534, 10684.679459616224, 8052.473658502678, 8210.671573137246, 8284.627191776504, 8471.915280847114, 8555.31557475413, 8544.109186851614, 8627.6980305689, 8989.0, 9224.0, 9245.399049061789], "value": 5945.3564640690365, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1587.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 111.0, 112.0, 113.0, 113.0, 111.0, 113.0, 113.0, 111.0, 113.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 126.0, 178.0, 133.0, 126.0, 132.0, 124.0, 153.0, 127.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 168.0, 174.0, 168.0, 178.0, 166.0, 165.0, 164.0, 168.0], "value": 168.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 110.0, 77.0, 76.0, 77.0, 77.0, 102.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 112.0, 85.0, 85.0, 88.0, 109.0, 86.0, 85.0, 109.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 116.0, 115.0, 119.0, 115.0, 115.0, 116.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 152.0, 151.0, 152.0, 151.0, 153.0, 153.0, 152.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 70.0, 70.0, 69.0, 70.0, 70.0, 71.0, 72.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 95.0, 85.0, 84.0, 84.0, 88.0, 85.0, 84.0, 83.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 150.0, 146.0, 135.0, 148.0, 161.0, 150.0, 185.0, 139.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 190.0, 199.0, 197.0, 194.0, 209.0, 193.0, 199.0, 207.0, 199.0], "value": 197.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 72.0, 76.0, 71.0, 74.0, 69.0, 71.0, 70.0, 83.0], "value": 73.4, "unit": "score"}]}]} 16:34:21 INFO - Return code: 0 16:34:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:34:21 ERROR - # TBPL SUCCESS # 16:34:21 INFO - Running post-action listener: _resource_record_post_action 16:34:21 INFO - [mozharness: 2017-03-29 23:34:21.186271Z] Finished run-tests step (success) 16:34:21 INFO - Running post-run listener: _resource_record_post_run 16:34:21 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 378478592; Read time: 260; Write time: 221416 16:34:21 INFO - TinderboxPrint: CPU usage
13.3% 16:34:21 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 260 16:34:21 INFO - TinderboxPrint: I/O write bytes / time
378,478,592 / 221,416 16:34:21 INFO - TinderboxPrint: CPU idle
8,321.3 (86.7%) 16:34:21 INFO - TinderboxPrint: CPU user
1,223.0 (12.7%) 16:34:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119468032; Read time: 0; Write time: 94976 16:34:21 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 12288; Write bytes: 259010560; Read time: 260; Write time: 126440 16:34:21 INFO - Running post-run listener: _upload_blobber_files 16:34:21 INFO - Blob upload gear active. 16:34:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:21 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 16:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:34:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:34:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:23 INFO - (blobuploader) - INFO - Done attempting. 16:34:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:34:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:34:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:23 INFO - (blobuploader) - INFO - Done attempting. 16:34:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:27 INFO - (blobuploader) - INFO - Done attempting. 16:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:27 INFO - (blobuploader) - INFO - Done attempting. 16:34:27 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:27 INFO - Return code: 0 16:34:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:27 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd8f6d0b4c7042ec6e9135054d0af3fb9114ab7267cdd52b9f64f4b5d140a04b5317bc18708e82e278681c21eb77e36f27e67c34e651d03d3a3183d1c0b5bbc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b721f71f4b3293e3241e6c272b20dfb695c0e90692f617aadc19c61cdafdccacdceafc0be606a539b0a6510a6614696da8579ec86683ddf67418c212ce0aafd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3e9c51e89fde151f6b4b891df59965f76b0f43a919b536dadec396234ba78ce4807aa3aa15bcab071f82ac71ca744b1000b5c6129a89a20f1817c5e76594019", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db6ecfcadb0c78aa0a9cb9e5584b499c8667e423b3cf84373ed0664d884bef8ac6967f01266a8260365db6cb7a9651d815eab8f523a941629ee9e60fca3afc13"} 16:34:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:27 INFO - Contents: 16:34:27 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd8f6d0b4c7042ec6e9135054d0af3fb9114ab7267cdd52b9f64f4b5d140a04b5317bc18708e82e278681c21eb77e36f27e67c34e651d03d3a3183d1c0b5bbc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b721f71f4b3293e3241e6c272b20dfb695c0e90692f617aadc19c61cdafdccacdceafc0be606a539b0a6510a6614696da8579ec86683ddf67418c212ce0aafd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3e9c51e89fde151f6b4b891df59965f76b0f43a919b536dadec396234ba78ce4807aa3aa15bcab071f82ac71ca744b1000b5c6129a89a20f1817c5e76594019", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db6ecfcadb0c78aa0a9cb9e5584b499c8667e423b3cf84373ed0664d884bef8ac6967f01266a8260365db6cb7a9651d815eab8f523a941629ee9e60fca3afc13"} 16:34:27 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:27 INFO - Copying logs to upload dir... 16:34:27 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.376394 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-03-29 16:34:27.330800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 16:34:27.334143) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd8f6d0b4c7042ec6e9135054d0af3fb9114ab7267cdd52b9f64f4b5d140a04b5317bc18708e82e278681c21eb77e36f27e67c34e651d03d3a3183d1c0b5bbc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b721f71f4b3293e3241e6c272b20dfb695c0e90692f617aadc19c61cdafdccacdceafc0be606a539b0a6510a6614696da8579ec86683ddf67418c212ce0aafd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3e9c51e89fde151f6b4b891df59965f76b0f43a919b536dadec396234ba78ce4807aa3aa15bcab071f82ac71ca744b1000b5c6129a89a20f1817c5e76594019", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db6ecfcadb0c78aa0a9cb9e5584b499c8667e423b3cf84373ed0664d884bef8ac6967f01266a8260365db6cb7a9651d815eab8f523a941629ee9e60fca3afc13"} build_url:https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011235 build_url: 'https://queue.taskcluster.net/v1/task/KOQbI6cGSHC6z2G0BEe_2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9dd8f6d0b4c7042ec6e9135054d0af3fb9114ab7267cdd52b9f64f4b5d140a04b5317bc18708e82e278681c21eb77e36f27e67c34e651d03d3a3183d1c0b5bbc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b721f71f4b3293e3241e6c272b20dfb695c0e90692f617aadc19c61cdafdccacdceafc0be606a539b0a6510a6614696da8579ec86683ddf67418c212ce0aafd2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3e9c51e89fde151f6b4b891df59965f76b0f43a919b536dadec396234ba78ce4807aa3aa15bcab071f82ac71ca744b1000b5c6129a89a20f1817c5e76594019", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db6ecfcadb0c78aa0a9cb9e5584b499c8667e423b3cf84373ed0664d884bef8ac6967f01266a8260365db6cb7a9651d815eab8f523a941629ee9e60fca3afc13"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-29 16:34:27.359036) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:34:27.359345) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1490829203.804000-1961901962 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-29 16:34:27.443860) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 16:34:27.444175) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-29 16:34:27.444533) ========= ========= Total master_lag: 0.17 =========