builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1492204164.57 results: success (0) revision: e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.566478) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.566985) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.567321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.582046) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.582330) ========= 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=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-14 14:09:25-- 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% 227M=0s 2017-04-14 14:09:25 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130282 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.726779) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.727095) ========= 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=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018843 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:24.776150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 14:09:24.776504) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f --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=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-14 14:09:25,258 truncating revision to first 12 chars 2017-04-14 14:09:25,258 Setting DEBUG logging. 2017-04-14 14:09:25,258 attempt 1/10 2017-04-14 14:09:25,259 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e53f7f1785eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-14 14:09:26,400 unpacking tar archive at: mozilla-aurora-e53f7f1785eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.438595 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-14 14:09:26.228325) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:26.228652) ========= script_repo_revision: e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:26.229149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:26.229441) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-14 14:09:26.239579) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-14 14:09:26.239866) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:09:26 INFO - MultiFileLogger online at 20170414 14:09:26 in /builds/slave/test 14:09:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 14:09:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:09:26 INFO - {'append_to_log': False, 14:09:26 INFO - 'base_work_dir': '/builds/slave/test', 14:09:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 14:09:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:09:26 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 14:09:26 INFO - 'buildbot_json_path': 'buildprops.json', 14:09:26 INFO - 'config_files': ('talos/linux_config.py',), 14:09:26 INFO - 'default_actions': ('clobber', 14:09:26 INFO - 'read-buildbot-config', 14:09:26 INFO - 'download-and-extract', 14:09:26 INFO - 'populate-webroot', 14:09:26 INFO - 'create-virtualenv', 14:09:26 INFO - 'install', 14:09:26 INFO - 'run-tests'), 14:09:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:09:26 INFO - 'download_minidump_stackwalk': True, 14:09:26 INFO - 'download_symbols': 'ondemand', 14:09:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:09:26 INFO - 'tooltool.py': '/tools/tooltool.py', 14:09:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:09:26 INFO - '/tools/misc-python/virtualenv.py')}, 14:09:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:09:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:09:26 INFO - 'gecko_profile': False, 14:09:26 INFO - 'gecko_profile_interval': 0, 14:09:26 INFO - 'installer_path': 'installer.exe', 14:09:26 INFO - 'log_level': 'info', 14:09:26 INFO - 'log_name': 'talos', 14:09:26 INFO - 'log_to_console': True, 14:09:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:09:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:09:26 INFO - 'opt_config_files': (), 14:09:26 INFO - 'pip_index': False, 14:09:26 INFO - 'suite': 'dromaeojs', 14:09:26 INFO - 'system_bits': '32', 14:09:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:09:26 INFO - 'title': 'talos-linux64-ix-007', 14:09:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:09:26 INFO - 'use_talos_json': True, 14:09:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:09:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:09:26 INFO - 'work_dir': 'build'} 14:09:26 INFO - [mozharness: 2017-04-14 21:09:26.823261Z] Running clobber step. 14:09:26 INFO - Running pre-action listener: _resource_record_pre_action 14:09:26 INFO - Running main action method: clobber 14:09:26 INFO - rmtree: /builds/slave/test/build 14:09:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:09:28 INFO - Running post-action listener: _resource_record_post_action 14:09:28 INFO - [mozharness: 2017-04-14 21:09:28.284895Z] Finished clobber step (success) 14:09:28 INFO - [mozharness: 2017-04-14 21:09:28.284992Z] Running read-buildbot-config step. 14:09:28 INFO - Running pre-action listener: _resource_record_pre_action 14:09:28 INFO - Running main action method: read_buildbot_config 14:09:28 INFO - Using buildbot properties: 14:09:28 INFO - { 14:09:28 INFO - "project": "", 14:09:28 INFO - "product": "firefox", 14:09:28 INFO - "who": "ryanvm@gmail.com", 14:09:28 INFO - "installer_path": "public/build/target.tar.bz2", 14:09:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:09:28 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 14:09:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 14:09:28 INFO - "stage_platform": "linux64", 14:09:28 INFO - "basedir": "/builds/slave/test", 14:09:28 INFO - "buildnumber": 127, 14:09:28 INFO - "platform": "ubuntu64_hw", 14:09:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:09:28 INFO - "slavebuilddir": "test", 14:09:28 INFO - "taskId": "MlHJ8y_6SdOpFdoqg2r1aA", 14:09:28 INFO - "branch": "mozilla-aurora", 14:09:28 INFO - "script_repo_revision": "production", 14:09:28 INFO - "revision": "e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f", 14:09:28 INFO - "slavename": "talos-linux64-ix-007", 14:09:28 INFO - "repo_path": "releases/mozilla-aurora" 14:09:28 INFO - } 14:09:28 INFO - Finding installer, test and symbols from parent task. 14:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MlHJ8y_6SdOpFdoqg2r1aA'}, attempt #1 14:09:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MlHJ8y_6SdOpFdoqg2r1aA'}, attempt #1 14:09:29 INFO - Task dependencies: S4Ra-0s8S62Sh7_hf0P45w 14:09:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w'}, attempt #1 14:09:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 14:09:29 INFO - Set test_url: https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/test_packages.json 14:09:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.crashreporter-symbols.zip 14:09:29 INFO - Running post-action listener: _resource_record_post_action 14:09:29 INFO - [mozharness: 2017-04-14 21:09:29.629059Z] Finished read-buildbot-config step (success) 14:09:29 INFO - [mozharness: 2017-04-14 21:09:29.629276Z] Running download-and-extract step. 14:09:29 INFO - Running pre-action listener: _resource_record_pre_action 14:09:29 INFO - Running main action method: download_and_extract 14:09:29 INFO - mkdir: /builds/slave/test/build/tests 14:09: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')]} 14:09:29 INFO - trying https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.test_packages.json 14:09:29 INFO - Downloading https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:09:30 INFO - Downloaded 896 bytes. 14:09:30 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:09:30 INFO - Using the following test package requirements: 14:09:30 INFO - {u'common': [u'target.common.tests.zip'], 14:09:30 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:09:30 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:09:30 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:09:30 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:09:30 INFO - u'mozbase': [u'target.common.tests.zip'], 14:09:30 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:09:30 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:09:30 INFO - u'web-platform': [u'target.common.tests.zip', 14:09:30 INFO - u'target.web-platform.tests.zip'], 14:09:30 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:09:30 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:09:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip 14:09:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:30 INFO - Fetch https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip into memory 14:09:31 INFO - Expected file size: 59542661 14:09:31 INFO - Obtained file size: 59542661 14:09:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:09:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip 14:09:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:41 INFO - Fetch https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.common.tests.zip into memory 14:09:42 INFO - Expected file size: 59542661 14:09:42 INFO - Obtained file size: 59542661 14:09:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.talos.tests.zip 14:09:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:09:52 INFO - Fetch https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.talos.tests.zip into memory 14:09:53 INFO - Expected file size: 14404424 14:09:53 INFO - Obtained file size: 14404424 14:09: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')]} 14:09:53 INFO - trying https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 14:09:53 INFO - Downloading https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:09:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:09:55 INFO - Downloaded 66659124 bytes. 14:09:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 14:09:55 INFO - mkdir: /builds/slave/test/properties 14:09:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:55 INFO - Contents: 14:09:55 INFO - build_url:https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 14:09:55 INFO - Running post-action listener: _resource_record_post_action 14:09:55 INFO - Running post-action listener: set_extra_try_arguments 14:09:55 INFO - [mozharness: 2017-04-14 21:09:55.005402Z] Finished download-and-extract step (success) 14:09:55 INFO - [mozharness: 2017-04-14 21:09:55.005499Z] Running populate-webroot step. 14:09:55 INFO - Running pre-action listener: _resource_record_pre_action 14:09:55 INFO - Running main action method: populate_webroot 14:09:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:55 INFO - '--tppagecycles', 14:09:55 INFO - '7'], 14:09:55 INFO - 'tests': ['tsvgm']}}, 14:09:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['damp', 'tps']}, 14:09:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'tests': ['damp', 'tps']}, 14:09:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['dromaeo_dom']}, 14:09:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['basic_compositor_video']}, 14:09:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:09:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['a11yr', 14:09:55 INFO - 'ts_paint', 14:09:55 INFO - 'tpaint', 14:09:55 INFO - 'sessionrestore', 14:09:55 INFO - 'sessionrestore_no_auto_restore', 14:09:55 INFO - 'tabpaint']}, 14:09:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['tsvgx', 14:09:55 INFO - 'tsvgr_opacity', 14:09:55 INFO - 'tart', 14:09:55 INFO - 'tscrollx', 14:09:55 INFO - 'cart', 14:09:55 INFO - 'tsvg_static']}, 14:09:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:55 INFO - 'tsvgr_opacity', 14:09:55 INFO - 'tart', 14:09:55 INFO - 'tscrollx', 14:09:55 INFO - 'cart', 14:09:55 INFO - 'tsvg_static']}, 14:09:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'talos_options': ['--disable-e10s'], 14:09:55 INFO - 'tests': ['tp5o']}, 14:09:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'talos_options': ['--disable-e10s', 14:09:55 INFO - '--xperf_path', 14:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:55 INFO - 'tests': ['tp5n']}, 14:09:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:55 INFO - 'talos_options': ['--xperf_path', 14:09:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:55 INFO - 'tests': ['tp5n']}}, 14:09:55 INFO - 'talos.zip': {'path': '', 14:09:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:55 INFO - Running post-action listener: _resource_record_post_action 14:09:55 INFO - [mozharness: 2017-04-14 21:09:55.018484Z] Finished populate-webroot step (success) 14:09:55 INFO - [mozharness: 2017-04-14 21:09:55.018574Z] Running create-virtualenv step. 14:09:55 INFO - Running pre-action listener: _resource_record_pre_action 14:09:55 INFO - Running main action method: create_virtualenv 14:09:55 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09: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 14:09:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:55 INFO - Using real prefix '/usr' 14:09:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:55 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:57 INFO - Installing pip.................done. 14:09:57 INFO - Return code: 0 14:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:57 INFO - Reading from file tmpfile_stdout 14:09:57 INFO - Output received: 14:09: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) 14:09:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:09: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 14:09: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 14:09:57 INFO - Using env: {'DISPLAY': ':0', 14:09:57 INFO - 'HOME': '/home/cltbld', 14:09:57 INFO - 'LANG': 'en_US.UTF-8', 14:09:57 INFO - 'LANGUAGE': 'en_US:en', 14:09:57 INFO - 'LOGNAME': 'cltbld', 14:09:57 INFO - 'MAIL': '/var/mail/cltbld', 14:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:57 INFO - 'MOZ_NO_REMOTE': '1', 14:09:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:57 INFO - 'NO_EM_RESTART': '1', 14:09:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:57 INFO - 'PWD': '/builds/slave/test', 14:09:57 INFO - 'SHELL': '/bin/bash', 14:09:57 INFO - 'SHLVL': '1', 14:09:57 INFO - 'TERM': 'linux', 14:09:57 INFO - 'TMOUT': '86400', 14:09:57 INFO - 'USER': 'cltbld', 14:09:57 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:57 INFO - '_': '/tools/buildbot/bin/python'} 14:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09: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 14:09:58 INFO - Cleaning up... 14:09:58 INFO - Return code: 0 14:09:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:09: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 14:09: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 14:09:58 INFO - Using env: {'DISPLAY': ':0', 14:09:58 INFO - 'HOME': '/home/cltbld', 14:09:58 INFO - 'LANG': 'en_US.UTF-8', 14:09:58 INFO - 'LANGUAGE': 'en_US:en', 14:09:58 INFO - 'LOGNAME': 'cltbld', 14:09:58 INFO - 'MAIL': '/var/mail/cltbld', 14:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:58 INFO - 'MOZ_NO_REMOTE': '1', 14:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:58 INFO - 'NO_EM_RESTART': '1', 14:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:58 INFO - 'PWD': '/builds/slave/test', 14:09:58 INFO - 'SHELL': '/bin/bash', 14:09:58 INFO - 'SHLVL': '1', 14:09:58 INFO - 'TERM': 'linux', 14:09:58 INFO - 'TMOUT': '86400', 14:09:58 INFO - 'USER': 'cltbld', 14:09:58 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:58 INFO - '_': '/tools/buildbot/bin/python'} 14:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:58 INFO - Downloading/unpacking psutil>=3.1.1 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:00 INFO - Installing collected packages: psutil 14:10:00 INFO - Running setup.py install for psutil 14:10:00 INFO - building 'psutil._psutil_linux' extension 14:10: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 14:10: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 14:10:00 INFO - building 'psutil._psutil_posix' extension 14:10: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 14:10: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 14:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:00 INFO - Successfully installed psutil 14:10:00 INFO - Cleaning up... 14:10:00 INFO - Return code: 0 14:10:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:00 INFO - Using env: {'DISPLAY': ':0', 14:10:00 INFO - 'HOME': '/home/cltbld', 14:10:00 INFO - 'LANG': 'en_US.UTF-8', 14:10:00 INFO - 'LANGUAGE': 'en_US:en', 14:10:00 INFO - 'LOGNAME': 'cltbld', 14:10:00 INFO - 'MAIL': '/var/mail/cltbld', 14:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:00 INFO - 'MOZ_NO_REMOTE': '1', 14:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:00 INFO - 'NO_EM_RESTART': '1', 14:10:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:00 INFO - 'PWD': '/builds/slave/test', 14:10:00 INFO - 'SHELL': '/bin/bash', 14:10:00 INFO - 'SHLVL': '1', 14:10:00 INFO - 'TERM': 'linux', 14:10:00 INFO - 'TMOUT': '86400', 14:10:00 INFO - 'USER': 'cltbld', 14:10:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:00 INFO - '_': '/tools/buildbot/bin/python'} 14:10:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:03 INFO - Installing collected packages: mozsystemmonitor 14:10:03 INFO - Running setup.py install for mozsystemmonitor 14:10:03 INFO - Successfully installed mozsystemmonitor 14:10:03 INFO - Cleaning up... 14:10:03 INFO - Return code: 0 14:10:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:03 INFO - Using env: {'DISPLAY': ':0', 14:10:03 INFO - 'HOME': '/home/cltbld', 14:10:03 INFO - 'LANG': 'en_US.UTF-8', 14:10:03 INFO - 'LANGUAGE': 'en_US:en', 14:10:03 INFO - 'LOGNAME': 'cltbld', 14:10:03 INFO - 'MAIL': '/var/mail/cltbld', 14:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:03 INFO - 'MOZ_NO_REMOTE': '1', 14:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:03 INFO - 'NO_EM_RESTART': '1', 14:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:03 INFO - 'PWD': '/builds/slave/test', 14:10:03 INFO - 'SHELL': '/bin/bash', 14:10:03 INFO - 'SHLVL': '1', 14:10:03 INFO - 'TERM': 'linux', 14:10:03 INFO - 'TMOUT': '86400', 14:10:03 INFO - 'USER': 'cltbld', 14:10:03 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:03 INFO - '_': '/tools/buildbot/bin/python'} 14:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:03 INFO - Downloading/unpacking jsonschema==2.5.1 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:05 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:05 INFO - warning: no files found matching '*.txt' 14:10:05 INFO - no previously-included directories found matching 'build' 14:10:05 INFO - no previously-included directories found matching 'dist' 14:10:05 INFO - no previously-included directories found matching '.git*' 14:10:05 INFO - Installing collected packages: jsonschema, functools32 14:10:05 INFO - Running setup.py install for functools32 14:10:05 INFO - warning: no files found matching '*.txt' 14:10:05 INFO - no previously-included directories found matching 'build' 14:10:05 INFO - no previously-included directories found matching 'dist' 14:10:05 INFO - no previously-included directories found matching '.git*' 14:10:06 INFO - Successfully installed jsonschema functools32 14:10:06 INFO - Cleaning up... 14:10:06 INFO - Return code: 0 14:10:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:06 INFO - Using env: {'DISPLAY': ':0', 14:10:06 INFO - 'HOME': '/home/cltbld', 14:10:06 INFO - 'LANG': 'en_US.UTF-8', 14:10:06 INFO - 'LANGUAGE': 'en_US:en', 14:10:06 INFO - 'LOGNAME': 'cltbld', 14:10:06 INFO - 'MAIL': '/var/mail/cltbld', 14:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:06 INFO - 'MOZ_NO_REMOTE': '1', 14:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:06 INFO - 'NO_EM_RESTART': '1', 14:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:06 INFO - 'PWD': '/builds/slave/test', 14:10:06 INFO - 'SHELL': '/bin/bash', 14:10:06 INFO - 'SHLVL': '1', 14:10:06 INFO - 'TERM': 'linux', 14:10:06 INFO - 'TMOUT': '86400', 14:10:06 INFO - 'USER': 'cltbld', 14:10:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:06 INFO - '_': '/tools/buildbot/bin/python'} 14:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:10:06 INFO - Cleaning up... 14:10:06 INFO - Return code: 0 14:10:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:06 INFO - Using env: {'DISPLAY': ':0', 14:10:06 INFO - 'HOME': '/home/cltbld', 14:10:06 INFO - 'LANG': 'en_US.UTF-8', 14:10:06 INFO - 'LANGUAGE': 'en_US:en', 14:10:06 INFO - 'LOGNAME': 'cltbld', 14:10:06 INFO - 'MAIL': '/var/mail/cltbld', 14:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:06 INFO - 'MOZ_NO_REMOTE': '1', 14:10:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:06 INFO - 'NO_EM_RESTART': '1', 14:10:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:06 INFO - 'PWD': '/builds/slave/test', 14:10:06 INFO - 'SHELL': '/bin/bash', 14:10:06 INFO - 'SHLVL': '1', 14:10:06 INFO - 'TERM': 'linux', 14:10:06 INFO - 'TMOUT': '86400', 14:10:06 INFO - 'USER': 'cltbld', 14:10:06 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:06 INFO - '_': '/tools/buildbot/bin/python'} 14:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:08 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:09 INFO - Downloading docopt-0.6.1.tar.gz 14:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:09 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:09 INFO - Running setup.py install for blobuploader 14:10:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:09 INFO - Running setup.py install for requests 14:10:09 INFO - Running setup.py install for docopt 14:10:10 INFO - Successfully installed blobuploader requests docopt 14:10:10 INFO - Cleaning up... 14:10:10 INFO - Return code: 0 14:10:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:10 INFO - Using env: {'DISPLAY': ':0', 14:10:10 INFO - 'HOME': '/home/cltbld', 14:10:10 INFO - 'LANG': 'en_US.UTF-8', 14:10:10 INFO - 'LANGUAGE': 'en_US:en', 14:10:10 INFO - 'LOGNAME': 'cltbld', 14:10:10 INFO - 'MAIL': '/var/mail/cltbld', 14:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:10 INFO - 'MOZ_NO_REMOTE': '1', 14:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:10 INFO - 'NO_EM_RESTART': '1', 14:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:10 INFO - 'PWD': '/builds/slave/test', 14:10:10 INFO - 'SHELL': '/bin/bash', 14:10:10 INFO - 'SHLVL': '1', 14:10:10 INFO - 'TERM': 'linux', 14:10:10 INFO - 'TMOUT': '86400', 14:10:10 INFO - 'USER': 'cltbld', 14:10:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:10 INFO - '_': '/tools/buildbot/bin/python'} 14:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:10 INFO - Running setup.py (path:/tmp/pip-XzvxdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:10 INFO - Running setup.py (path:/tmp/pip-uyqv7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:10 INFO - Running setup.py (path:/tmp/pip-Wojg3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:10 INFO - Running setup.py (path:/tmp/pip-snDKQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:10 INFO - Running setup.py (path:/tmp/pip-3HY_Dx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:10 INFO - Running setup.py (path:/tmp/pip-RYgiNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:10 INFO - Running setup.py (path:/tmp/pip-SGKMSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:10 INFO - Running setup.py (path:/tmp/pip-4z0k_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:10 INFO - Running setup.py (path:/tmp/pip-2Zvx_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:11 INFO - Running setup.py (path:/tmp/pip-wyzGSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:11 INFO - Running setup.py (path:/tmp/pip-8vOYfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:11 INFO - Running setup.py (path:/tmp/pip-XJHZI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:11 INFO - Running setup.py (path:/tmp/pip-KIBrBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:11 INFO - Running setup.py (path:/tmp/pip-K9Pq2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:11 INFO - Running setup.py (path:/tmp/pip-EAm1RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:11 INFO - Running setup.py (path:/tmp/pip-GgdAFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:11 INFO - Running setup.py (path:/tmp/pip-Bxo1yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:11 INFO - Running setup.py install for manifestparser 14:10:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:11 INFO - Running setup.py install for mozcrash 14:10:11 INFO - Running setup.py install for mozdebug 14:10:11 INFO - Running setup.py install for mozdevice 14:10:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozfile 14:10:12 INFO - Running setup.py install for mozhttpd 14:10:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozinfo 14:10:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozInstall 14:10:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozleak 14:10:12 INFO - Running setup.py install for mozlog 14:10:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for moznetwork 14:10:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozprocess 14:10:12 INFO - Running setup.py install for mozprofile 14:10:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:12 INFO - Running setup.py install for mozrunner 14:10:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:13 INFO - Running setup.py install for mozscreenshot 14:10:13 INFO - Running setup.py install for moztest 14:10:13 INFO - Running setup.py install for mozversion 14:10:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:13 INFO - Cleaning up... 14:10:13 INFO - Return code: 0 14:10:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:13 INFO - Using env: {'DISPLAY': ':0', 14:10:13 INFO - 'HOME': '/home/cltbld', 14:10:13 INFO - 'LANG': 'en_US.UTF-8', 14:10:13 INFO - 'LANGUAGE': 'en_US:en', 14:10:13 INFO - 'LOGNAME': 'cltbld', 14:10:13 INFO - 'MAIL': '/var/mail/cltbld', 14:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:13 INFO - 'MOZ_NO_REMOTE': '1', 14:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:13 INFO - 'NO_EM_RESTART': '1', 14:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:13 INFO - 'PWD': '/builds/slave/test', 14:10:13 INFO - 'SHELL': '/bin/bash', 14:10:13 INFO - 'SHLVL': '1', 14:10:13 INFO - 'TERM': 'linux', 14:10:13 INFO - 'TMOUT': '86400', 14:10:13 INFO - 'USER': 'cltbld', 14:10:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:13 INFO - '_': '/tools/buildbot/bin/python'} 14:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:13 INFO - Running setup.py (path:/tmp/pip-dAT3rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10: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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:13 INFO - Running setup.py (path:/tmp/pip-Kk9xML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10: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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:13 INFO - Running setup.py (path:/tmp/pip-kM9mJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10: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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:13 INFO - Running setup.py (path:/tmp/pip-8C8iY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10: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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:13 INFO - Running setup.py (path:/tmp/pip-Td3Wa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10: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)) 14:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:14 INFO - Running setup.py (path:/tmp/pip-_cjpte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:14 INFO - Running setup.py (path:/tmp/pip-D6t1Q2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:14 INFO - Running setup.py (path:/tmp/pip-6nmE11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:14 INFO - Running setup.py (path:/tmp/pip-_ob3QD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:14 INFO - Running setup.py (path:/tmp/pip-DQkJe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:14 INFO - Running setup.py (path:/tmp/pip-QOcHx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:14 INFO - Running setup.py (path:/tmp/pip-4Y299s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:14 INFO - Running setup.py (path:/tmp/pip-kyRNW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:14 INFO - Running setup.py (path:/tmp/pip-yGnlKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:14 INFO - Running setup.py (path:/tmp/pip-VV8QwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:14 INFO - Running setup.py (path:/tmp/pip-BtuJn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10: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)) 14:10:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:14 INFO - Running setup.py (path:/tmp/pip-hmczAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10: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 14:10:16 INFO - Downloading blessings-1.6.tar.gz 14:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:16 INFO - Installing collected packages: blessings 14:10:16 INFO - Running setup.py install for blessings 14:10:17 INFO - Successfully installed blessings 14:10:17 INFO - Cleaning up... 14:10:17 INFO - Return code: 0 14:10:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:17 INFO - Reading from file tmpfile_stdout 14:10:17 INFO - Current package versions: 14:10:17 INFO - argparse == 1.2.1 14:10:17 INFO - blessings == 1.6 14:10:17 INFO - blobuploader == 1.2.4 14:10:17 INFO - docopt == 0.6.1 14:10:17 INFO - functools32 == 3.2.3-2 14:10:17 INFO - jsonschema == 2.5.1 14:10:17 INFO - manifestparser == 1.1 14:10:17 INFO - mozInstall == 1.12 14:10:17 INFO - mozcrash == 1.0 14:10:17 INFO - mozdebug == 0.1 14:10:17 INFO - mozdevice == 0.49 14:10:17 INFO - mozfile == 1.2 14:10:17 INFO - mozhttpd == 0.7 14:10:17 INFO - mozinfo == 0.9 14:10:17 INFO - mozleak == 0.1 14:10:17 INFO - mozlog == 3.4 14:10:17 INFO - moznetwork == 0.27 14:10:17 INFO - mozprocess == 0.25 14:10:17 INFO - mozprofile == 0.28 14:10:17 INFO - mozrunner == 6.13 14:10:17 INFO - mozscreenshot == 0.1 14:10:17 INFO - mozsystemmonitor == 0.3 14:10:17 INFO - moztest == 0.8 14:10:17 INFO - mozversion == 1.4 14:10:17 INFO - psutil == 3.1.1 14:10:17 INFO - requests == 1.2.3 14:10:17 INFO - wsgiref == 0.1.2 14:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:17 INFO - Using env: {'DISPLAY': ':0', 14:10:17 INFO - 'HOME': '/home/cltbld', 14:10:17 INFO - 'LANG': 'en_US.UTF-8', 14:10:17 INFO - 'LANGUAGE': 'en_US:en', 14:10:17 INFO - 'LOGNAME': 'cltbld', 14:10:17 INFO - 'MAIL': '/var/mail/cltbld', 14:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:17 INFO - 'MOZ_NO_REMOTE': '1', 14:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:17 INFO - 'NO_EM_RESTART': '1', 14:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:17 INFO - 'PWD': '/builds/slave/test', 14:10:17 INFO - 'SHELL': '/bin/bash', 14:10:17 INFO - 'SHLVL': '1', 14:10:17 INFO - 'TERM': 'linux', 14:10:17 INFO - 'TMOUT': '86400', 14:10:17 INFO - 'USER': 'cltbld', 14:10:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:17 INFO - '_': '/tools/buildbot/bin/python'} 14:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10: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)) 14:10:17 INFO - Cleaning up... 14:10:17 INFO - Return code: 0 14:10:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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 0x11d81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1216a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1476310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, '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': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', '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 14:10: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 14:10: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 14:10:17 INFO - Using env: {'DISPLAY': ':0', 14:10:17 INFO - 'HOME': '/home/cltbld', 14:10:17 INFO - 'LANG': 'en_US.UTF-8', 14:10:17 INFO - 'LANGUAGE': 'en_US:en', 14:10:17 INFO - 'LOGNAME': 'cltbld', 14:10:17 INFO - 'MAIL': '/var/mail/cltbld', 14:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:17 INFO - 'MOZ_NO_REMOTE': '1', 14:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:17 INFO - 'NO_EM_RESTART': '1', 14:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:17 INFO - 'PWD': '/builds/slave/test', 14:10:17 INFO - 'SHELL': '/bin/bash', 14:10:17 INFO - 'SHLVL': '1', 14:10:17 INFO - 'TERM': 'linux', 14:10:17 INFO - 'TMOUT': '86400', 14:10:17 INFO - 'USER': 'cltbld', 14:10:17 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:17 INFO - '_': '/tools/buildbot/bin/python'} 14:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:17 INFO - Cleaning up... 14:10:17 INFO - Return code: 0 14:10:17 INFO - Running post-action listener: _resource_record_post_action 14:10:17 INFO - Running post-action listener: _start_resource_monitoring 14:10:17 INFO - Starting resource monitoring. 14:10:17 INFO - [mozharness: 2017-04-14 21:10:17.851199Z] Finished create-virtualenv step (success) 14:10:17 INFO - [mozharness: 2017-04-14 21:10:17.851666Z] Running install step. 14:10:17 INFO - Running pre-action listener: _resource_record_pre_action 14:10:17 INFO - Running main action method: install 14:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:18 INFO - Reading from file tmpfile_stdout 14:10:18 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:18 INFO - Reading from file tmpfile_stdout 14:10:18 INFO - Output received: 14:10:18 INFO - Usage: mozinstall [options] installer 14:10:18 INFO - Options: 14:10:18 INFO - -h, --help show this help message and exit 14:10:18 INFO - -d DEST, --destination=DEST 14:10:18 INFO - Directory to install application into. [default: 14:10:18 INFO - "/builds/slave/test"] 14:10:18 INFO - --app=APP Application being installed. [default: firefox] 14:10:18 INFO - mkdir: /builds/slave/test/build/application 14:10: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'] 14:10:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:10:34 INFO - Reading from file tmpfile_stdout 14:10:34 INFO - Output received: 14:10:34 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:34 INFO - Running post-action listener: _resource_record_post_action 14:10:34 INFO - [mozharness: 2017-04-14 21:10:34.684983Z] Finished install step (success) 14:10:34 INFO - [mozharness: 2017-04-14 21:10:34.685254Z] Running run-tests step. 14:10:34 INFO - Running pre-action listener: _resource_record_pre_action 14:10:34 INFO - Running main action method: run_tests 14:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:34 INFO - Python 2.7.3 14:10:34 INFO - Return code: 0 14:10:34 INFO - grabbing minidump binary from tooltool 14:10:34 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')]} 14:10:34 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 0x1473400>, '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 0x14743b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1474840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:34 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 14:10:34 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 14:10:34 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 14:10:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:34 INFO - Return code: 0 14:10:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:34 INFO - ENV: RUST_BACKTRACE is now 1 14:10:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:10:34 INFO - Using env: {'DISPLAY': ':0', 14:10:34 INFO - 'HOME': '/home/cltbld', 14:10:34 INFO - 'LANG': 'en_US.UTF-8', 14:10:34 INFO - 'LANGUAGE': 'en_US:en', 14:10:34 INFO - 'LOGNAME': 'cltbld', 14:10:34 INFO - 'MAIL': '/var/mail/cltbld', 14:10:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:34 INFO - 'MOZ_NO_REMOTE': '1', 14:10:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:34 INFO - 'NO_EM_RESTART': '1', 14:10:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:34 INFO - 'PWD': '/builds/slave/test', 14:10:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:34 INFO - 'RUST_BACKTRACE': '1', 14:10:34 INFO - 'SHELL': '/bin/bash', 14:10:34 INFO - 'SHLVL': '1', 14:10:34 INFO - 'TERM': 'linux', 14:10:34 INFO - 'TMOUT': '86400', 14:10:34 INFO - 'USER': 'cltbld', 14:10:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019', 14:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:34 INFO - '_': '/tools/buildbot/bin/python'} 14:10:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:10:34 INFO - mozversion application_buildid: 20170414200637 14:10:34 INFO - mozversion application_changeset: e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f 14:10:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:10:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:34 INFO - mozversion application_name: Firefox 14:10:34 INFO - mozversion application_remotingname: firefox-dev 14:10:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:34 INFO - mozversion application_vendor: Mozilla 14:10:34 INFO - mozversion application_version: 54.0a2 14:10:34 INFO - mozversion platform_buildid: 20170414200637 14:10:34 INFO - mozversion platform_changeset: e53f7f1785ebedaf692d599d70e3a7a9e1bb5f4f 14:10:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:34 INFO - mozversion platform_version: 54.0a2 14:10:34 INFO - using testdate: 1492204234 14:10:34 INFO - actual date: 1492204234 14:10:34 INFO - starting webserver on 'localhost:38963' 14:10:34 INFO - SUITE-START | Running 2 tests 14:10:34 INFO - TEST-START | dromaeo_css 14:10:34 INFO - operating with platform_type : linux_ 14:10:34 INFO - Initialising browser for dromaeo_css test... 14:10:34 INFO - TEST-INFO | started process 14785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4NZhn/profile http://localhost:38963/getInfo.html) 14:10:38 INFO - PROCESS | 14785 | __metrics Screen width/height:1600/1200 14:10:38 INFO - PROCESS | 14785 | colorDepth:24 14:10:38 INFO - PROCESS | 14785 | Browser inner width/height: 1024/697 14:10:38 INFO - PROCESS | 14785 | __metrics 14:10:39 INFO - PROCESS | 14785 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:10:39 INFO - PROCESS | 14785 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:10:40 INFO - TEST-INFO | 14785: exit 0 14:10:40 INFO - Browser initialized. 14:10:40 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:40 INFO - TEST-INFO | started process 14878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpA4NZhn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:51 INFO - PROCESS | 14878 | RSS: Main: 140095488 14:10:51 INFO - PROCESS | 14878 | 14:13:52 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38963/tests/dromaeo/cssquery-ext.html) 14:13:54 INFO - PROCESS | 14878 | RSS: Main: 292028416 14:13:54 INFO - PROCESS | 14878 | 14:15:41 INFO - PROCESS | 14878 | ************************* 14:15:41 INFO - PROCESS | 14878 | A coding exception was thrown and uncaught in a Task. 14:15:41 INFO - PROCESS | 14878 | 14:15:41 ERROR - PROCESS | 14878 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:15:41 INFO - PROCESS | 14878 | Full stack: 14:15:41 INFO - PROCESS | 14878 | ************************* 14:15:41 INFO - PROCESS | 14878 | ************************* 14:15:41 INFO - PROCESS | 14878 | A coding exception was thrown and uncaught in a Task. 14:15:41 INFO - PROCESS | 14878 | 14:15:41 ERROR - PROCESS | 14878 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:15:41 INFO - PROCESS | 14878 | Full stack: 14:15:41 INFO - PROCESS | 14878 | ************************* 14:15:41 INFO - PROCESS | 14878 | ************************* 14:15:41 INFO - PROCESS | 14878 | A coding exception was thrown and uncaught in a Task. 14:15:41 INFO - PROCESS | 14878 | 14:15:41 ERROR - PROCESS | 14878 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:15:41 INFO - PROCESS | 14878 | Full stack: 14:15:42 INFO - PROCESS | 14878 | ************************* 14:15:42 INFO - PROCESS | 14878 | ************************* 14:15:42 INFO - PROCESS | 14878 | A coding exception was thrown and uncaught in a Task. 14:15:42 INFO - PROCESS | 14878 | 14:15:42 ERROR - PROCESS | 14878 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:15:42 INFO - PROCESS | 14878 | Full stack: 14:15:42 INFO - PROCESS | 14878 | ************************* 14:16:56 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-ext.html (next: http://localhost:38963/tests/dromaeo/cssquery-jquery.html) 14:16:57 INFO - PROCESS | 14878 | RSS: Main: 222433280 14:16:57 INFO - PROCESS | 14878 | 14:19:59 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38963/tests/dromaeo/cssquery-mootools.html) 14:19:59 INFO - PROCESS | 14878 | RSS: Main: 169234432 14:19:59 INFO - PROCESS | 14878 | 14:23:01 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38963/tests/dromaeo/cssquery-prototype.html) 14:23:02 INFO - PROCESS | 14878 | RSS: Main: 185081856 14:23:02 INFO - PROCESS | 14878 | 14:26:05 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38963/tests/dromaeo/cssquery-yui.html) 14:26:05 INFO - PROCESS | 14878 | RSS: Main: 174276608 14:26:05 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | Cycle 1(1): loaded http://localhost:38963/tests/dromaeo/cssquery-yui.html (next: http://localhost:38963/tests/dromaeo/cssquery-dojo.html) 14:29:08 INFO - PROCESS | 14878 | RSS: Main: 265138176 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | __start_tp_report 14:29:08 INFO - PROCESS | 14878 | _x_x_mozilla_page_load 14:29:08 INFO - PROCESS | 14878 | _x_x_mozilla_page_load_details 14:29:08 INFO - PROCESS | 14878 | |i|pagename|runs| 14:29:08 INFO - PROCESS | 14878 | |0;dojo.html;3313.1385839681684;3407.795532268064;3415.214500664847;3425.383430982422;3459.948100778487;5660.320761508615;5676.744546495407;5692.971535142324;5741.052726300156;5755.136729490573;5735.713214339287;5788.739506722197;5789.478946894778;5800.47795698387;5811.767529298823;5243.4232234454275;5261.631685781997;5302.178162384817;5307.150855863043;5314.92027619586;5131.923021154686;5152.536271735543;5349.224362467459;5363.034653762321;5374.113271310229;5175.120229560984;5226.738663066832;5294.205869119624;5314.043472175007;5325.147976323789;5311.442298558653;5320.973395133;5321.494458026481;5323.733813309358;5327.573794096483;5100.38795344561;5174.844754657366;5233.685978841282;5290.127129023706;5291.523762861322;5648.830535083954;5655.830325090254;5699.544036477072;5725.971370143165;5741.62679425836;6148.292946311187;6182.629042257479;6193.938060619426;6201;6205.782797602107;6252.218472690914;6273.027680709497;6280.591761535531;6282.057691346335;6285.465735412496;5583.3858275590055;5613.382527921925;5683.090705487102;5732.283464566929;5812;6239.500839932794;6246.375362463808;6252.437280644764;6253.062040693932;6257.405546473078;6046.5767396281835;6054.757809687563;6062.060380641008;6063.242094738158;6064.151018857364;5923.585349025527;5963.4931030862;6077.756889724362;6093.791924632529;6157.507399408037;6113.880349023491;6123.201403005315;6158.692065396802;6159;6167.198264225622;5951.196588460589;6004.3395226525045;6011.398860113954;6062.514998800086;6135.969320153371;4634.930476042862;4715.504871988392;4722.291656251521;4724.763761811896;4751.714897106184;4129.463169787909;4188.329867221291;4234.153169366077;4237.470316210473;4245.830166793356;5886.381929897385;5913.940860591425;5916.26046744157;5994.610350327215;6020.277566692025;6134.096280631919;6167.938320616737;6179.196704428486;6181.598196117238;6186.505079593621;6008.639481631116;6009;6009.218801555857;6016.09758536223;6033.064874944391;5090.541851233407;5144.6655967362;5151.587872970228;5235.528802407802;5236.6857988520815;6483.059956306309;6501.902471462932;6505.21937367519;6512.088307636935;6515.674216289167;6164.229471316085;6170.629762214281;6206.255249370104;6206.968965155145;6226.097215903759;6241.032639940817;6281.4660753834605;6293.590916590407;6298.1812364392335;6482.805515834532;6073.665948372882;6086.026235802427;6086.72609732572;6087.878242435215;6089.086637004485;6166.81499555014;6168.228971378578;6179.412955769195;6182.7217775201125;6187.195664563578;5839.328477225174;5864.032434648406;5989.760409583568;5993.280806303272;5995.700214989321;6051.213342265477;6104.481119104926;6106.206193195034;6106.664133472702;6137.048757442603;6049.909251361145;6061.212042434456;6066.363031881765;6068;6070.423309785563;5859.853503662272;5880.8235752927485;5913.142594323885;5919.970400147971;6084.087386891824;5838.678872662044;5852.356240813592;5854.619449735754;5862.648241105548;5864 14:29:08 INFO - PROCESS | 14878 | |1;ext.html;741.8924255982882;803.2369249213247;821.223943373512;901.7339884734007;904.4799240436743;30519.847400762992;43702.781486092565;44180.77909610452;44192.33711494322;44315;44372.11255774883;44506.777466112624;44517.332240016345;44565;44569;7566.546007239555;7725.575093369863;8960.507172105532;9089.272858171364;9095.454272743624;10140.797184056351;10330.58677652893;10534.894651053468;10622.309549879272;10624.840627390595;10418.426986515738;10439.582416703322;10441.530131144078;10457.424841633707;10464.738381540446;10385.532651030722;10388;10405.21960852939;10415.114715249212;10430.165586753117;10078.697639070839;10079.294449388546;10153.644622438253;10194.694159175237;10208;39636;39813.402798958035;39852.402213966816;39884;39895.401568976486;4073.144639625682;4077.938830917539;4181.163767246563;4239.385289133089;4263.18999390118;26385.990021269423;28919.56620650692;29010.709892901014;29012.41975160506;29423.852880735674;4267.295896177127;4267.829286828523;4337.371081193241;4398.120375924827;4409.140217657558;243273;243818;244009;244391;244399;44611.33083003757;44795.32807007898;44813;44930.32604510935;44969.77515112469;46786.76606617013;46986.5301346989;47114.29328560075;47238.291425628646;47238.76380618075;15445.922770386076;15585.06489610627;15593.064416135068;15617.60955976087;15633;11858.051355891508;12104.515819367303;13602.387892544859;13605.455781768816;13620.591382258548;12711.682207944876;12723.172993755376;12824.935875320563;12953.676158095934;13038.739225215442;5437.809676661298;5510.586705997066;5542.944570554324;5553.8333849984565;5588.161775733673;990.2770977186694;997.7356000659686;1005.8541511480794;1007.4257673126394;1018.4296793795498;27712.861435692692;27882.721172788417;28023;28324.71675283262;28329.858350708113;1090.2368342160519;1097.2757979733337;1099.2140619457127;1104.2325583719237;1136.6135513925306;14609.92695036518;15083.095014299177;15135.52089683173;15145.697086058217;15334.539963801104;346150;348293;348427;348652;348870;54946.72526637341;55009.724951375785;55035.72482137644;55106.72446637741;55209.171862422096;1514.1369419430819;1535.5163123616248;1535.6007438066183;1561.7032763774846;1563.6090977255685;26108.8694556526;27201.31996700098;27223.86388068047;27596.448071038067;27737.86131069332;40607.3908891361;40706.389404159556;40760.388594170516;40888.1822363557;40901.59098408978;301528;301956;302038;303005;303271;31960.84019579887;32327;32586;32608.83695581507;32872.178195545304;42919.57080429281;43506.34740478832;43968.34047489354;44399.77800111108;44560.10879782451;32202.19494512656;32703.672963270063;32810.343793124484;33045.8226387316;33589.3282134351;29799.404011920073;30195.849020754755;33228;33283.50074748929;33401.49897751487;35154.82422587871;35896.102597435274;36088.45867312045;36091.45862812112;36266.456003159445;29798.404031918806;29888.402231955675;29959.550606740482;30222;30548.236294091937;23769.762302377447;24222.87888560546;24920.376990574656;25205.621915671647;25325.873370633766 14:29:08 INFO - PROCESS | 14878 | |2;jquery.html;415.3727870914918;468.78670205056704;471.87693289969866;476.99592358086227;484.566313149731;18425.447236582906;19398.90300548497;21007.369778906617;21007.36977890664;21186.36440906775;21205.681914771252;21643.45891352717;22307.107715691393;22749.31752047437;22826.315210543667;6355.777547785829;6424.743010279583;6572.507061970347;6663.200415950093;6721.966390168067;6537.378948999861;6637.668116594175;6644;6646.9667651661675;6651.501137414689;4118.423420721101;4567.931481027787;4656.580907718305;7778.338841198505;7974.242446967529;7822.804429889241;7831.569263690495;8052.51684898905;8053.073896501889;8077.192280771935;7697.730579429693;7922.564258965755;7937.404694647867;7937.968064151623;7941.166177551389;28013;29462.852685736434;30087.699123008926;30216.24459388511;30257.243568910733;3180.189051791778;3322.9833850830832;3594.1733401317583;3797.6392242736897;3822.694184465264;14653.706925861423;18583.16375763094;18728.250869965184;18975.335863244858;19677.016149192626;2169.208238992772;2303.825049224891;2331.2306938710185;2342.332435255944;2357.846739961897;98233.5088324561;99256;99401;116151.41924290408;124398.37800811029;16541.338346466247;20552.588948220953;21813.563728725338;22446.887765561067;22856.542869142522;42899.35650965238;44163.337549936776;44261.77869110634;44417;45000.54999449963;11845.407729613486;11872.88127118735;11941.402929853473;12005.339706316236;12058.336791476553;9324.90675093254;9413.952930235306;9727.221822254203;9846.852297215548;9911.306208565331;10875.401326922014;11000.174986876016;11017.889821101686;11019.272799523083;11138.276012059352;3833.9808300958316;3900.31744444721;4090.406891000788;4179.791010449465;4236.743358598294;948.691675205561;951.5194826612517;956.6269155029544;968.801395713877;982.0670363155032;20070.698939515918;20412.0814563345;21079.68380474294;21476.89261553682;21759.12963481443;973.3721749471551;992.161623428202;993.895640957689;1006.8640733500883;1018.3024628129755;11177.441127943734;11623.244489108181;11709.882901170879;11816.704582385337;11926;693339;702962;705093;746654;747537;116610;116679.41660291645;118274.40862795804;119306.4034679821;121845.39077304734;1246.7132559511363;1270.726793739332;1277.3932382118605;1311.6065180445637;1331.42083193811;17557.385491507735;18944.336948206746;20234.392968210977;20255;20305.49236269105;52254.738726306125;54345;55284.72357638186;55445;55934.72032639811;59754.70122649359;68174.31825681878;68252.3174768246;69157.65421172862;70808.64595676989;12552.435140418886;12921.870781292067;13044.478220871439;13219.272939988394;13244.735105297646;12246.203996740183;13397.12918660284;13641.658958525719;13704.931475342559;13794.448222071005;11998.460069297078;12034.63896083119;12403.875961240272;12474.313912734886;12570.87429125697;11433.428328583705;11627;11909;12091;12231.938840306097;12396.876031239572;12823.93588032054;12841.614751557468;13028.609141725763;13221.338933053501;12434;12459;12678.366081695694;12752.42614082387;12855.550055748005;11327.093832493216;12145.939270303592;12367;12690.809637855624;12725.745485090432 14:29:08 INFO - PROCESS | 14878 | |3;mootools.html;1543.0278924277711;1566.2638559876855;1573.5122112145236;1575.3383578896864;1581.825999140095;10723.731906702327;11380.317180969127;11425.200235983484;11428.885711142886;11434.771304573904;11215.943920280408;11284.153688473356;11556.768864622703;11568.132390070736;11590.188686791927;2413.1795189635477;2431.112643884987;2450.4976479821594;2452.448199155194;2453.595156799126;2369.5024044950583;2413.9758602414013;2466.728659847415;2468.518638865422;2469.148143890364;2360.704911886014;2426.2236084452984;2433.1605596069417;2440.036185706645;2451.3258853815255;2269.103704036913;2300.9654855177187;2307.457747429361;2308.988455057722;2405.458771776354;2357.092519380034;2390.187336305647;2390.5816482115733;2393.3298676370646;2395.6646069550275;11318.490667919963;11591;11597.188196826226;11598.420078996101;11601.941990289995;5703.74333155009;5834.445727655866;5845.386234445407;5845.88308233833;5846.707664616794;3342.097633638928;3416.6583341665632;3420.1449637590604;3430.5368775215525;3470.1845066409373;1196.8922796948316;1230.7107829660113;1268.099649249025;1315.270025136049;1353.5871559174448;14645.487407940778;15034.699306013928;15962.36150553988;17604;17808.732869006973;4614.423197100363;4711.882202944886;4799.0401919616215;4814.277858321209;4817.397825271841;11073.335599864035;11348.546058157746;12782.552610658582;12798.61604151877;12808.039397045259;5582;5754.74103665336;5820.447057529528;5837;5840.707964601753;5337.412884582693;5396.9730151348995;5397;5399.514043736004;5405.459454054563;3882.2429626222615;3928.9214215715524;3957.782321972319;3996.2806694795217;4001.2197621463533;1037.2117190934944;1042.301657889201;1046.6546039806997;1049.6483677967813;1056.9524371403306;1060.5068643081004;1073.2004656530935;1076.5370890516997;1082.1451053667515;1082.6860210539014;7149.9285007149265;7194.100737407824;7260.96369518149;7320.780376588711;7404.666789994463;1064.5794911010107;1068.3216157739892;1073.1843798712878;1077.6551503518956;1080.4921686807188;4462.9776851116185;4555.544445555484;4593.081383723269;4753.619710423158;4772.880677983008;13526;14172.433102675983;14735.631609209855;14735.852641473663;14753.852461475462;14513.564593062225;14588.197649129399;14591.854081459262;14616.926915365355;14624.19566923808;10601.575936962436;10778.4071876046;10799.298045627009;10830.241883068109;10833.891661083288;7284.1789552611845;7593.468457207942;7678.1170165431695;7757.896841263314;7763.534187948741;13041.152325098838;13054.282014489294;13116.147450415692;13141.34293285351;13286.86713132895;13469.797953030517;13484.595462136152;13538.729225415633;13616.114952528054;13698;8215.9589202056;9384.57769400365;9831.115199632068;9894.257930655085;9913.801723965336;10679.305845120043;10792.892071079503;10802.513886875267;11164.441777911234;11556.94221528887;9201.263898888206;9266.907330926604;9301.069893010645;9516.19112375456;9715.27135464857;8856;8956.776080598038;9090.045545217921;9156.908430915872;9353.251739860658;8165.714200002972;8239.299659529008;8254;8254.174582541698;8294.129116442928;6008.699565021644;6092.116643086816;6124.387561244018;6157.076438534076;6218.751249949952;6176.969115154396;6186.505079593711;6195.721192546256;6213.254409470893;6422.486201103807 14:29:08 INFO - PROCESS | 14878 | |4;prototype.html;402.3542214745332;416.8353500367355;427.4251132227153;427.90586071064365;436.5416312871484;5130.333056702623;5228.921566176501;5261.81583644572;5318.388385335683;5402.756875940582;5124.564412024973;5190.273361729352;5216.895662086756;5218.843434696955;5225.059489291926;4566.7441453600195;4570.840020599279;4572.222722137236;4602.125596136723;4617.468991066037;4428.313611390224;4464.888377790565;4565.885852853672;4624.930626040612;4634.58288754012;4507.183010618363;4520.231560634684;4525.366448697185;4528.932066019012;4559.293309537027;4517.763706965074;4546.590806827385;4577.862664120082;4598.26427771555;4632;4017.337139372;4159.188958153131;4465.397171381855;4480.753558554278;4503.54964503547;5010.72441015744;5054.949450505522;5057.645964782467;5075.593952483792;5107.182850743863;5074.477656702974;5088.516590923857;5092.949070509285;5116.283720279164;5120.641555091145;5319.867003324909;5343.530529104489;5449.863753406157;5482.5613950883835;5500;4528.818847246106;4544.272916333371;4585.4726706428855;4597.4712908015335;4600.2869555218995;5727.255456790591;5744.712764361765;5751.491590130017;5789.797357092523;5793.797217097382;4687.601553867891;4773.541626062581;4804.543568361;4804.95195048045;4808.519148085234;4791.712497250176;4802.655256528178;4846.975765121152;4855.465898751135;4885.877853053702;5129.230615407644;5154.304168937146;5163.664361816545;5184.507471790174;5203.19350500673;5278.762455689503;5362.410134885159;5508.6970216637665;5561.833145005657;5568.443155684399;1556.159673776148;1625.6992456395606;1645.3500867157406;1655.337864854068;1669.3155806119432;1213.2780995307778;1264.2477725753163;1269.6571925580042;1276.5978716704208;1288.6327396691897;5437.184422336682;5444.292242008592;5447.509724124848;5453.972730136404;5456.399796022434;5646.774129034792;5651.378348381675;5652.18043383707;5659.18905950092;5708.173384516915;5254.868628284324;5306.469353064663;5399.78400863961;5406.215948736907;5472;2912.6019710237692;2975.9404811904074;2978.687237840039;2983.701629837042;2984.492636251842;5598.312809851294;5907.881842363128;5909;5929.555283353766;5941.910871336933;5705.657660540381;5724.341700704389;5735.799247026334;5751.252337196222;5771.8557036074435;5866.911996320058;5906.232189815382;5907.645541267538;5915.692879776804;5927.8221653350465;5434.2935418395355;5529.336479622471;5591.8816236752;5592.804251851166;5629.577781666473;5500.092484739973;5518.917216241679;5523.7238138093735;5527.39198688152;5558.694271815089;5578.804741834017;5842.591018628656;5846.736896839738;5856.677882716492;5873.324567674772;4681.812727490862;4693.0992947856175;4693.413323334583;4723.315119307613;4750.904981900274;5491.780328786804;5553.305836770403;5595.642614431309;5665.20687103814;5668.627166835726;5517.158663288329;5519.972400137974;5524.75138618755;5565.749541270734;5607.158926161109;5525.010996041341;5528.55771538284;5538.16927460868;5563.554915606823;5593.720313984366;5223.425423203521;5453.254958413269;5504.80733174353;5525.557955363642;5550.974718778195;5535.584831137761;5536.474034966672;5538.944610553843;5588.972055139699;5666.150077488245;5220.5823534117935;5353.170258609922;5362.812301569426;5418.376886658085;5509.338879334506 14:29:08 INFO - PROCESS | 14878 | |5;yui.html;815.4210510537519;855.597869001569;902.9367944243903;934.5841100710187;937.8593211018347;14603.415863365466;18716.719249211274;18726;18736.156872940715;18739;16169.514914552552;16887.831121688778;16981.06604136772;16997.745033824503;17023.82976170241;881.9735407937773;904.7104926423547;905.3662436294587;908.1508789282043;908.2053203446984;866.0559989611322;885.9379843410932;886.9423487473326;887.3389324952919;887.5828360670474;955.3169483819067;956.4643799472283;957.899420560838;959.1511512311585;959.6497278493334;946.8863736351612;946.966856160031;947.4552132523792;947.663579429303;948.5826236456006;693.5457275484565;698.91263592051;700.1318365227132;700.2227527444533;700.3591713582066;16372.672546549122;16530;16720;18250.452486425427;18694.34569790051;15847.128407937558;16142.596435089099;16171.595710107224;16365.34538618454;16550.83449165505;13540.593782186452;13777.311134443238;13787.724245515034;13971.09187902783;14270.072445291024;3957.98021009896;4083.8774836754947;4096.795160241976;4096.856610018635;4200.642945349649;84806;89413;89711;90418.5479072607;91195;12504.562340318045;12576.434060467302;12591.181573197713;12690.238585684889;12815.935920320338;23364.299071027897;23785;23790.405239868796;23790.881045595008;23791.167309144097;8664.523451210118;8736.8689469658;8791.824163516694;8834.602442890086;8954.955225223832;4813.566778989908;4891.192953162688;4894.877628059327;4935.161022626162;5078.796848126033;3825.846966121324;3924.4309575111447;3931.253061918226;3932.4297976793205;3933;612.761023200952;628.6102616377875;640.7821340744076;642.1651852591613;643.8519140597596;853.833502467013;858.9785255368665;864.6498168241872;878.9252913502296;881.66496731243;11140.82974879983;11481;11555.537778488935;11914.52341906314;11937.940310298392;824.8762685597088;827.8840962265288;830.4685001598981;860.4794099569671;867.1631875240423;5176.559992400613;5198.884675218812;5225.790968361223;5230.843074707689;5239.790408383622;78106;79183.60408198037;79254;79851.20148798554;81932.18067819365;67721;69377;70038.29961700318;70120.64939675269;72879.63560182165;63859;64940.35059649343;65582.67208663926;66364.66817665978;67254.66372668203;9785.706428807147;10033.397996120257;10094.646687365906;10142.442165680959;10274.280800344202;43568.782156089015;43576.56423435725;43887.34168987531;44522.77738611286;44765.552344476135;49644.50355496399;49859.501404986935;50277.24584131314;50801.49198507968;52298;14233;14445.483224261301;14451.85548144505;14591;14644.341004654603;16376.426825061066;16623.66752664916;16679.666406671557;16849.663006739553;17942;13901.443942242196;14216.911966541513;14847.257637117886;15741;15984.840151598335;14901.478448254258;15357.385704571692;15481.920799684916;16017.839821601634;16096.812715162849;12896;13874.167549947035;15020.549383518512;15796.526104216891;16107.919460402623;11274.436278186222;11321.264117832645;11565.653030409101;11742.17804753659;12203.755924881276;11291.209615326849;12666.873331266937;12816.423260953094;13123.212607243597;13124.671883202996 14:29:08 INFO - PROCESS | 14878 | __end_tp_report 14:29:08 INFO - PROCESS | 14878 | __start_cc_report 14:29:08 INFO - PROCESS | 14878 | _x_x_mozilla_cycle_collect,1510 14:29:08 INFO - PROCESS | 14878 | __end_cc_report 14:29:08 INFO - PROCESS | 14878 | __startTimestamp1492205348602__endTimestamp 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | ------- Summary: start ------- 14:29:08 INFO - PROCESS | 14878 | Number of tests: 6 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#0] dojo.html Cycles:165 Average:5727.76 Median:5989.76 stddev:644.22 (10.8%) stddev-sans-first:617.72 14:29:08 INFO - PROCESS | 14878 | Values: 3313.1 3407.8 3415.2 3425.4 3459.9 5660.3 5676.7 5693.0 5741.1 5755.1 5735.7 5788.7 5789.5 5800.5 5811.8 5243.4 5261.6 5302.2 5307.2 5314.9 5131.9 5152.5 5349.2 5363.0 5374.1 5175.1 5226.7 5294.2 5314.0 5325.1 5311.4 5321.0 5321.5 5323.7 5327.6 5100.4 5174.8 5233.7 5290.1 5291.5 5648.8 5655.8 5699.5 5726.0 5741.6 6148.3 6182.6 6193.9 6201.0 6205.8 6252.2 6273.0 6280.6 6282.1 6285.5 5583.4 5613.4 5683.1 5732.3 5812.0 6239.5 6246.4 6252.4 6253.1 6257.4 6046.6 6054.8 6062.1 6063.2 6064.2 5923.6 5963.5 6077.8 6093.8 6157.5 6113.9 6123.2 6158.7 6159.0 6167.2 5951.2 6004.3 6011.4 6062.5 6136.0 4634.9 4715.5 4722.3 4724.8 4751.7 4129.5 4188.3 4234.2 4237.5 4245.8 5886.4 5913.9 5916.3 5994.6 6020.3 6134.1 6167.9 6179.2 6181.6 6186.5 6008.6 6009.0 6009.2 6016.1 6033.1 5090.5 5144.7 5151.6 5235.5 5236.7 6483.1 6501.9 6505.2 6512.1 6515.7 6164.2 6170.6 6206.3 6207.0 6226.1 6241.0 6281.5 6293.6 6298.2 6482.8 6073.7 6086.0 6086.7 6087.9 6089.1 6166.8 6168.2 6179.4 6182.7 6187.2 5839.3 5864.0 5989.8 5993.3 5995.7 6051.2 6104.5 6106.2 6106.7 6137.0 6049.9 6061.2 6066.4 6068.0 6070.4 5859.9 5880.8 5913.1 5920.0 6084.1 5838.7 5852.4 5854.6 5862.6 5864.0 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#1] ext.html Cycles:180 Average:45788.53 Median:31254.54 stddev:78829.76 (252.2%) stddev-sans-first:78978.34 14:29:08 INFO - PROCESS | 14878 | Values: 741.9 803.2 821.2 901.7 904.5 30519.8 43702.8 44180.8 44192.3 44315.0 44372.1 44506.8 44517.3 44565.0 44569.0 7566.5 7725.6 8960.5 9089.3 9095.5 10140.8 10330.6 10534.9 10622.3 10624.8 10418.4 10439.6 10441.5 10457.4 10464.7 10385.5 10388.0 10405.2 10415.1 10430.2 10078.7 10079.3 10153.6 10194.7 10208.0 39636.0 39813.4 39852.4 39884.0 39895.4 4073.1 4077.9 4181.2 4239.4 4263.2 26386.0 28919.6 29010.7 29012.4 29423.9 4267.3 4267.8 4337.4 4398.1 4409.1 243273.0 243818.0 244009.0 244391.0 244399.0 44611.3 44795.3 44813.0 44930.3 44969.8 46786.8 46986.5 47114.3 47238.3 47238.8 15445.9 15585.1 15593.1 15617.6 15633.0 11858.1 12104.5 13602.4 13605.5 13620.6 12711.7 12723.2 12824.9 12953.7 13038.7 5437.8 5510.6 5542.9 5553.8 5588.2 990.3 997.7 1005.9 1007.4 1018.4 27712.9 27882.7 28023.0 28324.7 28329.9 1090.2 1097.3 1099.2 1104.2 1136.6 14609.9 15083.1 15135.5 15145.7 15334.5 346150.0 348293.0 348427.0 348652.0 348870.0 54946.7 55009.7 55035.7 55106.7 55209.2 1514.1 1535.5 1535.6 1561.7 1563.6 26108.9 27201.3 27223.9 27596.4 27737.9 40607.4 40706.4 40760.4 40888.2 40901.6 301528.0 301956.0 302038.0 303005.0 303271.0 31960.8 32327.0 32586.0 32608.8 32872.2 42919.6 43506.3 43968.3 44399.8 44560.1 32202.2 32703.7 32810.3 33045.8 33589.3 29799.4 30195.8 33228.0 33283.5 33401.5 35154.8 35896.1 36088.5 36091.5 36266.5 29798.4 29888.4 29959.6 30222.0 30548.2 23769.8 24222.9 24920.4 25205.6 25325.9 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#2] jquery.html Cycles:180 Average:40096.62 Median:22377.00 stddev:118209.50 (528.3%) stddev-sans-first:118503.56 14:29:08 INFO - PROCESS | 14878 | Values: 415.4 468.8 471.9 477.0 484.6 18425.4 19398.9 21007.4 21007.4 21186.4 21205.7 21643.5 22307.1 22749.3 22826.3 6355.8 6424.7 6572.5 6663.2 6722.0 6537.4 6637.7 6644.0 6647.0 6651.5 4118.4 4567.9 4656.6 7778.3 7974.2 7822.8 7831.6 8052.5 8053.1 8077.2 7697.7 7922.6 7937.4 7938.0 7941.2 28013.0 29462.9 30087.7 30216.2 30257.2 3180.2 3323.0 3594.2 3797.6 3822.7 14653.7 18583.2 18728.3 18975.3 19677.0 2169.2 2303.8 2331.2 2342.3 2357.8 98233.5 99256.0 99401.0 116151.4 124398.4 16541.3 20552.6 21813.6 22446.9 22856.5 42899.4 44163.3 44261.8 44417.0 45000.5 11845.4 11872.9 11941.4 12005.3 12058.3 9324.9 9414.0 9727.2 9846.9 9911.3 10875.4 11000.2 11017.9 11019.3 11138.3 3834.0 3900.3 4090.4 4179.8 4236.7 948.7 951.5 956.6 968.8 982.1 20070.7 20412.1 21079.7 21476.9 21759.1 973.4 992.2 993.9 1006.9 1018.3 11177.4 11623.2 11709.9 11816.7 11926.0 693339.0 702962.0 705093.0 746654.0 747537.0 116610.0 116679.4 118274.4 119306.4 121845.4 1246.7 1270.7 1277.4 1311.6 1331.4 17557.4 18944.3 20234.4 20255.0 20305.5 52254.7 54345.0 55284.7 55445.0 55934.7 59754.7 68174.3 68252.3 69157.7 70808.6 12552.4 12921.9 13044.5 13219.3 13244.7 12246.2 13397.1 13641.7 13704.9 13794.4 11998.5 12034.6 12403.9 12474.3 12570.9 11433.4 11627.0 11909.0 12091.0 12231.9 12396.9 12823.9 12841.6 13028.6 13221.3 12434.0 12459.0 12678.4 12752.4 12855.6 11327.1 12145.9 12367.0 12690.8 12725.7 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#3] mootools.html Cycles:180 Average:7089.86 Median:2400.56 stddev:4508.38 (187.8%) stddev-sans-first:4501.76 14:29:08 INFO - PROCESS | 14878 | Values: 1543.0 1566.3 1573.5 1575.3 1581.8 10723.7 11380.3 11425.2 11428.9 11434.8 11215.9 11284.2 11556.8 11568.1 11590.2 2413.2 2431.1 2450.5 2452.4 2453.6 2369.5 2414.0 2466.7 2468.5 2469.1 2360.7 2426.2 2433.2 2440.0 2451.3 2269.1 2301.0 2307.5 2309.0 2405.5 2357.1 2390.2 2390.6 2393.3 2395.7 11318.5 11591.0 11597.2 11598.4 11601.9 5703.7 5834.4 5845.4 5845.9 5846.7 3342.1 3416.7 3420.1 3430.5 3470.2 1196.9 1230.7 1268.1 1315.3 1353.6 14645.5 15034.7 15962.4 17604.0 17808.7 4614.4 4711.9 4799.0 4814.3 4817.4 11073.3 11348.5 12782.6 12798.6 12808.0 5582.0 5754.7 5820.4 5837.0 5840.7 5337.4 5397.0 5397.0 5399.5 5405.5 3882.2 3928.9 3957.8 3996.3 4001.2 1037.2 1042.3 1046.7 1049.6 1057.0 1060.5 1073.2 1076.5 1082.1 1082.7 7149.9 7194.1 7261.0 7320.8 7404.7 1064.6 1068.3 1073.2 1077.7 1080.5 4463.0 4555.5 4593.1 4753.6 4772.9 13526.0 14172.4 14735.6 14735.9 14753.9 14513.6 14588.2 14591.9 14616.9 14624.2 10601.6 10778.4 10799.3 10830.2 10833.9 7284.2 7593.5 7678.1 7757.9 7763.5 13041.2 13054.3 13116.1 13141.3 13286.9 13469.8 13484.6 13538.7 13616.1 13698.0 8216.0 9384.6 9831.1 9894.3 9913.8 10679.3 10792.9 10802.5 11164.4 11556.9 9201.3 9266.9 9301.1 9516.2 9715.3 8856.0 8956.8 9090.0 9156.9 9353.3 8165.7 8239.3 8254.0 8254.2 8294.1 6008.7 6092.1 6124.4 6157.1 6218.8 6177.0 6186.5 6195.7 6213.3 6422.5 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#4] prototype.html Cycles:180 Average:4836.34 Median:5270.29 stddev:1273.22 (24.2%) stddev-sans-first:1232.53 14:29:08 INFO - PROCESS | 14878 | Values: 402.4 416.8 427.4 427.9 436.5 5130.3 5228.9 5261.8 5318.4 5402.8 5124.6 5190.3 5216.9 5218.8 5225.1 4566.7 4570.8 4572.2 4602.1 4617.5 4428.3 4464.9 4565.9 4624.9 4634.6 4507.2 4520.2 4525.4 4528.9 4559.3 4517.8 4546.6 4577.9 4598.3 4632.0 4017.3 4159.2 4465.4 4480.8 4503.5 5010.7 5054.9 5057.6 5075.6 5107.2 5074.5 5088.5 5092.9 5116.3 5120.6 5319.9 5343.5 5449.9 5482.6 5500.0 4528.8 4544.3 4585.5 4597.5 4600.3 5727.3 5744.7 5751.5 5789.8 5793.8 4687.6 4773.5 4804.5 4805.0 4808.5 4791.7 4802.7 4847.0 4855.5 4885.9 5129.2 5154.3 5163.7 5184.5 5203.2 5278.8 5362.4 5508.7 5561.8 5568.4 1556.2 1625.7 1645.4 1655.3 1669.3 1213.3 1264.2 1269.7 1276.6 1288.6 5437.2 5444.3 5447.5 5454.0 5456.4 5646.8 5651.4 5652.2 5659.2 5708.2 5254.9 5306.5 5399.8 5406.2 5472.0 2912.6 2975.9 2978.7 2983.7 2984.5 5598.3 5907.9 5909.0 5929.6 5941.9 5705.7 5724.3 5735.8 5751.3 5771.9 5866.9 5906.2 5907.6 5915.7 5927.8 5434.3 5529.3 5591.9 5592.8 5629.6 5500.1 5518.9 5523.7 5527.4 5558.7 5578.8 5842.6 5846.7 5856.7 5873.3 4681.8 4693.1 4693.4 4723.3 4750.9 5491.8 5553.3 5595.6 5665.2 5668.6 5517.2 5520.0 5524.8 5565.7 5607.2 5525.0 5528.6 5538.2 5563.6 5593.7 5223.4 5453.3 5504.8 5525.6 5551.0 5535.6 5536.5 5538.9 5589.0 5666.2 5220.6 5353.2 5362.8 5418.4 5509.3 14:29:08 INFO - PROCESS | 14878 | 14:29:08 INFO - PROCESS | 14878 | [#5] yui.html Cycles:180 Average:18737.83 Median:43731.95 stddev:23235.46 (53.1%) stddev-sans-first:23261.66 14:29:08 INFO - PROCESS | 14878 | Values: 815.4 855.6 902.9 934.6 937.9 14603.4 18716.7 18726.0 18736.2 18739.0 16169.5 16887.8 16981.1 16997.7 17023.8 882.0 904.7 905.4 908.2 908.2 866.1 885.9 886.9 887.3 887.6 955.3 956.5 957.9 959.2 959.6 946.9 947.0 947.5 947.7 948.6 693.5 698.9 700.1 700.2 700.4 16372.7 16530.0 16720.0 18250.5 18694.3 15847.1 16142.6 16171.6 16365.3 16550.8 13540.6 13777.3 13787.7 13971.1 14270.1 3958.0 4083.9 4096.8 4096.9 4200.6 84806.0 89413.0 89711.0 90418.5 91195.0 12504.6 12576.4 12591.2 12690.2 12815.9 23364.3 23785.0 23790.4 23790.9 23791.2 8664.5 8736.9 8791.8 8834.6 8955.0 4813.6 4891.2 4894.9 4935.2 5078.8 3825.8 3924.4 3931.3 3932.4 3933.0 612.8 628.6 640.8 642.2 643.9 853.8 859.0 864.6 878.9 881.7 11140.8 11481.0 11555.5 11914.5 11937.9 824.9 827.9 830.5 860.5 867.2 5176.6 5198.9 5225.8 5230.8 5239.8 78106.0 79183.6 79254.0 79851.2 81932.2 67721.0 69377.0 70038.3 70120.6 72879.6 63859.0 64940.4 65582.7 66364.7 67254.7 9785.7 10033.4 10094.6 10142.4 10274.3 43568.8 43576.6 43887.3 44522.8 44765.6 49644.5 49859.5 50277.2 50801.5 52298.0 14233.0 14445.5 14451.9 14591.0 14644.3 16376.4 16623.7 16679.7 16849.7 17942.0 13901.4 14216.9 14847.3 15741.0 15984.8 14901.5 15357.4 15481.9 16017.8 16096.8 12896.0 13874.2 15020.5 15796.5 16107.9 11274.4 11321.3 11565.7 11742.2 12203.8 11291.2 12666.9 12816.4 13123.2 13124.7 14:29:08 INFO - PROCESS | 14878 | -------- Summary: end -------- 14:29:08 INFO - PROCESS | 14878 | 14:29:09 INFO - TEST-INFO | 14878: exit 0 14:29:09 INFO - TEST-OK | dromaeo_css | took 1114416ms 14:29:09 INFO - TEST-START | kraken 14:29:09 INFO - operating with platform_type : linux_ 14:29:09 INFO - Initialising browser for kraken test... 14:29:09 INFO - TEST-INFO | started process 15204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1HLdX/profile http://localhost:38963/getInfo.html) 14:29:12 INFO - PROCESS | 15204 | __metrics Screen width/height:1600/1200 14:29:12 INFO - PROCESS | 15204 | colorDepth:24 14:29:12 INFO - PROCESS | 15204 | Browser inner width/height: 1024/697 14:29:12 INFO - PROCESS | 15204 | __metrics 14:29:13 INFO - PROCESS | 15204 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:29:13 INFO - PROCESS | 15204 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:29:14 INFO - TEST-INFO | 15204: exit 0 14:29:14 INFO - Browser initialized. 14:29:14 INFO - Running cycle 1/1 for kraken test... 14:29:14 INFO - TEST-INFO | started process 15297 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1HLdX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:26 INFO - PROCESS | 15297 | RSS: Main: 140238848 14:29:26 INFO - PROCESS | 15297 | 14:29:28 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38963/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:29 INFO - PROCESS | 15297 | RSS: Main: 183201792 14:29:29 INFO - PROCESS | 15297 | 14:29:32 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38963/tests/kraken/driver.html?testName=audio-dft) 14:29:32 INFO - PROCESS | 15297 | RSS: Main: 173600768 14:29:32 INFO - PROCESS | 15297 | 14:29:35 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38963/tests/kraken/driver.html?testName=audio-fft) 14:29:36 INFO - PROCESS | 15297 | RSS: Main: 266383360 14:29:36 INFO - PROCESS | 15297 | 14:29:38 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38963/tests/kraken/driver.html?testName=audio-oscillator) 14:29:39 INFO - PROCESS | 15297 | RSS: Main: 171962368 14:29:39 INFO - PROCESS | 15297 | 14:29:41 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38963/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:41 INFO - PROCESS | 15297 | RSS: Main: 174669824 14:29:41 INFO - PROCESS | 15297 | 14:29:44 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38963/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:45 INFO - PROCESS | 15297 | RSS: Main: 213676032 14:29:45 INFO - PROCESS | 15297 | 14:29:48 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38963/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:49 INFO - PROCESS | 15297 | RSS: Main: 211816448 14:29:49 INFO - PROCESS | 15297 | 14:29:51 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38963/tests/kraken/driver.html?testName=json-parse-financial) 14:29:52 INFO - PROCESS | 15297 | RSS: Main: 210632704 14:29:52 INFO - PROCESS | 15297 | 14:29:54 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38963/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:54 INFO - PROCESS | 15297 | RSS: Main: 172482560 14:29:54 INFO - PROCESS | 15297 | 14:29:56 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:56 INFO - PROCESS | 15297 | RSS: Main: 179376128 14:29:56 INFO - PROCESS | 15297 | 14:29:58 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:59 INFO - PROCESS | 15297 | RSS: Main: 189145088 14:29:59 INFO - PROCESS | 15297 | 14:30:02 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:02 INFO - PROCESS | 15297 | RSS: Main: 199385088 14:30:02 INFO - PROCESS | 15297 | 14:30:05 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:06 INFO - PROCESS | 15297 | RSS: Main: 194666496 14:30:06 INFO - PROCESS | 15297 | 14:30:07 INFO - PROCESS | 15297 | Cycle 1(1): loaded http://localhost:38963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38963/tests/kraken/driver.html?testName=ai-astar) 14:30:08 INFO - PROCESS | 15297 | RSS: Main: 243093504 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | __start_tp_report 14:30:08 INFO - PROCESS | 15297 | _x_x_mozilla_page_load 14:30:08 INFO - PROCESS | 15297 | _x_x_mozilla_page_load_details 14:30:08 INFO - PROCESS | 15297 | |i|pagename|runs| 14:30:08 INFO - PROCESS | 15297 | |0;ai-astar;105;113;113;113;115;112;112;111;111;111 14:30:08 INFO - PROCESS | 15297 | |1;audio-beat-detection;151;114;115;154;120;120;115;116;138;116 14:30:08 INFO - PROCESS | 15297 | |2;audio-dft;161;161;161;162;161;162;163;161;164;161 14:30:08 INFO - PROCESS | 15297 | |3;audio-fft;74;76;76;110;75;77;76;76;102;76 14:30:08 INFO - PROCESS | 15297 | |4;audio-oscillator;81;81;101;81;81;82;102;82;82;104 14:30:08 INFO - PROCESS | 15297 | |5;imaging-gaussian-blur;113;113;113;113;113;113;112;113;113;112 14:30:08 INFO - PROCESS | 15297 | |6;imaging-darkroom;147;147;148;148;147;147;147;147;148;147 14:30:08 INFO - PROCESS | 15297 | |7;imaging-desaturate;93;93;94;94;93;94;94;94;94;94 14:30:08 INFO - PROCESS | 15297 | |8;json-parse-financial;53;55;54;54;54;58;54;54;54;54 14:30:08 INFO - PROCESS | 15297 | |9;json-stringify-tinderbox;54;54;53;53;53;53;53;53;53;53 14:30:08 INFO - PROCESS | 15297 | |10;stanford-crypto-aes;75;76;81;78;77;75;76;82;79;80 14:30:08 INFO - PROCESS | 15297 | |11;stanford-crypto-ccm;123;122;120;119;120;120;119;119;169;132 14:30:08 INFO - PROCESS | 15297 | |12;stanford-crypto-pbkdf2;161;175;165;160;162;162;163;163;159;161 14:30:08 INFO - PROCESS | 15297 | |13;stanford-crypto-sha256-iterative;61;60;60;61;61;60;61;61;60;60 14:30:08 INFO - PROCESS | 15297 | __end_tp_report 14:30:08 INFO - PROCESS | 15297 | __start_cc_report 14:30:08 INFO - PROCESS | 15297 | _x_x_mozilla_cycle_collect,1675 14:30:08 INFO - PROCESS | 15297 | __end_cc_report 14:30:08 INFO - PROCESS | 15297 | __startTimestamp1492205408018__endTimestamp 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | ------- Summary: start ------- 14:30:08 INFO - PROCESS | 15297 | Number of tests: 14 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.63 (2.3%) stddev-sans-first:1.32 14:30:08 INFO - PROCESS | 15297 | Values: 105.0 113.0 113.0 113.0 115.0 112.0 112.0 111.0 111.0 111.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:120.00 stddev:15.67 (13.1%) stddev-sans-first:13.74 14:30:08 INFO - PROCESS | 15297 | Values: 151.0 114.0 115.0 154.0 120.0 120.0 115.0 116.0 138.0 116.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.50 stddev:1.06 (0.7%) stddev-sans-first:1.09 14:30:08 INFO - PROCESS | 15297 | Values: 161.0 161.0 161.0 162.0 161.0 162.0 163.0 161.0 164.0 161.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.92 (17.0%) stddev-sans-first:13.39 14:30:08 INFO - PROCESS | 15297 | Values: 74.0 76.0 76.0 110.0 75.0 77.0 76.0 76.0 102.0 76.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:81.00 stddev:10.13 (12.5%) stddev-sans-first:10.45 14:30:08 INFO - PROCESS | 15297 | Values: 81.0 81.0 101.0 81.0 81.0 82.0 102.0 82.0 82.0 104.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#5] imaging-gaussian-blur Cycles:10 Average:112.80 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 14:30:08 INFO - PROCESS | 15297 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 113.0 112.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 14:30:08 INFO - PROCESS | 15297 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 148.0 147.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#7] imaging-desaturate Cycles:10 Average:93.70 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 14:30:08 INFO - PROCESS | 15297 | Values: 93.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.35 (2.5%) stddev-sans-first:1.33 14:30:08 INFO - PROCESS | 15297 | Values: 53.0 55.0 54.0 54.0 54.0 58.0 54.0 54.0 54.0 54.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#9] json-stringify-tinderbox Cycles:10 Average:53.20 Median:53.00 stddev:0.42 (0.8%) stddev-sans-first:0.33 14:30:08 INFO - PROCESS | 15297 | Values: 54.0 54.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 53.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:2.51 (3.2%) stddev-sans-first:2.44 14:30:08 INFO - PROCESS | 15297 | Values: 75.0 76.0 81.0 78.0 77.0 75.0 76.0 82.0 79.0 80.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#11] stanford-crypto-ccm Cycles:10 Average:126.30 Median:121.00 stddev:15.51 (12.8%) stddev-sans-first:16.40 14:30:08 INFO - PROCESS | 15297 | Values: 123.0 122.0 120.0 119.0 120.0 120.0 119.0 119.0 169.0 132.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.10 Median:162.50 stddev:4.51 (2.8%) stddev-sans-first:4.72 14:30:08 INFO - PROCESS | 15297 | Values: 161.0 175.0 165.0 160.0 162.0 162.0 163.0 163.0 159.0 161.0 14:30:08 INFO - PROCESS | 15297 | 14:30:08 INFO - PROCESS | 15297 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:61.00 stddev:0.53 (0.9%) stddev-sans-first:0.53 14:30:08 INFO - PROCESS | 15297 | Values: 61.0 60.0 60.0 61.0 61.0 60.0 61.0 61.0 60.0 60.0 14:30:08 INFO - PROCESS | 15297 | -------- Summary: end -------- 14:30:08 INFO - PROCESS | 15297 | 14:30:09 INFO - TEST-INFO | 15297: exit 0 14:30:09 INFO - TEST-OK | kraken | took 59841ms 14:30:09 INFO - SUITE-END | took 1174s 14:30:09 INFO - Completed test suite (00:19:34) 14:30:09 INFO - javascript benchmark 14:30:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7887.483046576081, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.1385839681684, 3407.795532268064, 3415.214500664847, 3425.383430982422, 3459.948100778487, 5660.320761508615, 5676.744546495407, 5692.971535142324, 5741.052726300156, 5755.136729490573, 5735.713214339287, 5788.739506722197, 5789.478946894778, 5800.47795698387, 5811.767529298823, 5243.4232234454275, 5261.631685781997, 5302.178162384817, 5307.150855863043, 5314.92027619586, 5131.923021154686, 5152.536271735543, 5349.224362467459, 5363.034653762321, 5374.113271310229, 5175.120229560984, 5226.738663066832, 5294.205869119624, 5314.043472175007, 5325.147976323789, 5311.442298558653, 5320.973395133, 5321.494458026481, 5323.733813309358, 5327.573794096483, 5100.38795344561, 5174.844754657366, 5233.685978841282, 5290.127129023706, 5291.523762861322, 5648.830535083954, 5655.830325090254, 5699.544036477072, 5725.971370143165, 5741.62679425836, 6148.292946311187, 6182.629042257479, 6193.938060619426, 6201.0, 6205.782797602107, 6252.218472690914, 6273.027680709497, 6280.591761535531, 6282.057691346335, 6285.465735412496, 5583.3858275590055, 5613.382527921925, 5683.090705487102, 5732.283464566929, 5812.0, 6239.500839932794, 6246.375362463808, 6252.437280644764, 6253.062040693932, 6257.405546473078, 6046.5767396281835, 6054.757809687563, 6062.060380641008, 6063.242094738158, 6064.151018857364, 5923.585349025527, 5963.4931030862, 6077.756889724362, 6093.791924632529, 6157.507399408037, 6113.880349023491, 6123.201403005315, 6158.692065396802, 6159.0, 6167.198264225622, 5951.196588460589, 6004.3395226525045, 6011.398860113954, 6062.514998800086, 6135.969320153371, 4634.930476042862, 4715.504871988392, 4722.291656251521, 4724.763761811896, 4751.714897106184, 4129.463169787909, 4188.329867221291, 4234.153169366077, 4237.470316210473, 4245.830166793356, 5886.381929897385, 5913.940860591425, 5916.26046744157, 5994.610350327215, 6020.277566692025, 6134.096280631919, 6167.938320616737, 6179.196704428486, 6181.598196117238, 6186.505079593621, 6008.639481631116, 6009.0, 6009.218801555857, 6016.09758536223, 6033.064874944391, 5090.541851233407, 5144.6655967362, 5151.587872970228, 5235.528802407802, 5236.6857988520815, 6483.059956306309, 6501.902471462932, 6505.21937367519, 6512.088307636935, 6515.674216289167, 6164.229471316085, 6170.629762214281, 6206.255249370104, 6206.968965155145, 6226.097215903759, 6241.032639940817, 6281.4660753834605, 6293.590916590407, 6298.1812364392335, 6482.805515834532, 6073.665948372882, 6086.026235802427, 6086.72609732572, 6087.878242435215, 6089.086637004485, 6166.81499555014, 6168.228971378578, 6179.412955769195, 6182.7217775201125, 6187.195664563578, 5839.328477225174, 5864.032434648406, 5989.760409583568, 5993.280806303272, 5995.700214989321, 6051.213342265477, 6104.481119104926, 6106.206193195034, 6106.664133472702, 6137.048757442603, 6049.909251361145, 6061.212042434456, 6066.363031881765, 6068.0, 6070.423309785563, 5859.853503662272, 5880.8235752927485, 5913.142594323885, 5919.970400147971, 6084.087386891824, 5838.678872662044, 5852.356240813592, 5854.619449735754, 5862.648241105548, 5864.0], "value": 5685.048181939318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8924255982882, 803.2369249213247, 821.223943373512, 901.7339884734007, 904.4799240436743, 30519.847400762992, 43702.781486092565, 44180.77909610452, 44192.33711494322, 44315.0, 44372.11255774883, 44506.777466112624, 44517.332240016345, 44565.0, 44569.0, 7566.546007239555, 7725.575093369863, 8960.507172105532, 9089.272858171364, 9095.454272743624, 10140.797184056351, 10330.58677652893, 10534.894651053468, 10622.309549879272, 10624.840627390595, 10418.426986515738, 10439.582416703322, 10441.530131144078, 10457.424841633707, 10464.738381540446, 10385.532651030722, 10388.0, 10405.21960852939, 10415.114715249212, 10430.165586753117, 10078.697639070839, 10079.294449388546, 10153.644622438253, 10194.694159175237, 10208.0, 39636.0, 39813.402798958035, 39852.402213966816, 39884.0, 39895.401568976486, 4073.144639625682, 4077.938830917539, 4181.163767246563, 4239.385289133089, 4263.18999390118, 26385.990021269423, 28919.56620650692, 29010.709892901014, 29012.41975160506, 29423.852880735674, 4267.295896177127, 4267.829286828523, 4337.371081193241, 4398.120375924827, 4409.140217657558, 243273.0, 243818.0, 244009.0, 244391.0, 244399.0, 44611.33083003757, 44795.32807007898, 44813.0, 44930.32604510935, 44969.77515112469, 46786.76606617013, 46986.5301346989, 47114.29328560075, 47238.291425628646, 47238.76380618075, 15445.922770386076, 15585.06489610627, 15593.064416135068, 15617.60955976087, 15633.0, 11858.051355891508, 12104.515819367303, 13602.387892544859, 13605.455781768816, 13620.591382258548, 12711.682207944876, 12723.172993755376, 12824.935875320563, 12953.676158095934, 13038.739225215442, 5437.809676661298, 5510.586705997066, 5542.944570554324, 5553.8333849984565, 5588.161775733673, 990.2770977186694, 997.7356000659686, 1005.8541511480794, 1007.4257673126394, 1018.4296793795498, 27712.861435692692, 27882.721172788417, 28023.0, 28324.71675283262, 28329.858350708113, 1090.2368342160519, 1097.2757979733337, 1099.2140619457127, 1104.2325583719237, 1136.6135513925306, 14609.92695036518, 15083.095014299177, 15135.52089683173, 15145.697086058217, 15334.539963801104, 346150.0, 348293.0, 348427.0, 348652.0, 348870.0, 54946.72526637341, 55009.724951375785, 55035.72482137644, 55106.72446637741, 55209.171862422096, 1514.1369419430819, 1535.5163123616248, 1535.6007438066183, 1561.7032763774846, 1563.6090977255685, 26108.8694556526, 27201.31996700098, 27223.86388068047, 27596.448071038067, 27737.86131069332, 40607.3908891361, 40706.389404159556, 40760.388594170516, 40888.1822363557, 40901.59098408978, 301528.0, 301956.0, 302038.0, 303005.0, 303271.0, 31960.84019579887, 32327.0, 32586.0, 32608.83695581507, 32872.178195545304, 42919.57080429281, 43506.34740478832, 43968.34047489354, 44399.77800111108, 44560.10879782451, 32202.19494512656, 32703.672963270063, 32810.343793124484, 33045.8226387316, 33589.3282134351, 29799.404011920073, 30195.849020754755, 33228.0, 33283.50074748929, 33401.49897751487, 35154.82422587871, 35896.102597435274, 36088.45867312045, 36091.45862812112, 36266.456003159445, 29798.404031918806, 29888.402231955675, 29959.550606740482, 30222.0, 30548.236294091937, 23769.762302377447, 24222.87888560546, 24920.376990574656, 25205.621915671647, 25325.873370633766], "value": 18510.648058965377, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.3727870914918, 468.78670205056704, 471.87693289969866, 476.99592358086227, 484.566313149731, 18425.447236582906, 19398.90300548497, 21007.369778906617, 21007.36977890664, 21186.36440906775, 21205.681914771252, 21643.45891352717, 22307.107715691393, 22749.31752047437, 22826.315210543667, 6355.777547785829, 6424.743010279583, 6572.507061970347, 6663.200415950093, 6721.966390168067, 6537.378948999861, 6637.668116594175, 6644.0, 6646.9667651661675, 6651.501137414689, 4118.423420721101, 4567.931481027787, 4656.580907718305, 7778.338841198505, 7974.242446967529, 7822.804429889241, 7831.569263690495, 8052.51684898905, 8053.073896501889, 8077.192280771935, 7697.730579429693, 7922.564258965755, 7937.404694647867, 7937.968064151623, 7941.166177551389, 28013.0, 29462.852685736434, 30087.699123008926, 30216.24459388511, 30257.243568910733, 3180.189051791778, 3322.9833850830832, 3594.1733401317583, 3797.6392242736897, 3822.694184465264, 14653.706925861423, 18583.16375763094, 18728.250869965184, 18975.335863244858, 19677.016149192626, 2169.208238992772, 2303.825049224891, 2331.2306938710185, 2342.332435255944, 2357.846739961897, 98233.5088324561, 99256.0, 99401.0, 116151.41924290408, 124398.37800811029, 16541.338346466247, 20552.588948220953, 21813.563728725338, 22446.887765561067, 22856.542869142522, 42899.35650965238, 44163.337549936776, 44261.77869110634, 44417.0, 45000.54999449963, 11845.407729613486, 11872.88127118735, 11941.402929853473, 12005.339706316236, 12058.336791476553, 9324.90675093254, 9413.952930235306, 9727.221822254203, 9846.852297215548, 9911.306208565331, 10875.401326922014, 11000.174986876016, 11017.889821101686, 11019.272799523083, 11138.276012059352, 3833.9808300958316, 3900.31744444721, 4090.406891000788, 4179.791010449465, 4236.743358598294, 948.691675205561, 951.5194826612517, 956.6269155029544, 968.801395713877, 982.0670363155032, 20070.698939515918, 20412.0814563345, 21079.68380474294, 21476.89261553682, 21759.12963481443, 973.3721749471551, 992.161623428202, 993.895640957689, 1006.8640733500883, 1018.3024628129755, 11177.441127943734, 11623.244489108181, 11709.882901170879, 11816.704582385337, 11926.0, 693339.0, 702962.0, 705093.0, 746654.0, 747537.0, 116610.0, 116679.41660291645, 118274.40862795804, 119306.4034679821, 121845.39077304734, 1246.7132559511363, 1270.726793739332, 1277.3932382118605, 1311.6065180445637, 1331.42083193811, 17557.385491507735, 18944.336948206746, 20234.392968210977, 20255.0, 20305.49236269105, 52254.738726306125, 54345.0, 55284.72357638186, 55445.0, 55934.72032639811, 59754.70122649359, 68174.31825681878, 68252.3174768246, 69157.65421172862, 70808.64595676989, 12552.435140418886, 12921.870781292067, 13044.478220871439, 13219.272939988394, 13244.735105297646, 12246.203996740183, 13397.12918660284, 13641.658958525719, 13704.931475342559, 13794.448222071005, 11998.460069297078, 12034.63896083119, 12403.875961240272, 12474.313912734886, 12570.87429125697, 11433.428328583705, 11627.0, 11909.0, 12091.0, 12231.938840306097, 12396.876031239572, 12823.93588032054, 12841.614751557468, 13028.609141725763, 13221.338933053501, 12434.0, 12459.0, 12678.366081695694, 12752.42614082387, 12855.550055748005, 11327.093832493216, 12145.939270303592, 12367.0, 12690.809637855624, 12725.745485090432], "value": 11986.224460518451, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1543.0278924277711, 1566.2638559876855, 1573.5122112145236, 1575.3383578896864, 1581.825999140095, 10723.731906702327, 11380.317180969127, 11425.200235983484, 11428.885711142886, 11434.771304573904, 11215.943920280408, 11284.153688473356, 11556.768864622703, 11568.132390070736, 11590.188686791927, 2413.1795189635477, 2431.112643884987, 2450.4976479821594, 2452.448199155194, 2453.595156799126, 2369.5024044950583, 2413.9758602414013, 2466.728659847415, 2468.518638865422, 2469.148143890364, 2360.704911886014, 2426.2236084452984, 2433.1605596069417, 2440.036185706645, 2451.3258853815255, 2269.103704036913, 2300.9654855177187, 2307.457747429361, 2308.988455057722, 2405.458771776354, 2357.092519380034, 2390.187336305647, 2390.5816482115733, 2393.3298676370646, 2395.6646069550275, 11318.490667919963, 11591.0, 11597.188196826226, 11598.420078996101, 11601.941990289995, 5703.74333155009, 5834.445727655866, 5845.386234445407, 5845.88308233833, 5846.707664616794, 3342.097633638928, 3416.6583341665632, 3420.1449637590604, 3430.5368775215525, 3470.1845066409373, 1196.8922796948316, 1230.7107829660113, 1268.099649249025, 1315.270025136049, 1353.5871559174448, 14645.487407940778, 15034.699306013928, 15962.36150553988, 17604.0, 17808.732869006973, 4614.423197100363, 4711.882202944886, 4799.0401919616215, 4814.277858321209, 4817.397825271841, 11073.335599864035, 11348.546058157746, 12782.552610658582, 12798.61604151877, 12808.039397045259, 5582.0, 5754.74103665336, 5820.447057529528, 5837.0, 5840.707964601753, 5337.412884582693, 5396.9730151348995, 5397.0, 5399.514043736004, 5405.459454054563, 3882.2429626222615, 3928.9214215715524, 3957.782321972319, 3996.2806694795217, 4001.2197621463533, 1037.2117190934944, 1042.301657889201, 1046.6546039806997, 1049.6483677967813, 1056.9524371403306, 1060.5068643081004, 1073.2004656530935, 1076.5370890516997, 1082.1451053667515, 1082.6860210539014, 7149.9285007149265, 7194.100737407824, 7260.96369518149, 7320.780376588711, 7404.666789994463, 1064.5794911010107, 1068.3216157739892, 1073.1843798712878, 1077.6551503518956, 1080.4921686807188, 4462.9776851116185, 4555.544445555484, 4593.081383723269, 4753.619710423158, 4772.880677983008, 13526.0, 14172.433102675983, 14735.631609209855, 14735.852641473663, 14753.852461475462, 14513.564593062225, 14588.197649129399, 14591.854081459262, 14616.926915365355, 14624.19566923808, 10601.575936962436, 10778.4071876046, 10799.298045627009, 10830.241883068109, 10833.891661083288, 7284.1789552611845, 7593.468457207942, 7678.1170165431695, 7757.896841263314, 7763.534187948741, 13041.152325098838, 13054.282014489294, 13116.147450415692, 13141.34293285351, 13286.86713132895, 13469.797953030517, 13484.595462136152, 13538.729225415633, 13616.114952528054, 13698.0, 8215.9589202056, 9384.57769400365, 9831.115199632068, 9894.257930655085, 9913.801723965336, 10679.305845120043, 10792.892071079503, 10802.513886875267, 11164.441777911234, 11556.94221528887, 9201.263898888206, 9266.907330926604, 9301.069893010645, 9516.19112375456, 9715.27135464857, 8856.0, 8956.776080598038, 9090.045545217921, 9156.908430915872, 9353.251739860658, 8165.714200002972, 8239.299659529008, 8254.0, 8254.174582541698, 8294.129116442928, 6008.699565021644, 6092.116643086816, 6124.387561244018, 6157.076438534076, 6218.751249949952, 6176.969115154396, 6186.505079593711, 6195.721192546256, 6213.254409470893, 6422.486201103807], "value": 5368.733845027421, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.3542214745332, 416.8353500367355, 427.4251132227153, 427.90586071064365, 436.5416312871484, 5130.333056702623, 5228.921566176501, 5261.81583644572, 5318.388385335683, 5402.756875940582, 5124.564412024973, 5190.273361729352, 5216.895662086756, 5218.843434696955, 5225.059489291926, 4566.7441453600195, 4570.840020599279, 4572.222722137236, 4602.125596136723, 4617.468991066037, 4428.313611390224, 4464.888377790565, 4565.885852853672, 4624.930626040612, 4634.58288754012, 4507.183010618363, 4520.231560634684, 4525.366448697185, 4528.932066019012, 4559.293309537027, 4517.763706965074, 4546.590806827385, 4577.862664120082, 4598.26427771555, 4632.0, 4017.337139372, 4159.188958153131, 4465.397171381855, 4480.753558554278, 4503.54964503547, 5010.72441015744, 5054.949450505522, 5057.645964782467, 5075.593952483792, 5107.182850743863, 5074.477656702974, 5088.516590923857, 5092.949070509285, 5116.283720279164, 5120.641555091145, 5319.867003324909, 5343.530529104489, 5449.863753406157, 5482.5613950883835, 5500.0, 4528.818847246106, 4544.272916333371, 4585.4726706428855, 4597.4712908015335, 4600.2869555218995, 5727.255456790591, 5744.712764361765, 5751.491590130017, 5789.797357092523, 5793.797217097382, 4687.601553867891, 4773.541626062581, 4804.543568361, 4804.95195048045, 4808.519148085234, 4791.712497250176, 4802.655256528178, 4846.975765121152, 4855.465898751135, 4885.877853053702, 5129.230615407644, 5154.304168937146, 5163.664361816545, 5184.507471790174, 5203.19350500673, 5278.762455689503, 5362.410134885159, 5508.6970216637665, 5561.833145005657, 5568.443155684399, 1556.159673776148, 1625.6992456395606, 1645.3500867157406, 1655.337864854068, 1669.3155806119432, 1213.2780995307778, 1264.2477725753163, 1269.6571925580042, 1276.5978716704208, 1288.6327396691897, 5437.184422336682, 5444.292242008592, 5447.509724124848, 5453.972730136404, 5456.399796022434, 5646.774129034792, 5651.378348381675, 5652.18043383707, 5659.18905950092, 5708.173384516915, 5254.868628284324, 5306.469353064663, 5399.78400863961, 5406.215948736907, 5472.0, 2912.6019710237692, 2975.9404811904074, 2978.687237840039, 2983.701629837042, 2984.492636251842, 5598.312809851294, 5907.881842363128, 5909.0, 5929.555283353766, 5941.910871336933, 5705.657660540381, 5724.341700704389, 5735.799247026334, 5751.252337196222, 5771.8557036074435, 5866.911996320058, 5906.232189815382, 5907.645541267538, 5915.692879776804, 5927.8221653350465, 5434.2935418395355, 5529.336479622471, 5591.8816236752, 5592.804251851166, 5629.577781666473, 5500.092484739973, 5518.917216241679, 5523.7238138093735, 5527.39198688152, 5558.694271815089, 5578.804741834017, 5842.591018628656, 5846.736896839738, 5856.677882716492, 5873.324567674772, 4681.812727490862, 4693.0992947856175, 4693.413323334583, 4723.315119307613, 4750.904981900274, 5491.780328786804, 5553.305836770403, 5595.642614431309, 5665.20687103814, 5668.627166835726, 5517.158663288329, 5519.972400137974, 5524.75138618755, 5565.749541270734, 5607.158926161109, 5525.010996041341, 5528.55771538284, 5538.16927460868, 5563.554915606823, 5593.720313984366, 5223.425423203521, 5453.254958413269, 5504.80733174353, 5525.557955363642, 5550.974718778195, 5535.584831137761, 5536.474034966672, 5538.944610553843, 5588.972055139699, 5666.150077488245, 5220.5823534117935, 5353.170258609922, 5362.812301569426, 5418.376886658085, 5509.338879334506], "value": 4463.909435940319, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.4210510537519, 855.597869001569, 902.9367944243903, 934.5841100710187, 937.8593211018347, 14603.415863365466, 18716.719249211274, 18726.0, 18736.156872940715, 18739.0, 16169.514914552552, 16887.831121688778, 16981.06604136772, 16997.745033824503, 17023.82976170241, 881.9735407937773, 904.7104926423547, 905.3662436294587, 908.1508789282043, 908.2053203446984, 866.0559989611322, 885.9379843410932, 886.9423487473326, 887.3389324952919, 887.5828360670474, 955.3169483819067, 956.4643799472283, 957.899420560838, 959.1511512311585, 959.6497278493334, 946.8863736351612, 946.966856160031, 947.4552132523792, 947.663579429303, 948.5826236456006, 693.5457275484565, 698.91263592051, 700.1318365227132, 700.2227527444533, 700.3591713582066, 16372.672546549122, 16530.0, 16720.0, 18250.452486425427, 18694.34569790051, 15847.128407937558, 16142.596435089099, 16171.595710107224, 16365.34538618454, 16550.83449165505, 13540.593782186452, 13777.311134443238, 13787.724245515034, 13971.09187902783, 14270.072445291024, 3957.98021009896, 4083.8774836754947, 4096.795160241976, 4096.856610018635, 4200.642945349649, 84806.0, 89413.0, 89711.0, 90418.5479072607, 91195.0, 12504.562340318045, 12576.434060467302, 12591.181573197713, 12690.238585684889, 12815.935920320338, 23364.299071027897, 23785.0, 23790.405239868796, 23790.881045595008, 23791.167309144097, 8664.523451210118, 8736.8689469658, 8791.824163516694, 8834.602442890086, 8954.955225223832, 4813.566778989908, 4891.192953162688, 4894.877628059327, 4935.161022626162, 5078.796848126033, 3825.846966121324, 3924.4309575111447, 3931.253061918226, 3932.4297976793205, 3933.0, 612.761023200952, 628.6102616377875, 640.7821340744076, 642.1651852591613, 643.8519140597596, 853.833502467013, 858.9785255368665, 864.6498168241872, 878.9252913502296, 881.66496731243, 11140.82974879983, 11481.0, 11555.537778488935, 11914.52341906314, 11937.940310298392, 824.8762685597088, 827.8840962265288, 830.4685001598981, 860.4794099569671, 867.1631875240423, 5176.559992400613, 5198.884675218812, 5225.790968361223, 5230.843074707689, 5239.790408383622, 78106.0, 79183.60408198037, 79254.0, 79851.20148798554, 81932.18067819365, 67721.0, 69377.0, 70038.29961700318, 70120.64939675269, 72879.63560182165, 63859.0, 64940.35059649343, 65582.67208663926, 66364.66817665978, 67254.66372668203, 9785.706428807147, 10033.397996120257, 10094.646687365906, 10142.442165680959, 10274.280800344202, 43568.782156089015, 43576.56423435725, 43887.34168987531, 44522.77738611286, 44765.552344476135, 49644.50355496399, 49859.501404986935, 50277.24584131314, 50801.49198507968, 52298.0, 14233.0, 14445.483224261301, 14451.85548144505, 14591.0, 14644.341004654603, 16376.426825061066, 16623.66752664916, 16679.666406671557, 16849.663006739553, 17942.0, 13901.443942242196, 14216.911966541513, 14847.257637117886, 15741.0, 15984.840151598335, 14901.478448254258, 15357.385704571692, 15481.920799684916, 16017.839821601634, 16096.812715162849, 12896.0, 13874.167549947035, 15020.549383518512, 15796.526104216891, 16107.919460402623, 11274.436278186222, 11321.264117832645, 11565.653030409101, 11742.17804753659, 12203.755924881276, 11291.209615326849, 12666.873331266937, 12816.423260953094, 13123.212607243597, 13124.671883202996], "value": 7964.651587600736, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1457.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 115.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 114.0, 115.0, 154.0, 120.0, 120.0, 115.0, 116.0, 138.0, 116.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 163.0, 161.0, 164.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 110.0, 75.0, 77.0, 76.0, 76.0, 102.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 101.0, 81.0, 81.0, 82.0, 102.0, 82.0, 82.0, 104.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 54.0, 54.0, 58.0, 54.0, 54.0, 54.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0, 53.0], "value": 53.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 81.0, 78.0, 77.0, 75.0, 76.0, 82.0, 79.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 122.0, 120.0, 119.0, 120.0, 120.0, 119.0, 119.0, 169.0, 132.0], "value": 126.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 175.0, 165.0, 160.0, 162.0, 162.0, 163.0, 163.0, 159.0, 161.0], "value": 163.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0], "value": 60.5, "unit": "score"}]}]} 14:30:09 INFO - Return code: 0 14:30:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:09 ERROR - # TBPL SUCCESS # 14:30:09 INFO - Running post-action listener: _resource_record_post_action 14:30:09 INFO - [mozharness: 2017-04-14 21:30:09.834764Z] Finished run-tests step (success) 14:30:09 INFO - Running post-run listener: _resource_record_post_run 14:30:09 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 266240; Write bytes: 380051456; Read time: 40; Write time: 264156 14:30:09 INFO - TinderboxPrint: CPU usage
13.2% 14:30:09 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 14:30:09 INFO - TinderboxPrint: I/O write bytes / time
380,051,456 / 264,156 14:30:09 INFO - TinderboxPrint: CPU idle
8,255.2 (86.8%) 14:30:09 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 14:30:09 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123256832; Read time: 0; Write time: 96100 14:30:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 256794624; Read time: 40; Write time: 168056 14:30:10 INFO - Running post-run listener: _upload_blobber_files 14:30:10 INFO - Blob upload gear active. 14:30:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:10 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 14:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:10 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:30:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:30:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:11 INFO - (blobuploader) - INFO - Done attempting. 14:30:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:15 INFO - (blobuploader) - INFO - Done attempting. 14:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:16 INFO - (blobuploader) - INFO - Done attempting. 14:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:30:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:17 INFO - (blobuploader) - INFO - Done attempting. 14:30:17 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:17 INFO - Return code: 0 14:30:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3b1b068a64a60cdff856ed51b5537a6f24c2aaa0d26667b82d07e87efd98a12557945b41a61cd1bcf54cc39f1ef6dd1da19aa4e76fa66cf56b0f3dbb210ac2b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1f04fdf2394bb4f04b72b22434fb11ea995d4fd96261ab5ca09fbca5996aff245c4639ad8b8c64b75483e37d2aae7ab3a2319e4c2af054874047044818419f06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b69d32f2b358246f209a774045102b5517081c1b4772d80ef9cba7ae719ad8144d2145462ca3fd2e75d93e8af90c64daf4ca1c2fb61e5ad4a6fc8647fe7dae82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b122022e6d52250e9c4c4eb9a2e9d72a3c623ff4c15effa5dcdd67bcd36f1eab1e4a295e03f8c7038d9231097943be75403b7973cc9561554b78423917b8a89d"} 14:30:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:17 INFO - Contents: 14:30:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3b1b068a64a60cdff856ed51b5537a6f24c2aaa0d26667b82d07e87efd98a12557945b41a61cd1bcf54cc39f1ef6dd1da19aa4e76fa66cf56b0f3dbb210ac2b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1f04fdf2394bb4f04b72b22434fb11ea995d4fd96261ab5ca09fbca5996aff245c4639ad8b8c64b75483e37d2aae7ab3a2319e4c2af054874047044818419f06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b69d32f2b358246f209a774045102b5517081c1b4772d80ef9cba7ae719ad8144d2145462ca3fd2e75d93e8af90c64daf4ca1c2fb61e5ad4a6fc8647fe7dae82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b122022e6d52250e9c4c4eb9a2e9d72a3c623ff4c15effa5dcdd67bcd36f1eab1e4a295e03f8c7038d9231097943be75403b7973cc9561554b78423917b8a89d"} 14:30:17 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:17 INFO - Copying logs to upload dir... 14:30:17 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.020569 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-04-14 14:30:17.272117) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 14:30:17.275486) ========= 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=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3b1b068a64a60cdff856ed51b5537a6f24c2aaa0d26667b82d07e87efd98a12557945b41a61cd1bcf54cc39f1ef6dd1da19aa4e76fa66cf56b0f3dbb210ac2b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1f04fdf2394bb4f04b72b22434fb11ea995d4fd96261ab5ca09fbca5996aff245c4639ad8b8c64b75483e37d2aae7ab3a2319e4c2af054874047044818419f06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b69d32f2b358246f209a774045102b5517081c1b4772d80ef9cba7ae719ad8144d2145462ca3fd2e75d93e8af90c64daf4ca1c2fb61e5ad4a6fc8647fe7dae82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b122022e6d52250e9c4c4eb9a2e9d72a3c623ff4c15effa5dcdd67bcd36f1eab1e4a295e03f8c7038d9231097943be75403b7973cc9561554b78423917b8a89d"} build_url:https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011360 build_url: 'https://queue.taskcluster.net/v1/task/S4Ra-0s8S62Sh7_hf0P45w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3b1b068a64a60cdff856ed51b5537a6f24c2aaa0d26667b82d07e87efd98a12557945b41a61cd1bcf54cc39f1ef6dd1da19aa4e76fa66cf56b0f3dbb210ac2b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1f04fdf2394bb4f04b72b22434fb11ea995d4fd96261ab5ca09fbca5996aff245c4639ad8b8c64b75483e37d2aae7ab3a2319e4c2af054874047044818419f06", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b69d32f2b358246f209a774045102b5517081c1b4772d80ef9cba7ae719ad8144d2145462ca3fd2e75d93e8af90c64daf4ca1c2fb61e5ad4a6fc8647fe7dae82", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b122022e6d52250e9c4c4eb9a2e9d72a3c623ff4c15effa5dcdd67bcd36f1eab1e4a295e03f8c7038d9231097943be75403b7973cc9561554b78423917b8a89d"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-14 14:30:17.388433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:30:17.388741) ========= 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=923d835db2ba3686ebe126b700000192-1492204164.335027-1665135019 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-14 14:30:17.439040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 14:30:17.439310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-14 14:30:17.439557) ========= ========= Total master_lag: 0.22 =========