builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1472051496.55 results: success (0) buildid: 20160824072025 builduid: 1c6919645c76406095cbf9d68d7ecb7c revision: a5571e6af4e9655ba6af3cb972286697f24813d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.549660) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.550187) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.550521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.573597) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.573926) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 08:11:37-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2016-08-24 08:11:37 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.764127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.764444) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015979 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.814250) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:36.814674) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5571e6af4e9655ba6af3cb972286697f24813d1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev a5571e6af4e9655ba6af3cb972286697f24813d1 --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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 08:11:37,302 truncating revision to first 12 chars 2016-08-24 08:11:37,302 Setting DEBUG logging. 2016-08-24 08:11:37,303 attempt 1/10 2016-08-24 08:11:37,303 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5571e6af4e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 08:11:37,611 unpacking tar archive at: fx-team-a5571e6af4e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.648846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:37.477540) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:37.477884) ========= script_repo_revision: a5571e6af4e9655ba6af3cb972286697f24813d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:37.478338) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:37.478621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 08:11:37.487879) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-24 08:11:37.488297) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:11:38 INFO - MultiFileLogger online at 20160824 08:11:38 in /builds/slave/test 08:11:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:11:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:11:38 INFO - {'append_to_log': False, 08:11:38 INFO - 'base_work_dir': '/builds/slave/test', 08:11:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:11:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:11:38 INFO - 'branch': 'Fx-Team-Non-PGO', 08:11:38 INFO - 'buildbot_json_path': 'buildprops.json', 08:11:38 INFO - 'config_files': ('talos/linux_config.py',), 08:11:38 INFO - 'default_actions': ('clobber', 08:11:38 INFO - 'read-buildbot-config', 08:11:38 INFO - 'download-and-extract', 08:11:38 INFO - 'populate-webroot', 08:11:38 INFO - 'create-virtualenv', 08:11:38 INFO - 'install', 08:11:38 INFO - 'run-tests'), 08:11:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:11:38 INFO - 'download_minidump_stackwalk': True, 08:11:38 INFO - 'download_symbols': 'ondemand', 08:11:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:11:38 INFO - 'tooltool.py': '/tools/tooltool.py', 08:11:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:11:38 INFO - '/tools/misc-python/virtualenv.py')}, 08:11:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:11:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:11:38 INFO - 'installer_path': 'installer.exe', 08:11:38 INFO - 'log_level': 'info', 08:11:38 INFO - 'log_name': 'talos', 08:11:38 INFO - 'log_to_console': True, 08:11:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:11:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:11:38 INFO - 'opt_config_files': (), 08:11:38 INFO - 'pip_index': False, 08:11:38 INFO - 'sps_profile': False, 08:11:38 INFO - 'sps_profile_interval': 0, 08:11:38 INFO - 'suite': 'dromaeojs', 08:11:38 INFO - 'system_bits': '32', 08:11:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:11:38 INFO - 'title': 'talos-linux64-ix-037', 08:11:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:11:38 INFO - 'use_talos_json': True, 08:11:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:11:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:11:38 INFO - 'work_dir': 'build'} 08:11:38 INFO - [mozharness: 2016-08-24 15:11:38.074765Z] Running clobber step. 08:11:38 INFO - Running pre-action listener: _resource_record_pre_action 08:11:38 INFO - Running main action method: clobber 08:11:38 INFO - rmtree: /builds/slave/test/build 08:11:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:11:39 INFO - Running post-action listener: _resource_record_post_action 08:11:39 INFO - [mozharness: 2016-08-24 15:11:39.046711Z] Finished clobber step (success) 08:11:39 INFO - [mozharness: 2016-08-24 15:11:39.046811Z] Running read-buildbot-config step. 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: read_buildbot_config 08:11:39 INFO - Using buildbot properties: 08:11:39 INFO - { 08:11:39 INFO - "project": "", 08:11:39 INFO - "product": "firefox", 08:11:39 INFO - "script_repo_revision": "production", 08:11:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:11:39 INFO - "repository": "", 08:11:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:11:39 INFO - "buildid": "20160824072025", 08:11:39 INFO - "pgo_build": "False", 08:11:39 INFO - "basedir": "/builds/slave/test", 08:11:39 INFO - "buildnumber": 2118, 08:11:39 INFO - "slavename": "talos-linux64-ix-037", 08:11:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:11:39 INFO - "platform": "ubuntu64_hw", 08:11:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:11:39 INFO - "branch": "fx-team", 08:11:39 INFO - "repo_path": "integration/fx-team", 08:11:39 INFO - "revision": "a5571e6af4e9655ba6af3cb972286697f24813d1", 08:11:39 INFO - "stage_platform": "linux64", 08:11:39 INFO - "builduid": "1c6919645c76406095cbf9d68d7ecb7c", 08:11:39 INFO - "slavebuilddir": "test" 08:11:39 INFO - } 08:11:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:11:39 INFO - Running post-action listener: _resource_record_post_action 08:11:39 INFO - [mozharness: 2016-08-24 15:11:39.049221Z] Finished read-buildbot-config step (success) 08:11:39 INFO - [mozharness: 2016-08-24 15:11:39.049309Z] Running download-and-extract step. 08:11:39 INFO - Running pre-action listener: _resource_record_pre_action 08:11:39 INFO - Running main action method: download_and_extract 08:11:39 INFO - mkdir: /builds/slave/test/build/tests 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - trying https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:11:39 INFO - Downloading https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:11:39 INFO - Downloaded 1361 bytes. 08:11:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:11:39 INFO - Using the following test package requirements: 08:11:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:11:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:11:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'jsshell-linux-x86_64.zip'], 08:11:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:11:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:11:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:11:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:11:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:11:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:11:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:11:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:39 INFO - trying https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:11:39 INFO - Downloading https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:11:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:41 INFO - Downloaded 20324718 bytes. 08:11:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:11:45 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:45 INFO - trying https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:11:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:11:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:11:46 INFO - Downloaded 20324718 bytes. 08:11:46 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 08:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:50 INFO - trying https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:50 INFO - Downloading https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:11:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:11:52 INFO - Downloaded 14413981 bytes. 08:11:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 08:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:11:52 INFO - trying https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:11:52 INFO - Downloading https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:11:54 INFO - Downloaded 55749777 bytes. 08:11:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:11:54 INFO - mkdir: /builds/slave/test/properties 08:11:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:11:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:11:54 INFO - Contents: 08:11:54 INFO - build_url:https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:11:55 INFO - Running post-action listener: _resource_record_post_action 08:11:55 INFO - Running post-action listener: set_extra_try_arguments 08:11:55 INFO - [mozharness: 2016-08-24 15:11:55.113723Z] Finished download-and-extract step (success) 08:11:55 INFO - [mozharness: 2016-08-24 15:11:55.113948Z] Running populate-webroot step. 08:11:55 INFO - Running pre-action listener: _resource_record_pre_action 08:11:55 INFO - Running main action method: populate_webroot 08:11:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:11:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:11:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:11:55 INFO - '--tppagecycles', 08:11:55 INFO - '7'], 08:11:55 INFO - 'tests': ['tsvgm']}}, 08:11:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:11:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:11:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:11:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:11:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:11:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['damp', 'tps']}, 08:11:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'tests': ['damp', 'tps']}, 08:11:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['dromaeo_dom']}, 08:11:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:11:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['basic_compositor_video']}, 08:11:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:11:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'other-e10s': {'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['a11yr', 08:11:55 INFO - 'ts_paint', 08:11:55 INFO - 'tpaint', 08:11:55 INFO - 'sessionrestore', 08:11:55 INFO - 'sessionrestore_no_auto_restore', 08:11:55 INFO - 'tabpaint']}, 08:11:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['tsvgx', 08:11:55 INFO - 'tsvgr_opacity', 08:11:55 INFO - 'tart', 08:11:55 INFO - 'tscrollx', 08:11:55 INFO - 'cart']}, 08:11:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:11:55 INFO - 'tsvgr_opacity', 08:11:55 INFO - 'tart', 08:11:55 INFO - 'tscrollx', 08:11:55 INFO - 'cart']}, 08:11:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'talos_options': ['--disable-e10s'], 08:11:55 INFO - 'tests': ['tp5o']}, 08:11:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'tests': ['tp5o']}, 08:11:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'talos_options': ['--disable-e10s', 08:11:55 INFO - '--xperf_path', 08:11:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:55 INFO - 'tests': ['tp5n']}, 08:11:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:11:55 INFO - 'talos_options': ['--xperf_path', 08:11:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:11:55 INFO - 'tests': ['tp5n']}}, 08:11:55 INFO - 'talos.zip': {'path': '', 08:11:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:11:55 INFO - Running post-action listener: _resource_record_post_action 08:11:55 INFO - [mozharness: 2016-08-24 15:11:55.134423Z] Finished populate-webroot step (success) 08:11:55 INFO - [mozharness: 2016-08-24 15:11:55.134511Z] Running create-virtualenv step. 08:11:55 INFO - Running pre-action listener: _resource_record_pre_action 08:11:55 INFO - Running main action method: create_virtualenv 08:11:55 INFO - Creating virtualenv /builds/slave/test/build/venv 08:11: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 08:11:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:11:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:11:55 INFO - Using real prefix '/usr' 08:11:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:11:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:11:57 INFO - Installing pip.................done. 08:11:57 INFO - Return code: 0 08:11:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:11: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 08:11: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 08:11:57 INFO - Using env: {'DISPLAY': ':0', 08:11:57 INFO - 'HOME': '/home/cltbld', 08:11:57 INFO - 'LANG': 'en_US.UTF-8', 08:11:57 INFO - 'LANGUAGE': 'en_US:en', 08:11:57 INFO - 'LOGNAME': 'cltbld', 08:11:57 INFO - 'MAIL': '/var/mail/cltbld', 08:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:57 INFO - 'MOZ_NO_REMOTE': '1', 08:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:57 INFO - 'NO_EM_RESTART': '1', 08:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:57 INFO - 'PWD': '/builds/slave/test', 08:11:57 INFO - 'SHELL': '/bin/bash', 08:11:57 INFO - 'SHLVL': '1', 08:11:57 INFO - 'TERM': 'linux', 08:11:57 INFO - 'TMOUT': '86400', 08:11:57 INFO - 'USER': 'cltbld', 08:11:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:57 INFO - '_': '/tools/buildbot/bin/python'} 08:11:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:11:57 INFO - Cleaning up... 08:11:57 INFO - Return code: 0 08:11:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:11: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')]} 08:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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')]} 08:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:11: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', '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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 08:11: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 psutil>=3.1.1 08:11:57 INFO - Using env: {'DISPLAY': ':0', 08:11:57 INFO - 'HOME': '/home/cltbld', 08:11:57 INFO - 'LANG': 'en_US.UTF-8', 08:11:57 INFO - 'LANGUAGE': 'en_US:en', 08:11:57 INFO - 'LOGNAME': 'cltbld', 08:11:57 INFO - 'MAIL': '/var/mail/cltbld', 08:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:57 INFO - 'MOZ_NO_REMOTE': '1', 08:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:57 INFO - 'NO_EM_RESTART': '1', 08:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:57 INFO - 'PWD': '/builds/slave/test', 08:11:57 INFO - 'SHELL': '/bin/bash', 08:11:57 INFO - 'SHLVL': '1', 08:11:57 INFO - 'TERM': 'linux', 08:11:57 INFO - 'TMOUT': '86400', 08:11:57 INFO - 'USER': 'cltbld', 08:11:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:57 INFO - '_': '/tools/buildbot/bin/python'} 08:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:11:58 INFO - Downloading/unpacking psutil>=3.1.1 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:00 INFO - Installing collected packages: psutil 08:12:00 INFO - Running setup.py install for psutil 08:12:00 INFO - building 'psutil._psutil_linux' extension 08:12: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 08:12: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 08:12:00 INFO - building 'psutil._psutil_posix' extension 08:12: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 08:12: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 08:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:00 INFO - Successfully installed psutil 08:12:00 INFO - Cleaning up... 08:12:00 INFO - Return code: 0 08:12:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12: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 08:12: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 08:12:00 INFO - Using env: {'DISPLAY': ':0', 08:12:00 INFO - 'HOME': '/home/cltbld', 08:12:00 INFO - 'LANG': 'en_US.UTF-8', 08:12:00 INFO - 'LANGUAGE': 'en_US:en', 08:12:00 INFO - 'LOGNAME': 'cltbld', 08:12:00 INFO - 'MAIL': '/var/mail/cltbld', 08:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:00 INFO - 'MOZ_NO_REMOTE': '1', 08:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:00 INFO - 'NO_EM_RESTART': '1', 08:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:00 INFO - 'PWD': '/builds/slave/test', 08:12:00 INFO - 'SHELL': '/bin/bash', 08:12:00 INFO - 'SHLVL': '1', 08:12:00 INFO - 'TERM': 'linux', 08:12:00 INFO - 'TMOUT': '86400', 08:12:00 INFO - 'USER': 'cltbld', 08:12:00 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:00 INFO - '_': '/tools/buildbot/bin/python'} 08:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:12:02 INFO - Installing collected packages: mozsystemmonitor 08:12:02 INFO - Running setup.py install for mozsystemmonitor 08:12:02 INFO - Successfully installed mozsystemmonitor 08:12:02 INFO - Cleaning up... 08:12:02 INFO - Return code: 0 08:12:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12: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 08:12: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 08:12:03 INFO - Using env: {'DISPLAY': ':0', 08:12:03 INFO - 'HOME': '/home/cltbld', 08:12:03 INFO - 'LANG': 'en_US.UTF-8', 08:12:03 INFO - 'LANGUAGE': 'en_US:en', 08:12:03 INFO - 'LOGNAME': 'cltbld', 08:12:03 INFO - 'MAIL': '/var/mail/cltbld', 08:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:03 INFO - 'MOZ_NO_REMOTE': '1', 08:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:03 INFO - 'NO_EM_RESTART': '1', 08:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:03 INFO - 'PWD': '/builds/slave/test', 08:12:03 INFO - 'SHELL': '/bin/bash', 08:12:03 INFO - 'SHLVL': '1', 08:12:03 INFO - 'TERM': 'linux', 08:12:03 INFO - 'TMOUT': '86400', 08:12:03 INFO - 'USER': 'cltbld', 08:12:03 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:03 INFO - '_': '/tools/buildbot/bin/python'} 08:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:03 INFO - Downloading/unpacking jsonschema==2.5.1 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:05 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:05 INFO - warning: no files found matching '*.txt' 08:12:05 INFO - no previously-included directories found matching 'build' 08:12:05 INFO - no previously-included directories found matching 'dist' 08:12:05 INFO - no previously-included directories found matching '.git*' 08:12:05 INFO - Installing collected packages: jsonschema, functools32 08:12:05 INFO - Running setup.py install for functools32 08:12:05 INFO - warning: no files found matching '*.txt' 08:12:05 INFO - no previously-included directories found matching 'build' 08:12:05 INFO - no previously-included directories found matching 'dist' 08:12:05 INFO - no previously-included directories found matching '.git*' 08:12:05 INFO - Successfully installed jsonschema functools32 08:12:05 INFO - Cleaning up... 08:12:05 INFO - Return code: 0 08:12:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:05 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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:12:05 INFO - Using env: {'DISPLAY': ':0', 08:12:05 INFO - 'HOME': '/home/cltbld', 08:12:05 INFO - 'LANG': 'en_US.UTF-8', 08:12:05 INFO - 'LANGUAGE': 'en_US:en', 08:12:05 INFO - 'LOGNAME': 'cltbld', 08:12:05 INFO - 'MAIL': '/var/mail/cltbld', 08:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:05 INFO - 'MOZ_NO_REMOTE': '1', 08:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:05 INFO - 'NO_EM_RESTART': '1', 08:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:05 INFO - 'PWD': '/builds/slave/test', 08:12:05 INFO - 'SHELL': '/bin/bash', 08:12:05 INFO - 'SHLVL': '1', 08:12:05 INFO - 'TERM': 'linux', 08:12:05 INFO - 'TMOUT': '86400', 08:12:05 INFO - 'USER': 'cltbld', 08:12:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:05 INFO - '_': '/tools/buildbot/bin/python'} 08:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:12:05 INFO - Cleaning up... 08:12:05 INFO - Return code: 0 08:12:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:05 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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:12:05 INFO - Using env: {'DISPLAY': ':0', 08:12:05 INFO - 'HOME': '/home/cltbld', 08:12:05 INFO - 'LANG': 'en_US.UTF-8', 08:12:05 INFO - 'LANGUAGE': 'en_US:en', 08:12:05 INFO - 'LOGNAME': 'cltbld', 08:12:05 INFO - 'MAIL': '/var/mail/cltbld', 08:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:05 INFO - 'MOZ_NO_REMOTE': '1', 08:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:05 INFO - 'NO_EM_RESTART': '1', 08:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:05 INFO - 'PWD': '/builds/slave/test', 08:12:05 INFO - 'SHELL': '/bin/bash', 08:12:05 INFO - 'SHLVL': '1', 08:12:05 INFO - 'TERM': 'linux', 08:12:05 INFO - 'TMOUT': '86400', 08:12:05 INFO - 'USER': 'cltbld', 08:12:05 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:05 INFO - '_': '/tools/buildbot/bin/python'} 08:12:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:05 INFO - Downloading/unpacking blobuploader==1.2.4 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:07 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:08 INFO - Downloading docopt-0.6.1.tar.gz 08:12:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:08 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:08 INFO - Running setup.py install for blobuploader 08:12:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:08 INFO - Running setup.py install for requests 08:12:09 INFO - Running setup.py install for docopt 08:12:09 INFO - Successfully installed blobuploader requests docopt 08:12:09 INFO - Cleaning up... 08:12:09 INFO - Return code: 0 08:12:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:09 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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:09 INFO - Using env: {'DISPLAY': ':0', 08:12:09 INFO - 'HOME': '/home/cltbld', 08:12:09 INFO - 'LANG': 'en_US.UTF-8', 08:12:09 INFO - 'LANGUAGE': 'en_US:en', 08:12:09 INFO - 'LOGNAME': 'cltbld', 08:12:09 INFO - 'MAIL': '/var/mail/cltbld', 08:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:09 INFO - 'MOZ_NO_REMOTE': '1', 08:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:09 INFO - 'NO_EM_RESTART': '1', 08:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:09 INFO - 'PWD': '/builds/slave/test', 08:12:09 INFO - 'SHELL': '/bin/bash', 08:12:09 INFO - 'SHLVL': '1', 08:12:09 INFO - 'TERM': 'linux', 08:12:09 INFO - 'TMOUT': '86400', 08:12:09 INFO - 'USER': 'cltbld', 08:12:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:09 INFO - '_': '/tools/buildbot/bin/python'} 08:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:09 INFO - Running setup.py (path:/tmp/pip-UGIUJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:09 INFO - Running setup.py (path:/tmp/pip-DOXzeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:09 INFO - Running setup.py (path:/tmp/pip-v495z2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:09 INFO - Running setup.py (path:/tmp/pip-tBFVMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:09 INFO - Running setup.py (path:/tmp/pip-WQpxI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:09 INFO - Running setup.py (path:/tmp/pip-8Mr4bN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:09 INFO - Running setup.py (path:/tmp/pip-9YkW6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:09 INFO - Running setup.py (path:/tmp/pip-ulSNDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:10 INFO - Running setup.py (path:/tmp/pip-9pB2RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:10 INFO - Running setup.py (path:/tmp/pip-A9Zjyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:10 INFO - Running setup.py (path:/tmp/pip-k9_2Yc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:10 INFO - Running setup.py (path:/tmp/pip-lJAxJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:10 INFO - Running setup.py (path:/tmp/pip-bUo7ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:10 INFO - Running setup.py (path:/tmp/pip-SzlbaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:10 INFO - Running setup.py (path:/tmp/pip-Ge_W7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:10 INFO - Running setup.py (path:/tmp/pip-PWq36W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:10 INFO - Running setup.py (path:/tmp/pip-rWg9Zw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:10 INFO - Running setup.py install for manifestparser 08:12:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:10 INFO - Running setup.py install for mozcrash 08:12:10 INFO - Running setup.py install for mozdebug 08:12:10 INFO - Running setup.py install for mozdevice 08:12:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozfile 08:12:11 INFO - Running setup.py install for mozhttpd 08:12:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozinfo 08:12:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozInstall 08:12:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozleak 08:12:11 INFO - Running setup.py install for mozlog 08:12:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for moznetwork 08:12:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozprocess 08:12:11 INFO - Running setup.py install for mozprofile 08:12:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:11 INFO - Running setup.py install for mozrunner 08:12:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:12 INFO - Running setup.py install for mozscreenshot 08:12:12 INFO - Running setup.py install for moztest 08:12:12 INFO - Running setup.py install for mozversion 08:12:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:12 INFO - Cleaning up... 08:12:12 INFO - Return code: 0 08:12:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:12 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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:12 INFO - Using env: {'DISPLAY': ':0', 08:12:12 INFO - 'HOME': '/home/cltbld', 08:12:12 INFO - 'LANG': 'en_US.UTF-8', 08:12:12 INFO - 'LANGUAGE': 'en_US:en', 08:12:12 INFO - 'LOGNAME': 'cltbld', 08:12:12 INFO - 'MAIL': '/var/mail/cltbld', 08:12:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:12 INFO - 'MOZ_NO_REMOTE': '1', 08:12:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:12 INFO - 'NO_EM_RESTART': '1', 08:12:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:12 INFO - 'PWD': '/builds/slave/test', 08:12:12 INFO - 'SHELL': '/bin/bash', 08:12:12 INFO - 'SHLVL': '1', 08:12:12 INFO - 'TERM': 'linux', 08:12:12 INFO - 'TMOUT': '86400', 08:12:12 INFO - 'USER': 'cltbld', 08:12:12 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:12 INFO - '_': '/tools/buildbot/bin/python'} 08:12:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:12 INFO - Running setup.py (path:/tmp/pip-kVHY7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:12 INFO - Running setup.py (path:/tmp/pip-LPXKUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:12 INFO - Running setup.py (path:/tmp/pip-9ozQaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:12 INFO - Running setup.py (path:/tmp/pip-2xMwzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:12 INFO - Running setup.py (path:/tmp/pip-FUasdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12: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)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:13 INFO - Running setup.py (path:/tmp/pip-RjM3RM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:13 INFO - Running setup.py (path:/tmp/pip-GWlKIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:13 INFO - Running setup.py (path:/tmp/pip-EM6TAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:13 INFO - Running setup.py (path:/tmp/pip-EeC3fN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:13 INFO - Running setup.py (path:/tmp/pip-Oxy4RX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:13 INFO - Running setup.py (path:/tmp/pip-6HgLEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:13 INFO - Running setup.py (path:/tmp/pip-_ke6QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:13 INFO - Running setup.py (path:/tmp/pip-KtBW8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:13 INFO - Running setup.py (path:/tmp/pip-k5Ybtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:13 INFO - Running setup.py (path:/tmp/pip-aF1cej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:13 INFO - Running setup.py (path:/tmp/pip-7DnznM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:12:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:13 INFO - Running setup.py (path:/tmp/pip-_Xnmfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:12:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:15 INFO - Downloading blessings-1.6.tar.gz 08:12:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:15 INFO - Installing collected packages: blessings 08:12:15 INFO - Running setup.py install for blessings 08:12:15 INFO - Successfully installed blessings 08:12:15 INFO - Cleaning up... 08:12:16 INFO - Return code: 0 08:12:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:16 INFO - Reading from file tmpfile_stdout 08:12:16 INFO - Current package versions: 08:12:16 INFO - argparse == 1.2.1 08:12:16 INFO - blessings == 1.6 08:12:16 INFO - blobuploader == 1.2.4 08:12:16 INFO - docopt == 0.6.1 08:12:16 INFO - functools32 == 3.2.3-2 08:12:16 INFO - jsonschema == 2.5.1 08:12:16 INFO - manifestparser == 1.1 08:12:16 INFO - mozInstall == 1.12 08:12:16 INFO - mozcrash == 0.17 08:12:16 INFO - mozdebug == 0.1 08:12:16 INFO - mozdevice == 0.48 08:12:16 INFO - mozfile == 1.2 08:12:16 INFO - mozhttpd == 0.7 08:12:16 INFO - mozinfo == 0.9 08:12:16 INFO - mozleak == 0.1 08:12:16 INFO - mozlog == 3.3 08:12:16 INFO - moznetwork == 0.27 08:12:16 INFO - mozprocess == 0.23 08:12:16 INFO - mozprofile == 0.28 08:12:16 INFO - mozrunner == 6.12 08:12:16 INFO - mozscreenshot == 0.1 08:12:16 INFO - mozsystemmonitor == 0.3 08:12:16 INFO - moztest == 0.7 08:12:16 INFO - mozversion == 1.4 08:12:16 INFO - psutil == 3.1.1 08:12:16 INFO - requests == 1.2.3 08:12:16 INFO - wsgiref == 0.1.2 08:12:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:16 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 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:16 INFO - Using env: {'DISPLAY': ':0', 08:12:16 INFO - 'HOME': '/home/cltbld', 08:12:16 INFO - 'LANG': 'en_US.UTF-8', 08:12:16 INFO - 'LANGUAGE': 'en_US:en', 08:12:16 INFO - 'LOGNAME': 'cltbld', 08:12:16 INFO - 'MAIL': '/var/mail/cltbld', 08:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:16 INFO - 'MOZ_NO_REMOTE': '1', 08:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:16 INFO - 'NO_EM_RESTART': '1', 08:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:16 INFO - 'PWD': '/builds/slave/test', 08:12:16 INFO - 'SHELL': '/bin/bash', 08:12:16 INFO - 'SHLVL': '1', 08:12:16 INFO - 'TERM': 'linux', 08:12:16 INFO - 'TMOUT': '86400', 08:12:16 INFO - 'USER': 'cltbld', 08:12:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:16 INFO - '_': '/tools/buildbot/bin/python'} 08:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:16 INFO - Cleaning up... 08:12:16 INFO - Return code: 0 08:12:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f611bbfcf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b2230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:12:16 INFO - Using env: {'DISPLAY': ':0', 08:12:16 INFO - 'HOME': '/home/cltbld', 08:12:16 INFO - 'LANG': 'en_US.UTF-8', 08:12:16 INFO - 'LANGUAGE': 'en_US:en', 08:12:16 INFO - 'LOGNAME': 'cltbld', 08:12:16 INFO - 'MAIL': '/var/mail/cltbld', 08:12:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:16 INFO - 'MOZ_NO_REMOTE': '1', 08:12:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:16 INFO - 'NO_EM_RESTART': '1', 08:12:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:16 INFO - 'PWD': '/builds/slave/test', 08:12:16 INFO - 'SHELL': '/bin/bash', 08:12:16 INFO - 'SHLVL': '1', 08:12:16 INFO - 'TERM': 'linux', 08:12:16 INFO - 'TMOUT': '86400', 08:12:16 INFO - 'USER': 'cltbld', 08:12:16 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:16 INFO - '_': '/tools/buildbot/bin/python'} 08:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:16 INFO - Cleaning up... 08:12:16 INFO - Return code: 0 08:12:16 INFO - Running post-action listener: _resource_record_post_action 08:12:16 INFO - Running post-action listener: _start_resource_monitoring 08:12:16 INFO - Starting resource monitoring. 08:12:16 INFO - [mozharness: 2016-08-24 15:12:16.705372Z] Finished create-virtualenv step (success) 08:12:16 INFO - [mozharness: 2016-08-24 15:12:16.706032Z] Running install step. 08:12:16 INFO - Running pre-action listener: _resource_record_pre_action 08:12:16 INFO - Running main action method: install 08:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:16 INFO - Reading from file tmpfile_stdout 08:12:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:16 INFO - Reading from file tmpfile_stdout 08:12:16 INFO - Output received: 08:12:16 INFO - Usage: mozinstall [options] installer 08:12:16 INFO - Options: 08:12:16 INFO - -h, --help show this help message and exit 08:12:16 INFO - -d DEST, --destination=DEST 08:12:16 INFO - Directory to install application into. [default: 08:12:16 INFO - "/builds/slave/test"] 08:12:16 INFO - --app=APP Application being installed. [default: firefox] 08:12:16 INFO - mkdir: /builds/slave/test/build/application 08:12:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:12:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:12:33 INFO - Reading from file tmpfile_stdout 08:12:33 INFO - Output received: 08:12:33 INFO - /builds/slave/test/build/application/firefox/firefox 08:12:33 INFO - Running post-action listener: _resource_record_post_action 08:12:33 INFO - [mozharness: 2016-08-24 15:12:33.067761Z] Finished install step (success) 08:12:33 INFO - [mozharness: 2016-08-24 15:12:33.068009Z] Running run-tests step. 08:12:33 INFO - Running pre-action listener: _resource_record_pre_action 08:12:33 INFO - Running main action method: run_tests 08:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:12:33 INFO - Python 2.7.3 08:12:33 INFO - Return code: 0 08:12:33 INFO - grabbing minidump binary from tooltool 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14ac090>, '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 0x14af9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14afe40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:12:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:12:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:12:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:12:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:12:33 INFO - Return code: 0 08:12:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:12:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:12:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:12:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:12:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:12:33 INFO - Using env: {'DISPLAY': ':0', 08:12:33 INFO - 'HOME': '/home/cltbld', 08:12:33 INFO - 'LANG': 'en_US.UTF-8', 08:12:33 INFO - 'LANGUAGE': 'en_US:en', 08:12:33 INFO - 'LOGNAME': 'cltbld', 08:12:33 INFO - 'MAIL': '/var/mail/cltbld', 08:12:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:12:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:33 INFO - 'MOZ_NO_REMOTE': '1', 08:12:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:33 INFO - 'NO_EM_RESTART': '1', 08:12:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:33 INFO - 'PWD': '/builds/slave/test', 08:12:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:12:33 INFO - 'SHELL': '/bin/bash', 08:12:33 INFO - 'SHLVL': '1', 08:12:33 INFO - 'TERM': 'linux', 08:12:33 INFO - 'TMOUT': '86400', 08:12:33 INFO - 'USER': 'cltbld', 08:12:33 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588', 08:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:33 INFO - '_': '/tools/buildbot/bin/python'} 08:12:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:12:33 INFO - mozversion application_buildid: 20160824072025 08:12:33 INFO - mozversion application_changeset: a5571e6af4e9655ba6af3cb972286697f24813d1 08:12:33 INFO - mozversion application_display_name: Nightly 08:12:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:12:33 INFO - mozversion application_name: Firefox 08:12:33 INFO - mozversion application_remotingname: firefox 08:12:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:12:33 INFO - mozversion application_vendor: Mozilla 08:12:33 INFO - mozversion application_version: 51.0a1 08:12:33 INFO - mozversion platform_buildid: 20160824072025 08:12:33 INFO - mozversion platform_changeset: a5571e6af4e9655ba6af3cb972286697f24813d1 08:12:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:12:33 INFO - mozversion platform_version: 51.0a1 08:12:33 INFO - using testdate: 1472051553 08:12:33 INFO - actual date: 1472051553 08:12:33 INFO - starting webserver on 'localhost:48302' 08:12:33 INFO - SUITE-START | Running 2 tests 08:12:33 INFO - TEST-START | dromaeo_css 08:12:33 INFO - operating with platform_type : linux_ 08:12:33 INFO - Initialising browser for dromaeo_css test... 08:12:33 INFO - TEST-INFO | started process 14037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbBt3C/profile http://localhost:48302/getInfo.html) 08:12:37 INFO - PROCESS | 14037 | __metrics Screen width/height:1600/1200 08:12:37 INFO - PROCESS | 14037 | colorDepth:24 08:12:37 INFO - PROCESS | 14037 | Browser inner width/height: 1024/697 08:12:37 INFO - PROCESS | 14037 | __metrics 08:12:38 INFO - PROCESS | 14037 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:12:38 INFO - PROCESS | 14037 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:38 INFO - PROCESS | 14037 | console.error: PushService: 08:12:38 INFO - PROCESS | 14037 | stateChangeProcessEnqueue: Error transitioning state 08:12:38 INFO - PROCESS | 14037 | UnknownError 08:12:39 INFO - TEST-INFO | 14037: exit 0 08:12:39 INFO - Browser initialized. 08:12:39 INFO - Running cycle 1/1 for dromaeo_css test... 08:12:39 INFO - TEST-INFO | started process 14119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbBt3C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:51 INFO - PROCESS | 14119 | RSS: Main: 181407744 08:12:51 INFO - PROCESS | 14119 | 08:13:42 INFO - PROCESS | 14119 | 1472051622642 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:15:55 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48302/tests/dromaeo/cssquery-ext.html) 08:15:56 INFO - PROCESS | 14119 | RSS: Main: 286756864 08:15:56 INFO - PROCESS | 14119 | 08:18:59 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-ext.html (next: http://localhost:48302/tests/dromaeo/cssquery-jquery.html) 08:19:00 INFO - PROCESS | 14119 | RSS: Main: 272252928 08:19:00 INFO - PROCESS | 14119 | 08:22:02 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48302/tests/dromaeo/cssquery-mootools.html) 08:22:02 INFO - PROCESS | 14119 | RSS: Main: 242860032 08:22:02 INFO - PROCESS | 14119 | 08:25:05 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48302/tests/dromaeo/cssquery-prototype.html) 08:25:05 INFO - PROCESS | 14119 | RSS: Main: 220352512 08:25:05 INFO - PROCESS | 14119 | 08:28:08 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48302/tests/dromaeo/cssquery-yui.html) 08:28:09 INFO - PROCESS | 14119 | RSS: Main: 219254784 08:28:09 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | Cycle 1(1): loaded http://localhost:48302/tests/dromaeo/cssquery-yui.html (next: http://localhost:48302/tests/dromaeo/cssquery-dojo.html) 08:31:12 INFO - PROCESS | 14119 | RSS: Main: 311095296 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | __start_tp_report 08:31:12 INFO - PROCESS | 14119 | _x_x_mozilla_page_load 08:31:12 INFO - PROCESS | 14119 | _x_x_mozilla_page_load_details 08:31:12 INFO - PROCESS | 14119 | |i|pagename|runs| 08:31:12 INFO - PROCESS | 14119 | |0;dojo.html;2525.684289463817;2536.5814640584304;2554.374178326309;2569.537483253014;2577.265479338389;4534.433195850519;4542.205114105035;4581.24409472437;4621.861344159676;4628.305754136877;4626.814927402908;4627.028324051945;4638.884027899304;4679.719216846992;4682.672212945095;4181.498220213563;4230.7038507304505;4244.045089854773;4261.339492378686;4307.117041006586;4232.873013809591;4272.572742725718;4307.353896915456;4311.245532031882;4343.522212556632;4259.616634502894;4313.374560688699;4328.63206627437;4378.299472084467;4399.472063352402;4329.588689074533;4347.3696314034605;4382.276924307485;4401.581849724271;4403.295472724349;4130;4167.124903770212;4172.561881002482;4241.406203131564;4265.680073994463;4548.522405147445;4554.7039442436135;4576.885577860547;4639.884002899921;4652.13935421948;4931.852044438672;4935.531124543163;4953.058918805452;4953.108440480712;5013.799448022075;4828.61371090312;4878.512148785093;4913.901721965541;5012.774425150877;5030.57240134589;4544.477385100723;4599.655025873073;4602.746848923274;4611.976940115345;4657.534246575316;4979.45226025137;4998.650094493423;5020.548150666457;5086.796528138833;5087.160618497906;4706.035262771124;4818.927716084261;4824.421069471686;4825.758712064453;4832.44426890912;4791.520847915181;4854.2233242681;4854.611631069506;4856.587190088882;4920.5571498565305;4809.9038019239415;4812.06164797868;4815.879603009953;4820.590249828733;4871.14754917888;4685.695429797052;4805.687630304019;4813.422389313235;4821.228603423506;4879;4128.710990230655;4151.27352713274;4189.392538082022;4196.832126714959;4238.978805105955;3635.4546817976984;3657.049167216543;3659.8902032939054;3706.9073273168387;3708.2212735325343;4190.811413486339;4195.91608167835;4197.916041679149;4198;4250.893727656833;4798.712077275374;4827.8551643450755;4902.093112774148;4911.7544122793715;4961.231009193581;4222.113356195172;4244.639205667491;4246.957530424718;4285.400043993844;4296.484421869396;4444.1111777643955;4444.266695995125;4450.977745111254;4464.732116072981;4519.751413672214;4473.731576105444;4535.591796738309;4576.748278844696;4589.128065667513;4638.7216766993415;4923.753812309442;4929.852104436873;4930.137225985366;4962.875928101682;4976.502349765139;4589.416651255445;4590;4590.701604395704;4636.791344389578;4646.581807637329;4746.7389293589185;4802.807887684454;4804.8318308859025;4843.321934929042;4856.295837103529;4875.512448755097;4953.653244272867;4956.801727930842;4959.975200123977;4960.454350021422;4816.710997340171;4827.565519103157;4829.73436460998;4832.468428472936;4892.290617860462;4705.106029854317;4719.2921061841;4818.301346304836;4830.758462076952;4894.583960363409;4736.881577960578;4751.311059896227;4754.904901902012;4803.375561177025;4821.7348045856415;4850.248211527219;4855.6601037927;4859.076775412802;4861.076395484846;4916.950830491649;4587.678862479728;4641.164590373765;4646.349511068521;4704.106219818361;4731.739754313408 08:31:12 INFO - PROCESS | 14119 | |1;ext.html;578.3089208395967;583.3961849485783;584.9385814489476;590.4390828712724;590.7400743672782;28629.141125766233;39641.20717585646;40704.79647601762;40739.59260407395;44253;40158.99602509939;40245.39631905524;40660;40704.185916281654;40772;7617.923820761777;7760.495567788104;7761.922380776176;7763.456558040939;7766.456348055638;7727.381809455258;7821.139674635786;7826.608669566527;7842.137364889858;7852.685892564291;7874.173211812763;7898;7924.564148971805;7932.365410767154;7935.127136015034;7824.72613458529;7829.647665854994;7857.0964339101165;7860.921390786076;7861.174576669453;7683.462157648967;7707.807304817368;7745.225477452266;7764.767056988299;7771.455998080137;38571;38824.41763373552;38894.41658375126;38951.80524097361;39254;3080.5687203791485;3082.059971708628;3142.732867706248;3471.8437670304897;3789.0716774390453;31979.783810134893;32172;32445;32487.675123248937;32578.837105814557;3186.123815950609;3214.25911674901;3242.400155971129;3410.6418826023405;3418.1967237699123;271215;272035;272711;273150.999999998;275129;54968.72515637476;55636.721816391466;55658.44341556614;55772.72113639406;55802.441975580536;29191.270218244714;29552.113436596937;29590.704092958797;58937.70531147317;59021.11468327978;12167.33079680626;12321.93839030799;12322;12322.876771232352;12326.32205228721;10813.243072984973;10887.292325998786;10901.34591924487;10906.890931090587;10981.17641176915;18098.27606895736;18315.725264121047;18326.442252408695;18331.633367332845;18340;6809.591424514545;7025.121859767529;7110.288971102848;7126.679299431538;7135.571865688075;749.5989645539719;811.5739236900674;843.9324854011664;878.7275944457239;969.3941286695815;26887.462250755267;28526;28980.855095724808;29131;29150;809.7246936041774;922.2207234886511;938.3572253006575;940.4592359393376;993.7826162950328;14151.221682807338;14727.779083313544;14960.625984350478;15207.695846083237;15244.314005869763;380853;384958.2785463267;386304;387023;387468;49710.50289497059;50148.74925625348;50322.74838625784;50335;50377.74811125921;1086.4513420722485;1150.5167829511458;1170.2334970594275;1199.3943058755274;1200.2918278215895;27477;29217.41565168727;29339.559906600993;29479.26301842471;30300.848495758262;42273.78863105665;42815.3577696341;42828.357574637026;42891.35662965121;42939.570604293556;288528;289282;290501;290672;291344;24504.509909802062;25242;25441;26319.736802631727;26566.867165664047;41950.46362250405;43221.3516797242;43255.78372108119;44444.77777611091;47443.1392151962;35836.64163358333;36073;36195;36761.81619091887;36769.63230367769;36354.4546831803;36539.58711546288;36682.44976325304;38095.42856857094;38909.416358754075;36578;36877.815610921774;37103.6289637111;37472.81263593664;37948.81025594854;31522.842385787924;33645.327093457505;33648.49527257142;33885.491717623765;34131.82934085314;24905.377365566004;25096.874515627303;25321.493570128863;25730.87134564315;25888 08:31:12 INFO - PROCESS | 14119 | |2;jquery.html;348.7907255646614;357.7317012240819;374.93626083565795;375.41622776582415;391.77277179236046;12843.422046007929;16983.405580804676;17345.566360841;18152.18315175817;19121.71317430236;14846.406143754264;14859.702805943874;16019.919900400482;16062.116583587898;16080.517584472454;5140.588752899759;5147.845564633067;5240.60695447841;5283.841484755463;5284.735763211843;3828.827702753369;5154.74226288686;5249.606279529032;5253.106971814782;5856.238688970428;6118.051701986199;6196.318404975449;6224.0663900415075;6224.8132556023165;6226.501879849601;5926.199963005004;6035.668038257894;6067.302260240041;6076;6198.2252218472695;5339.759710813023;5340.706261155674;5342.439043900374;5345.037893179227;5350.117230656937;21501.67747483789;21872.562548749094;22069.33791986243;22074.22740204085;22244.777552224434;1943.3263002479061;2026.3313106674761;2072.922080518122;2471.1104002559246;2481.813863960192;13678;13873.861261387357;13933.303334833217;13934;14304.713905721932;1741.268667159796;1748.8513476354526;1781.287485005995;1822.6901426757483;1827.232562323827;45645.77177114126;62441.37558624447;62721.37278627201;70614.64692676504;70842;8422.494650321001;8723.65105395777;9174.495402752913;9188;9273.814523709489;12023.458944347525;12095.27428354284;12097.092718046182;12100.458903630337;12107;6644.136262285871;6675.23234828001;6825.69284382194;6907.34380233877;6986.44108471321;6549.8690026200165;6592.80221593353;6714.462842972551;6771.93228067713;6858.417034552019;3802.7528210666774;3826.732128750961;3828.789416582059;3895.9805200973815;3908.2965066288343;1818.2817786974072;1866.6266746650454;1897.0988780329233;1899.6960486322398;1915.4062240705425;685.9828504287433;828.2545708861952;847.2374862623565;873.3144481581928;928.6517555916531;16236.594085147966;16521.752173717403;17153.914230429018;17289.308427663003;18202;833.6082041440513;837.6607473972929;845.8392905348087;848.1518481518482;863.5854789700978;9580.56887440053;10065.748356291006;10182.18542516597;10185.185185185168;10199.643012494675;391061;393957;400911;407684.0010798577;412091;82584;85636;86737.69893451603;87802.56098719465;87925.56037219772;900.3877363392955;925.0610630210342;941.5151197133482;944.6268723854176;945;11597.478113485082;16101.355945762038;16515.91742041282;16756.832431676015;16871.66256674884;38269.4259586112;38417;39467.40798888076;39701.808945731675;39845.40231896466;48731.75634121807;48922.51077489322;49592;49626.75186624188;50048.49951500584;6741.696623651849;7519.586422746802;7686.57723825195;7860.646270917708;8166.959165204374;11148.777024459627;11586.536538538365;11794.941025294818;11840.70398240051;12509.499620015098;10227.386356818615;10302.690919272434;10321.948390258001;10391.37651740898;10487.213458990454;10509.159267258448;10524.842127367943;10587.100096491577;10750.354978701303;10822.512986915764;10124.544395502367;10193.184545236512;10326.225533084898;10401.84397234027;10850.620228291971;6882.621455819978;6909.447244220551;6954.130733658293;7095.645217739196;7369.336759691653;7686.896210056973;10265.9486702569;10325.535350909076;10443.582256709646;10464 08:31:12 INFO - PROCESS | 14119 | |3;mootools.html;1296.0474051572094;1356.5387768158828;1382.5990462765799;1574.5355120239528;1614.2897125264883;7016.894746578799;7527;7528.397728181746;7531.209223031585;7534.321911028013;6197.163382943312;7007.509474336798;7189.8562028759525;7202.423806095513;7283.308085731847;2046.5804510075436;2076.397844625057;2077.1276064053136;2078.033714322847;2079.459340571455;2019.656658368081;2032.2074390987527;2039.775624681284;2051.1897800368847;2052.3227334979497;1820.59036716739;2012.8490363222743;2049.5183631846503;2076.086521930346;2080.4278823323557;2067;2090.1952748192057;2090.9477263068393;2091.383042002613;2093.8953052347474;1996;2016.0826823795285;2042.2137477071285;2050.5796311756053;2055.2395613623057;7381.815454613624;7409.666565004588;7511.361534269594;7512.5492470451945;7513.812154696122;4240.724352917081;4395.824167033315;4396.274614688573;4400.185965596343;4400.559944005574;2711.1188863619204;2778.7915906306907;2817.3660926291627;2833.744962953344;2864.1980245531286;801.587182600961;824.2540500846743;836.6318819719304;849.613425891218;850.9531975741331;9786.461744604045;9805.509724513746;9859.950700246452;9906.157976572073;9921.156701680293;3782.4893639358884;3865.632764887331;3944.6647035002347;4036.8990775230855;4065.2072845794787;8542.359323050796;8547.69212312672;8550.1449855014;8556.40105192643;8561.657533698582;4272.33778764292;4278.657707383401;4284.293091639907;4284.935725964113;4286.5284818669925;3932.528096628366;3936.5079365079364;3937.724359294822;3938.940915886264;3939.8030098495533;3195.6964088411564;3265.869365225412;3283.688049635281;3286.1784553861535;3340.1816554944194;970.7670159161892;972.2513664478312;980.5587485631495;986.033686986757;994.472929347447;763.8586861430653;800.1758189065272;809.6761295481737;811.1645005644195;815.963281652327;4761.595264402496;4769.856904292877;4865.635077369141;4937.234728616998;5114.974425127851;817.5054092274207;860.6256278518864;870.4907629036958;874.6195404998846;881.6870011146079;3120.801178791711;3380.5267262583257;3392.4741665041465;3396.4565669492763;3500.632433594487;8663.48019118855;9014.864777028219;9056.411333263317;9067.455952642862;9098.226650734628;8995.910040899507;8996.730098097067;9026;9029.819403611891;9049.77375565616;6760.864782704319;6841.863162736817;6856.280090590516;6857.108575885103;6861.656917154122;4796.56830885222;4840.636952228668;4918.188498897642;4966.776495057658;5120.052790233819;8063.758087257392;8096.7166149184495;8108.75673729789;8165.428420010542;8218.589070546568;7985.920140798517;8018.719344822904;8052.436329457116;8378.664853405795;8460.915390846012;5989.910151347646;6047.818565443044;6049;6068.120122582112;6071.848203794941;6818.610281495777;6944.305569443015;7007.579545227302;7033.120859892513;7047.260037695968;5029.874253143701;6215.378462153749;6223.968880155751;6248.9062664059165;6332.493400528039;6269.937300627118;6301.40136687014;6304.464120549621;6315.684215789101;6384.329645387167;5947.167396564571;5967.76128954837;6017.187679663364;6021.578489505868;6023.969880150571;4351.499577548622;4384.890377740455;4466.910661786681;4474.306482495218;4625.491195968373;4370.322599997005;4481.619062379734;4507.940633950953;4530.524294949115;4564.406627138451 08:31:12 INFO - PROCESS | 14119 | |4;prototype.html;287.24311439357285;293.45124616966274;295.779644165097;296.05115604487605;300.4981680593408;4755.358026666399;4791;4811.542903424178;4857.368542089528;4860.684055536388;4678.836240731575;4753.263244197146;4765.142274390609;4768.880777980544;4770.594499467541;3584.9641503584958;3683.926321473569;3692.5015122958325;3715.461258117571;3718.4794128821986;3596.5684117905757;3758.4926034985338;3773.6415040571237;3787.9923640470593;3815.618438156176;3704.481372607837;3717.1636381814146;3726.795026273554;3777.471154038437;3780.9810950945207;3517.505060349367;3717.70258379329;3722.4788529605876;3730.1047748540427;3737.9626203737885;3293.2919422324076;3302.4055669979393;3303.0256074458093;3316.154380632923;3326.6507016763135;4556.977215113903;4560.042391097873;4582.541745825424;4593.793279302439;4609.423822022247;4259.9574004260185;4278.272693642089;4288.206681763883;4288.356746488021;4306.870793876189;4695.765211739399;4981.252812078181;4983.7757300921185;4986.152354099775;4993.525615066563;3516.331896939573;3529.7882127072203;3553.129483276588;3553.289342131558;3574.874879379235;5191.818286359997;5217.50433708797;5220.530152286313;5269.894602107975;5289.391719952217;3555.6977656898935;3612.205314830733;3624.3657359961903;3657.6708096271464;3659.304732100892;3629.237860049366;3631.5279013728045;3641.927161456756;3663.5420572428447;3684.5578530576504;4157;4173.269677806372;4175.874723758231;4205.789710514462;4207.516135644379;4952.5542701157065;4954.157793175097;4955.72036863047;4959.925601115986;4960.156773348539;1189.5717541684987;1262.3372729316998;1265.702559898423;1266.4486004644236;1266.9176503527242;786.9016372953381;800.5756948817136;810.7446154461326;814.5357146426599;819.2913130142384;4166.187823219376;4242.978785106055;4371.475422949266;4374.091229332522;4399.5160532341415;5102.336696229467;5108.821191258363;5110.2590124431745;5111.361079865017;5120.564751996122;4355.673324500675;4364.323529852878;4370.956290437119;4375.978120109443;4378.9928316487385;2604.9088281910044;2665;2682.409869828635;2698.1770559979004;2712.742289482496;4740.217864052462;4748.548887855648;4749.3852090289465;4764.213904705684;4765.976170119127;5165.793368265227;5171.793128274902;5181.5854731621375;5194.662346947436;5222.8955420892125;4569.9314510282375;4722.929156062662;4738.95261047392;4740.786664600101;4753.667243292936;5085.973845561884;5110.163859058258;5112.616553758408;5120.513551212629;5164.225366195101;4981.153203955409;4988.326575912351;5018.397792264952;5041.899162016813;5094.7962081516325;4479.932801008053;4790.353302304284;4820.758962051954;4829.9034019318715;4830.95169048305;3667.853285868642;3675.1730860556163;3695.113172838553;3699.5005674233635;3733.178700685845;5182.922256166085;5204.765785539736;5205.843824685266;5214.504622060898;5245.449227831023;4924.482929292516;4937.407511098548;4974.403071631427;4983.3023376728015;5013.573846223112;4999.725015124058;5001.299818025406;5025.6482046256415;5033.748312584283;5038.47096054909;4953.455119936876;4980.626453016111;4985.750712464434;4999.725015124203;5009.949900500948;4788.162071637519;4879.707217566957;4891.364122664031;5039.748012599282;5042.168042272984;4845.345878306383;4859.837372369262;4901.730404827768;4903.5586797188425;4904.8773780655765 08:31:12 INFO - PROCESS | 14119 | |5;yui.html;646.7219095788811;680.9421199198065;685.6366125953247;712.9001939728436;740.9110906691197;12734.55429059983;13514.729705405898;13521.729565408687;13581.38883750231;13738;12147.331896745698;12164.330961797097;12171.087168462356;12172.817407738868;12192.939035304833;623.5853157650157;730.5397599512313;738.4350971506801;764.0296823034743;766.4711349169083;760.3461023519768;761.4251240313555;762;762.3024932187042;763.0080894836718;803.1005274093023;804.2801692485223;804.9154838741936;806.2622700229313;806.4516129032256;655.397034728049;675.0144788608637;679.7654809090856;680.7651360280695;793.1354823242665;571.368637655389;585.0843430032029;585.3970410477215;585.6017907822679;586.7564960541371;12862.228266304051;12880.355982200947;12894.355282235945;12896.22622642635;12902.54841080567;11961.700957476045;12272.877271227351;12488.937555312164;12892.935535322264;12905.612831614973;10831.891681083167;11306.660800176009;11457.713557161054;11546.307221566733;12160.270383777002;4053.756774593534;4078.225137223918;4094.2220978014084;4148.481439820022;4152;52643.736781316235;55633.1655025179;62382.37617623811;62723;62745;10385.273030887765;10560.155187584975;10745.83881241782;10774.892251077388;10845.51195196218;20706.792932070486;21004;21020.684689729667;21028.684569731467;21044.47388815292;6843.965780171166;7100.396466300319;7120.71517139319;7142.285771422816;7386.741464048732;3736.4768932349493;3754.324221640131;3836.5971572984436;3845.020403881969;3881.8253178606465;2894.4066466374343;3012.201766531871;3019.909402717878;3022.9244268893012;3023.3046399328277;494.06868053719;506.6909185396905;506.83527853447777;507.5787096709722;514.3570536828964;577.644748479682;610.664134725899;611.6483022262217;619.1115748900343;621.1304174156218;7983.800404989922;8477.263661747083;8550.78623034429;8585.742427727178;8673.132686731276;498.10000543561455;590.2916500199777;593.4955288005161;596.2755252368394;599.2988203801563;3980.940285895656;4023.1953609277675;4149.419081328617;4228.217779710763;4256.63078873447;57012.71493642505;57112.42887571071;57124.71437642868;57345.13982290269;58086.4191358081;74761.62619186979;86981.56509217413;87320;87386.56306718553;89605;45209.999999999345;60011.69994150001;66808.66595667088;71329;81124;7459.365953893763;8286.212809783061;8392.580370981548;8420.284275836622;8478.660853566034;34690.30619387649;37962;40662.883995301294;44067.55932440634;44307.55692443034;35270.47094293536;36093.63906361008;48487.51512484971;56793;58802.705986469795;9295.163435290857;9753.707388778348;10416.21878359111;10621.309614875008;10959.06847917936;10684.145268378355;10741.087007604128;10764.784704306026;11264.15518836107;11266.718332041764;10149.087417857458;10312;10316.742081448025;10608;10817.675469735921;9623.278254131108;9963.402195868272;10155.796884062129;11081.72295692582;11221.60724374643;11290.887091128983;11845.23006004607;11884.76230475403;12257.32584707814;12507.27369483814;10970.341779493256;11088.501017454395;11143.275687080313;11148;11352.943235284101;10127.24045696561;10231.846522302023;10322.48387580633;10322.535485903003;10593 08:31:12 INFO - PROCESS | 14119 | __end_tp_report 08:31:12 INFO - PROCESS | 14119 | __start_cc_report 08:31:12 INFO - PROCESS | 14119 | _x_x_mozilla_cycle_collect,942 08:31:12 INFO - PROCESS | 14119 | __end_cc_report 08:31:12 INFO - PROCESS | 14119 | __startTimestamp1472052672705__endTimestamp 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | ------- Summary: start ------- 08:31:12 INFO - PROCESS | 14119 | Number of tests: 6 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#0] dojo.html Cycles:165 Average:4548.72 Median:4646.35 stddev:467.81 (10.1%) stddev-sans-first:441.51 08:31:12 INFO - PROCESS | 14119 | Values: 2525.7 2536.6 2554.4 2569.5 2577.3 4534.4 4542.2 4581.2 4621.9 4628.3 4626.8 4627.0 4638.9 4679.7 4682.7 4181.5 4230.7 4244.0 4261.3 4307.1 4232.9 4272.6 4307.4 4311.2 4343.5 4259.6 4313.4 4328.6 4378.3 4399.5 4329.6 4347.4 4382.3 4401.6 4403.3 4130.0 4167.1 4172.6 4241.4 4265.7 4548.5 4554.7 4576.9 4639.9 4652.1 4931.9 4935.5 4953.1 4953.1 5013.8 4828.6 4878.5 4913.9 5012.8 5030.6 4544.5 4599.7 4602.7 4612.0 4657.5 4979.5 4998.7 5020.5 5086.8 5087.2 4706.0 4818.9 4824.4 4825.8 4832.4 4791.5 4854.2 4854.6 4856.6 4920.6 4809.9 4812.1 4815.9 4820.6 4871.1 4685.7 4805.7 4813.4 4821.2 4879.0 4128.7 4151.3 4189.4 4196.8 4239.0 3635.5 3657.0 3659.9 3706.9 3708.2 4190.8 4195.9 4197.9 4198.0 4250.9 4798.7 4827.9 4902.1 4911.8 4961.2 4222.1 4244.6 4247.0 4285.4 4296.5 4444.1 4444.3 4451.0 4464.7 4519.8 4473.7 4535.6 4576.7 4589.1 4638.7 4923.8 4929.9 4930.1 4962.9 4976.5 4589.4 4590.0 4590.7 4636.8 4646.6 4746.7 4802.8 4804.8 4843.3 4856.3 4875.5 4953.7 4956.8 4960.0 4960.5 4816.7 4827.6 4829.7 4832.5 4892.3 4705.1 4719.3 4818.3 4830.8 4894.6 4736.9 4751.3 4754.9 4803.4 4821.7 4850.2 4855.7 4859.1 4861.1 4917.0 4587.7 4641.2 4646.3 4704.1 4731.7 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#1] ext.html Cycles:180 Average:47167.63 Median:20868.94 stddev:84128.70 (403.1%) stddev-sans-first:84291.98 08:31:12 INFO - PROCESS | 14119 | Values: 578.3 583.4 584.9 590.4 590.7 28629.1 39641.2 40704.8 40739.6 44253.0 40159.0 40245.4 40660.0 40704.2 40772.0 7617.9 7760.5 7761.9 7763.5 7766.5 7727.4 7821.1 7826.6 7842.1 7852.7 7874.2 7898.0 7924.6 7932.4 7935.1 7824.7 7829.6 7857.1 7860.9 7861.2 7683.5 7707.8 7745.2 7764.8 7771.5 38571.0 38824.4 38894.4 38951.8 39254.0 3080.6 3082.1 3142.7 3471.8 3789.1 31979.8 32172.0 32445.0 32487.7 32578.8 3186.1 3214.3 3242.4 3410.6 3418.2 271215.0 272035.0 272711.0 273151.0 275129.0 54968.7 55636.7 55658.4 55772.7 55802.4 29191.3 29552.1 29590.7 58937.7 59021.1 12167.3 12321.9 12322.0 12322.9 12326.3 10813.2 10887.3 10901.3 10906.9 10981.2 18098.3 18315.7 18326.4 18331.6 18340.0 6809.6 7025.1 7110.3 7126.7 7135.6 749.6 811.6 843.9 878.7 969.4 26887.5 28526.0 28980.9 29131.0 29150.0 809.7 922.2 938.4 940.5 993.8 14151.2 14727.8 14960.6 15207.7 15244.3 380853.0 384958.3 386304.0 387023.0 387468.0 49710.5 50148.7 50322.7 50335.0 50377.7 1086.5 1150.5 1170.2 1199.4 1200.3 27477.0 29217.4 29339.6 29479.3 30300.8 42273.8 42815.4 42828.4 42891.4 42939.6 288528.0 289282.0 290501.0 290672.0 291344.0 24504.5 25242.0 25441.0 26319.7 26566.9 41950.5 43221.4 43255.8 44444.8 47443.1 35836.6 36073.0 36195.0 36761.8 36769.6 36354.5 36539.6 36682.4 38095.4 38909.4 36578.0 36877.8 37103.6 37472.8 37948.8 31522.8 33645.3 33648.5 33885.5 34131.8 24905.4 25096.9 25321.5 25730.9 25888.0 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#2] jquery.html Cycles:180 Average:24779.28 Median:195726.39 stddev:66281.22 (33.9%) stddev-sans-first:66441.78 08:31:12 INFO - PROCESS | 14119 | Values: 348.8 357.7 374.9 375.4 391.8 12843.4 16983.4 17345.6 18152.2 19121.7 14846.4 14859.7 16019.9 16062.1 16080.5 5140.6 5147.8 5240.6 5283.8 5284.7 3828.8 5154.7 5249.6 5253.1 5856.2 6118.1 6196.3 6224.1 6224.8 6226.5 5926.2 6035.7 6067.3 6076.0 6198.2 5339.8 5340.7 5342.4 5345.0 5350.1 21501.7 21872.6 22069.3 22074.2 22244.8 1943.3 2026.3 2072.9 2471.1 2481.8 13678.0 13873.9 13933.3 13934.0 14304.7 1741.3 1748.9 1781.3 1822.7 1827.2 45645.8 62441.4 62721.4 70614.6 70842.0 8422.5 8723.7 9174.5 9188.0 9273.8 12023.5 12095.3 12097.1 12100.5 12107.0 6644.1 6675.2 6825.7 6907.3 6986.4 6549.9 6592.8 6714.5 6771.9 6858.4 3802.8 3826.7 3828.8 3896.0 3908.3 1818.3 1866.6 1897.1 1899.7 1915.4 686.0 828.3 847.2 873.3 928.7 16236.6 16521.8 17153.9 17289.3 18202.0 833.6 837.7 845.8 848.2 863.6 9580.6 10065.7 10182.2 10185.2 10199.6 391061.0 393957.0 400911.0 407684.0 412091.0 82584.0 85636.0 86737.7 87802.6 87925.6 900.4 925.1 941.5 944.6 945.0 11597.5 16101.4 16515.9 16756.8 16871.7 38269.4 38417.0 39467.4 39701.8 39845.4 48731.8 48922.5 49592.0 49626.8 50048.5 6741.7 7519.6 7686.6 7860.6 8167.0 11148.8 11586.5 11794.9 11840.7 12509.5 10227.4 10302.7 10321.9 10391.4 10487.2 10509.2 10524.8 10587.1 10750.4 10822.5 10124.5 10193.2 10326.2 10401.8 10850.6 6882.6 6909.4 6954.1 7095.6 7369.3 7686.9 10265.9 10325.5 10443.6 10464.0 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#3] mootools.html Cycles:180 Average:4795.63 Median:6022.77 stddev:2663.48 (44.2%) stddev-sans-first:2657.97 08:31:12 INFO - PROCESS | 14119 | Values: 1296.0 1356.5 1382.6 1574.5 1614.3 7016.9 7527.0 7528.4 7531.2 7534.3 6197.2 7007.5 7189.9 7202.4 7283.3 2046.6 2076.4 2077.1 2078.0 2079.5 2019.7 2032.2 2039.8 2051.2 2052.3 1820.6 2012.8 2049.5 2076.1 2080.4 2067.0 2090.2 2090.9 2091.4 2093.9 1996.0 2016.1 2042.2 2050.6 2055.2 7381.8 7409.7 7511.4 7512.5 7513.8 4240.7 4395.8 4396.3 4400.2 4400.6 2711.1 2778.8 2817.4 2833.7 2864.2 801.6 824.3 836.6 849.6 851.0 9786.5 9805.5 9860.0 9906.2 9921.2 3782.5 3865.6 3944.7 4036.9 4065.2 8542.4 8547.7 8550.1 8556.4 8561.7 4272.3 4278.7 4284.3 4284.9 4286.5 3932.5 3936.5 3937.7 3938.9 3939.8 3195.7 3265.9 3283.7 3286.2 3340.2 970.8 972.3 980.6 986.0 994.5 763.9 800.2 809.7 811.2 816.0 4761.6 4769.9 4865.6 4937.2 5115.0 817.5 860.6 870.5 874.6 881.7 3120.8 3380.5 3392.5 3396.5 3500.6 8663.5 9014.9 9056.4 9067.5 9098.2 8995.9 8996.7 9026.0 9029.8 9049.8 6760.9 6841.9 6856.3 6857.1 6861.7 4796.6 4840.6 4918.2 4966.8 5120.1 8063.8 8096.7 8108.8 8165.4 8218.6 7985.9 8018.7 8052.4 8378.7 8460.9 5989.9 6047.8 6049.0 6068.1 6071.8 6818.6 6944.3 7007.6 7033.1 7047.3 5029.9 6215.4 6224.0 6248.9 6332.5 6269.9 6301.4 6304.5 6315.7 6384.3 5947.2 5967.8 6017.2 6021.6 6024.0 4351.5 4384.9 4466.9 4474.3 4625.5 4370.3 4481.6 4507.9 4530.5 4564.4 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#4] prototype.html Cycles:180 Average:4132.08 Median:4739.59 stddev:1204.42 (25.4%) stddev-sans-first:1172.71 08:31:12 INFO - PROCESS | 14119 | Values: 287.2 293.5 295.8 296.1 300.5 4755.4 4791.0 4811.5 4857.4 4860.7 4678.8 4753.3 4765.1 4768.9 4770.6 3585.0 3683.9 3692.5 3715.5 3718.5 3596.6 3758.5 3773.6 3788.0 3815.6 3704.5 3717.2 3726.8 3777.5 3781.0 3517.5 3717.7 3722.5 3730.1 3738.0 3293.3 3302.4 3303.0 3316.2 3326.7 4557.0 4560.0 4582.5 4593.8 4609.4 4260.0 4278.3 4288.2 4288.4 4306.9 4695.8 4981.3 4983.8 4986.2 4993.5 3516.3 3529.8 3553.1 3553.3 3574.9 5191.8 5217.5 5220.5 5269.9 5289.4 3555.7 3612.2 3624.4 3657.7 3659.3 3629.2 3631.5 3641.9 3663.5 3684.6 4157.0 4173.3 4175.9 4205.8 4207.5 4952.6 4954.2 4955.7 4959.9 4960.2 1189.6 1262.3 1265.7 1266.4 1266.9 786.9 800.6 810.7 814.5 819.3 4166.2 4243.0 4371.5 4374.1 4399.5 5102.3 5108.8 5110.3 5111.4 5120.6 4355.7 4364.3 4371.0 4376.0 4379.0 2604.9 2665.0 2682.4 2698.2 2712.7 4740.2 4748.5 4749.4 4764.2 4766.0 5165.8 5171.8 5181.6 5194.7 5222.9 4569.9 4722.9 4739.0 4740.8 4753.7 5086.0 5110.2 5112.6 5120.5 5164.2 4981.2 4988.3 5018.4 5041.9 5094.8 4479.9 4790.4 4820.8 4829.9 4831.0 3667.9 3675.2 3695.1 3699.5 3733.2 5182.9 5204.8 5205.8 5214.5 5245.4 4924.5 4937.4 4974.4 4983.3 5013.6 4999.7 5001.3 5025.6 5033.7 5038.5 4953.5 4980.6 4985.8 4999.7 5009.9 4788.2 4879.7 4891.4 5039.7 5042.2 4845.3 4859.8 4901.7 4903.6 4904.9 08:31:12 INFO - PROCESS | 14119 | 08:31:12 INFO - PROCESS | 14119 | [#5] yui.html Cycles:180 Average:15787.59 Median:24162.10 stddev:21037.73 (87.1%) stddev-sans-first:21066.03 08:31:12 INFO - PROCESS | 14119 | Values: 646.7 680.9 685.6 712.9 740.9 12734.6 13514.7 13521.7 13581.4 13738.0 12147.3 12164.3 12171.1 12172.8 12192.9 623.6 730.5 738.4 764.0 766.5 760.3 761.4 762.0 762.3 763.0 803.1 804.3 804.9 806.3 806.5 655.4 675.0 679.8 680.8 793.1 571.4 585.1 585.4 585.6 586.8 12862.2 12880.4 12894.4 12896.2 12902.5 11961.7 12272.9 12488.9 12892.9 12905.6 10831.9 11306.7 11457.7 11546.3 12160.3 4053.8 4078.2 4094.2 4148.5 4152.0 52643.7 55633.2 62382.4 62723.0 62745.0 10385.3 10560.2 10745.8 10774.9 10845.5 20706.8 21004.0 21020.7 21028.7 21044.5 6844.0 7100.4 7120.7 7142.3 7386.7 3736.5 3754.3 3836.6 3845.0 3881.8 2894.4 3012.2 3019.9 3022.9 3023.3 494.1 506.7 506.8 507.6 514.4 577.6 610.7 611.6 619.1 621.1 7983.8 8477.3 8550.8 8585.7 8673.1 498.1 590.3 593.5 596.3 599.3 3980.9 4023.2 4149.4 4228.2 4256.6 57012.7 57112.4 57124.7 57345.1 58086.4 74761.6 86981.6 87320.0 87386.6 89605.0 45210.0 60011.7 66808.7 71329.0 81124.0 7459.4 8286.2 8392.6 8420.3 8478.7 34690.3 37962.0 40662.9 44067.6 44307.6 35270.5 36093.6 48487.5 56793.0 58802.7 9295.2 9753.7 10416.2 10621.3 10959.1 10684.1 10741.1 10764.8 11264.2 11266.7 10149.1 10312.0 10316.7 10608.0 10817.7 9623.3 9963.4 10155.8 11081.7 11221.6 11290.9 11845.2 11884.8 12257.3 12507.3 10970.3 11088.5 11143.3 11148.0 11352.9 10127.2 10231.8 10322.5 10322.5 10593.0 08:31:12 INFO - PROCESS | 14119 | -------- Summary: end -------- 08:31:12 INFO - PROCESS | 14119 | 08:31:13 INFO - TEST-INFO | 14119: exit 0 08:31:13 INFO - TEST-OK | dromaeo_css | took 1120433ms 08:31:13 INFO - TEST-START | kraken 08:31:13 INFO - operating with platform_type : linux_ 08:31:13 INFO - Initialising browser for kraken test... 08:31:13 INFO - TEST-INFO | started process 14426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp73kg4y/profile http://localhost:48302/getInfo.html) 08:31:18 INFO - PROCESS | 14426 | __metrics Screen width/height:1600/1200 08:31:18 INFO - PROCESS | 14426 | colorDepth:24 08:31:18 INFO - PROCESS | 14426 | Browser inner width/height: 1024/697 08:31:18 INFO - PROCESS | 14426 | __metrics 08:31:18 INFO - PROCESS | 14426 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:31:18 INFO - PROCESS | 14426 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:19 INFO - TEST-INFO | 14426: exit 0 08:31:19 INFO - Browser initialized. 08:31:19 INFO - Running cycle 1/1 for kraken test... 08:31:19 INFO - TEST-INFO | started process 14506 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp73kg4y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:31:32 INFO - PROCESS | 14506 | RSS: Main: 181481472 08:31:32 INFO - PROCESS | 14506 | 08:31:34 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48302/tests/kraken/driver.html?testName=audio-beat-detection) 08:31:35 INFO - PROCESS | 14506 | RSS: Main: 235126784 08:31:35 INFO - PROCESS | 14506 | 08:31:38 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48302/tests/kraken/driver.html?testName=audio-dft) 08:31:39 INFO - PROCESS | 14506 | RSS: Main: 225996800 08:31:39 INFO - PROCESS | 14506 | 08:31:42 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48302/tests/kraken/driver.html?testName=audio-fft) 08:31:42 INFO - PROCESS | 14506 | RSS: Main: 304934912 08:31:42 INFO - PROCESS | 14506 | 08:31:45 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48302/tests/kraken/driver.html?testName=audio-oscillator) 08:31:45 INFO - PROCESS | 14506 | RSS: Main: 214355968 08:31:45 INFO - PROCESS | 14506 | 08:31:47 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48302/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:31:48 INFO - PROCESS | 14506 | RSS: Main: 215629824 08:31:48 INFO - PROCESS | 14506 | 08:31:51 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48302/tests/kraken/driver.html?testName=imaging-darkroom) 08:31:52 INFO - PROCESS | 14506 | RSS: Main: 253751296 08:31:52 INFO - PROCESS | 14506 | 08:31:55 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48302/tests/kraken/driver.html?testName=imaging-desaturate) 08:31:56 INFO - PROCESS | 14506 | RSS: Main: 247517184 08:31:56 INFO - PROCESS | 14506 | 08:31:59 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48302/tests/kraken/driver.html?testName=json-parse-financial) 08:31:59 INFO - PROCESS | 14506 | RSS: Main: 250884096 08:31:59 INFO - PROCESS | 14506 | 08:32:01 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48302/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:02 INFO - PROCESS | 14506 | RSS: Main: 215101440 08:32:02 INFO - PROCESS | 14506 | 08:32:04 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:04 INFO - PROCESS | 14506 | RSS: Main: 222695424 08:32:04 INFO - PROCESS | 14506 | 08:32:06 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:07 INFO - PROCESS | 14506 | RSS: Main: 224149504 08:32:07 INFO - PROCESS | 14506 | 08:32:10 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:11 INFO - PROCESS | 14506 | RSS: Main: 218275840 08:32:11 INFO - PROCESS | 14506 | 08:32:14 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:14 INFO - PROCESS | 14506 | RSS: Main: 222441472 08:32:14 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | Cycle 1(1): loaded http://localhost:48302/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48302/tests/kraken/driver.html?testName=ai-astar) 08:32:16 INFO - PROCESS | 14506 | RSS: Main: 271872000 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | __start_tp_report 08:32:16 INFO - PROCESS | 14506 | _x_x_mozilla_page_load 08:32:16 INFO - PROCESS | 14506 | _x_x_mozilla_page_load_details 08:32:16 INFO - PROCESS | 14506 | |i|pagename|runs| 08:32:16 INFO - PROCESS | 14506 | |0;ai-astar;115;115;129;118;117;116;115;116;114;114 08:32:16 INFO - PROCESS | 14506 | |1;audio-beat-detection;158;122;147;181;122;144;144;126;192;123 08:32:16 INFO - PROCESS | 14506 | |2;audio-dft;162;163;162;162;161;161;160;160;160;160 08:32:16 INFO - PROCESS | 14506 | |3;audio-fft;75;80;75;165;77;78;87;78;168;77 08:32:16 INFO - PROCESS | 14506 | |4;audio-oscillator;86;87;150;88;87;89;144;87;87;141 08:32:16 INFO - PROCESS | 14506 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;117;117 08:32:16 INFO - PROCESS | 14506 | |6;imaging-darkroom;146;147;146;147;145;147;146;146;147;146 08:32:16 INFO - PROCESS | 14506 | |7;imaging-desaturate;96;96;95;95;95;95;95;95;95;94 08:32:16 INFO - PROCESS | 14506 | |8;json-parse-financial;66;66;66;67;66;66;67;67;73;65 08:32:16 INFO - PROCESS | 14506 | |9;json-stringify-tinderbox;66;66;65;65;66;65;66;66;65;65 08:32:16 INFO - PROCESS | 14506 | |10;stanford-crypto-aes;83;83;83;86;83;84;81;91;88;82 08:32:16 INFO - PROCESS | 14506 | |11;stanford-crypto-ccm;148;144;132;153;142;138;135;136;150;130 08:32:16 INFO - PROCESS | 14506 | |12;stanford-crypto-pbkdf2;171;171;176;171;172;174;170;172;168;171 08:32:16 INFO - PROCESS | 14506 | |13;stanford-crypto-sha256-iterative;72;69;68;78;68;69;67;68;67;67 08:32:16 INFO - PROCESS | 14506 | __end_tp_report 08:32:16 INFO - PROCESS | 14506 | __start_cc_report 08:32:16 INFO - PROCESS | 14506 | _x_x_mozilla_cycle_collect,1977 08:32:16 INFO - PROCESS | 14506 | __end_cc_report 08:32:16 INFO - PROCESS | 14506 | __startTimestamp1472052736693__endTimestamp 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | ------- Summary: start ------- 08:32:16 INFO - PROCESS | 14506 | Number of tests: 14 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#0] ai-astar Cycles:10 Average:116.90 Median:116.00 stddev:4.43 (3.8%) stddev-sans-first:4.65 08:32:16 INFO - PROCESS | 14506 | Values: 115.0 115.0 129.0 118.0 117.0 116.0 115.0 116.0 114.0 114.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:145.50 stddev:24.89 (17.1%) stddev-sans-first:26.01 08:32:16 INFO - PROCESS | 14506 | Values: 158.0 122.0 147.0 181.0 122.0 144.0 144.0 126.0 192.0 123.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 08:32:16 INFO - PROCESS | 14506 | Values: 162.0 163.0 162.0 162.0 161.0 161.0 160.0 160.0 160.0 160.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.50 stddev:37.32 (48.2%) stddev-sans-first:38.80 08:32:16 INFO - PROCESS | 14506 | Values: 75.0 80.0 75.0 165.0 77.0 78.0 87.0 78.0 168.0 77.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:87.00 stddev:27.97 (32.2%) stddev-sans-first:28.85 08:32:16 INFO - PROCESS | 14506 | Values: 86.0 87.0 150.0 88.0 87.0 89.0 144.0 87.0 87.0 141.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:32:16 INFO - PROCESS | 14506 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:32:16 INFO - PROCESS | 14506 | Values: 146.0 147.0 146.0 147.0 145.0 147.0 146.0 146.0 147.0 146.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 08:32:16 INFO - PROCESS | 14506 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#8] json-parse-financial Cycles:10 Average:66.90 Median:66.50 stddev:2.23 (3.4%) stddev-sans-first:2.35 08:32:16 INFO - PROCESS | 14506 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 73.0 65.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:66.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 08:32:16 INFO - PROCESS | 14506 | Values: 66.0 66.0 65.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:3.06 (3.7%) stddev-sans-first:3.21 08:32:16 INFO - PROCESS | 14506 | Values: 83.0 83.0 83.0 86.0 83.0 84.0 81.0 91.0 88.0 82.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:143.00 stddev:7.86 (5.5%) stddev-sans-first:7.89 08:32:16 INFO - PROCESS | 14506 | Values: 148.0 144.0 132.0 153.0 142.0 138.0 135.0 136.0 150.0 130.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.17 (1.3%) stddev-sans-first:2.29 08:32:16 INFO - PROCESS | 14506 | Values: 171.0 171.0 176.0 171.0 172.0 174.0 170.0 172.0 168.0 171.0 08:32:16 INFO - PROCESS | 14506 | 08:32:16 INFO - PROCESS | 14506 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:68.50 stddev:3.40 (5.0%) stddev-sans-first:3.46 08:32:16 INFO - PROCESS | 14506 | Values: 72.0 69.0 68.0 78.0 68.0 69.0 67.0 68.0 67.0 67.0 08:32:16 INFO - PROCESS | 14506 | -------- Summary: end -------- 08:32:16 INFO - PROCESS | 14506 | 08:32:17 INFO - TEST-INFO | 14506: exit 0 08:32:18 INFO - TEST-OK | kraken | took 64231ms 08:32:18 INFO - SUITE-END | took 1184s 08:32:18 INFO - Completed test suite (00:19:45) 08:32:18 INFO - javascript benchmark 08:32:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2525.684289463817, 2536.5814640584304, 2554.374178326309, 2569.537483253014, 2577.265479338389, 4534.433195850519, 4542.205114105035, 4581.24409472437, 4621.861344159676, 4628.305754136877, 4626.814927402908, 4627.028324051945, 4638.884027899304, 4679.719216846992, 4682.672212945095, 4181.498220213563, 4230.7038507304505, 4244.045089854773, 4261.339492378686, 4307.117041006586, 4232.873013809591, 4272.572742725718, 4307.353896915456, 4311.245532031882, 4343.522212556632, 4259.616634502894, 4313.374560688699, 4328.63206627437, 4378.299472084467, 4399.472063352402, 4329.588689074533, 4347.3696314034605, 4382.276924307485, 4401.581849724271, 4403.295472724349, 4130.0, 4167.124903770212, 4172.561881002482, 4241.406203131564, 4265.680073994463, 4548.522405147445, 4554.7039442436135, 4576.885577860547, 4639.884002899921, 4652.13935421948, 4931.852044438672, 4935.531124543163, 4953.058918805452, 4953.108440480712, 5013.799448022075, 4828.61371090312, 4878.512148785093, 4913.901721965541, 5012.774425150877, 5030.57240134589, 4544.477385100723, 4599.655025873073, 4602.746848923274, 4611.976940115345, 4657.534246575316, 4979.45226025137, 4998.650094493423, 5020.548150666457, 5086.796528138833, 5087.160618497906, 4706.035262771124, 4818.927716084261, 4824.421069471686, 4825.758712064453, 4832.44426890912, 4791.520847915181, 4854.2233242681, 4854.611631069506, 4856.587190088882, 4920.5571498565305, 4809.9038019239415, 4812.06164797868, 4815.879603009953, 4820.590249828733, 4871.14754917888, 4685.695429797052, 4805.687630304019, 4813.422389313235, 4821.228603423506, 4879.0, 4128.710990230655, 4151.27352713274, 4189.392538082022, 4196.832126714959, 4238.978805105955, 3635.4546817976984, 3657.049167216543, 3659.8902032939054, 3706.9073273168387, 3708.2212735325343, 4190.811413486339, 4195.91608167835, 4197.916041679149, 4198.0, 4250.893727656833, 4798.712077275374, 4827.8551643450755, 4902.093112774148, 4911.7544122793715, 4961.231009193581, 4222.113356195172, 4244.639205667491, 4246.957530424718, 4285.400043993844, 4296.484421869396, 4444.1111777643955, 4444.266695995125, 4450.977745111254, 4464.732116072981, 4519.751413672214, 4473.731576105444, 4535.591796738309, 4576.748278844696, 4589.128065667513, 4638.7216766993415, 4923.753812309442, 4929.852104436873, 4930.137225985366, 4962.875928101682, 4976.502349765139, 4589.416651255445, 4590.0, 4590.701604395704, 4636.791344389578, 4646.581807637329, 4746.7389293589185, 4802.807887684454, 4804.8318308859025, 4843.321934929042, 4856.295837103529, 4875.512448755097, 4953.653244272867, 4956.801727930842, 4959.975200123977, 4960.454350021422, 4816.710997340171, 4827.565519103157, 4829.73436460998, 4832.468428472936, 4892.290617860462, 4705.106029854317, 4719.2921061841, 4818.301346304836, 4830.758462076952, 4894.583960363409, 4736.881577960578, 4751.311059896227, 4754.904901902012, 4803.375561177025, 4821.7348045856415, 4850.248211527219, 4855.6601037927, 4859.076775412802, 4861.076395484846, 4916.950830491649, 4587.678862479728, 4641.164590373765, 4646.349511068521, 4704.106219818361, 4731.739754313408], "value": 4519.006582309794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.3089208395967, 583.3961849485783, 584.9385814489476, 590.4390828712724, 590.7400743672782, 28629.141125766233, 39641.20717585646, 40704.79647601762, 40739.59260407395, 44253.0, 40158.99602509939, 40245.39631905524, 40660.0, 40704.185916281654, 40772.0, 7617.923820761777, 7760.495567788104, 7761.922380776176, 7763.456558040939, 7766.456348055638, 7727.381809455258, 7821.139674635786, 7826.608669566527, 7842.137364889858, 7852.685892564291, 7874.173211812763, 7898.0, 7924.564148971805, 7932.365410767154, 7935.127136015034, 7824.72613458529, 7829.647665854994, 7857.0964339101165, 7860.921390786076, 7861.174576669453, 7683.462157648967, 7707.807304817368, 7745.225477452266, 7764.767056988299, 7771.455998080137, 38571.0, 38824.41763373552, 38894.41658375126, 38951.80524097361, 39254.0, 3080.5687203791485, 3082.059971708628, 3142.732867706248, 3471.8437670304897, 3789.0716774390453, 31979.783810134893, 32172.0, 32445.0, 32487.675123248937, 32578.837105814557, 3186.123815950609, 3214.25911674901, 3242.400155971129, 3410.6418826023405, 3418.1967237699123, 271215.0, 272035.0, 272711.0, 273150.999999998, 275129.0, 54968.72515637476, 55636.721816391466, 55658.44341556614, 55772.72113639406, 55802.441975580536, 29191.270218244714, 29552.113436596937, 29590.704092958797, 58937.70531147317, 59021.11468327978, 12167.33079680626, 12321.93839030799, 12322.0, 12322.876771232352, 12326.32205228721, 10813.243072984973, 10887.292325998786, 10901.34591924487, 10906.890931090587, 10981.17641176915, 18098.27606895736, 18315.725264121047, 18326.442252408695, 18331.633367332845, 18340.0, 6809.591424514545, 7025.121859767529, 7110.288971102848, 7126.679299431538, 7135.571865688075, 749.5989645539719, 811.5739236900674, 843.9324854011664, 878.7275944457239, 969.3941286695815, 26887.462250755267, 28526.0, 28980.855095724808, 29131.0, 29150.0, 809.7246936041774, 922.2207234886511, 938.3572253006575, 940.4592359393376, 993.7826162950328, 14151.221682807338, 14727.779083313544, 14960.625984350478, 15207.695846083237, 15244.314005869763, 380853.0, 384958.2785463267, 386304.0, 387023.0, 387468.0, 49710.50289497059, 50148.74925625348, 50322.74838625784, 50335.0, 50377.74811125921, 1086.4513420722485, 1150.5167829511458, 1170.2334970594275, 1199.3943058755274, 1200.2918278215895, 27477.0, 29217.41565168727, 29339.559906600993, 29479.26301842471, 30300.848495758262, 42273.78863105665, 42815.3577696341, 42828.357574637026, 42891.35662965121, 42939.570604293556, 288528.0, 289282.0, 290501.0, 290672.0, 291344.0, 24504.509909802062, 25242.0, 25441.0, 26319.736802631727, 26566.867165664047, 41950.46362250405, 43221.3516797242, 43255.78372108119, 44444.77777611091, 47443.1392151962, 35836.64163358333, 36073.0, 36195.0, 36761.81619091887, 36769.63230367769, 36354.4546831803, 36539.58711546288, 36682.44976325304, 38095.42856857094, 38909.416358754075, 36578.0, 36877.815610921774, 37103.6289637111, 37472.81263593664, 37948.81025594854, 31522.842385787924, 33645.327093457505, 33648.49527257142, 33885.491717623765, 34131.82934085314, 24905.377365566004, 25096.874515627303, 25321.493570128863, 25730.87134564315, 25888.0], "value": 17459.695952651167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.7907255646614, 357.7317012240819, 374.93626083565795, 375.41622776582415, 391.77277179236046, 12843.422046007929, 16983.405580804676, 17345.566360841, 18152.18315175817, 19121.71317430236, 14846.406143754264, 14859.702805943874, 16019.919900400482, 16062.116583587898, 16080.517584472454, 5140.588752899759, 5147.845564633067, 5240.60695447841, 5283.841484755463, 5284.735763211843, 3828.827702753369, 5154.74226288686, 5249.606279529032, 5253.106971814782, 5856.238688970428, 6118.051701986199, 6196.318404975449, 6224.0663900415075, 6224.8132556023165, 6226.501879849601, 5926.199963005004, 6035.668038257894, 6067.302260240041, 6076.0, 6198.2252218472695, 5339.759710813023, 5340.706261155674, 5342.439043900374, 5345.037893179227, 5350.117230656937, 21501.67747483789, 21872.562548749094, 22069.33791986243, 22074.22740204085, 22244.777552224434, 1943.3263002479061, 2026.3313106674761, 2072.922080518122, 2471.1104002559246, 2481.813863960192, 13678.0, 13873.861261387357, 13933.303334833217, 13934.0, 14304.713905721932, 1741.268667159796, 1748.8513476354526, 1781.287485005995, 1822.6901426757483, 1827.232562323827, 45645.77177114126, 62441.37558624447, 62721.37278627201, 70614.64692676504, 70842.0, 8422.494650321001, 8723.65105395777, 9174.495402752913, 9188.0, 9273.814523709489, 12023.458944347525, 12095.27428354284, 12097.092718046182, 12100.458903630337, 12107.0, 6644.136262285871, 6675.23234828001, 6825.69284382194, 6907.34380233877, 6986.44108471321, 6549.8690026200165, 6592.80221593353, 6714.462842972551, 6771.93228067713, 6858.417034552019, 3802.7528210666774, 3826.732128750961, 3828.789416582059, 3895.9805200973815, 3908.2965066288343, 1818.2817786974072, 1866.6266746650454, 1897.0988780329233, 1899.6960486322398, 1915.4062240705425, 685.9828504287433, 828.2545708861952, 847.2374862623565, 873.3144481581928, 928.6517555916531, 16236.594085147966, 16521.752173717403, 17153.914230429018, 17289.308427663003, 18202.0, 833.6082041440513, 837.6607473972929, 845.8392905348087, 848.1518481518482, 863.5854789700978, 9580.56887440053, 10065.748356291006, 10182.18542516597, 10185.185185185168, 10199.643012494675, 391061.0, 393957.0, 400911.0, 407684.0010798577, 412091.0, 82584.0, 85636.0, 86737.69893451603, 87802.56098719465, 87925.56037219772, 900.3877363392955, 925.0610630210342, 941.5151197133482, 944.6268723854176, 945.0, 11597.478113485082, 16101.355945762038, 16515.91742041282, 16756.832431676015, 16871.66256674884, 38269.4259586112, 38417.0, 39467.40798888076, 39701.808945731675, 39845.40231896466, 48731.75634121807, 48922.51077489322, 49592.0, 49626.75186624188, 50048.49951500584, 6741.696623651849, 7519.586422746802, 7686.57723825195, 7860.646270917708, 8166.959165204374, 11148.777024459627, 11586.536538538365, 11794.941025294818, 11840.70398240051, 12509.499620015098, 10227.386356818615, 10302.690919272434, 10321.948390258001, 10391.37651740898, 10487.213458990454, 10509.159267258448, 10524.842127367943, 10587.100096491577, 10750.354978701303, 10822.512986915764, 10124.544395502367, 10193.184545236512, 10326.225533084898, 10401.84397234027, 10850.620228291971, 6882.621455819978, 6909.447244220551, 6954.130733658293, 7095.645217739196, 7369.336759691653, 7686.896210056973, 10265.9486702569, 10325.535350909076, 10443.582256709646, 10464.0], "value": 8286.860185508214, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.0474051572094, 1356.5387768158828, 1382.5990462765799, 1574.5355120239528, 1614.2897125264883, 7016.894746578799, 7527.0, 7528.397728181746, 7531.209223031585, 7534.321911028013, 6197.163382943312, 7007.509474336798, 7189.8562028759525, 7202.423806095513, 7283.308085731847, 2046.5804510075436, 2076.397844625057, 2077.1276064053136, 2078.033714322847, 2079.459340571455, 2019.656658368081, 2032.2074390987527, 2039.775624681284, 2051.1897800368847, 2052.3227334979497, 1820.59036716739, 2012.8490363222743, 2049.5183631846503, 2076.086521930346, 2080.4278823323557, 2067.0, 2090.1952748192057, 2090.9477263068393, 2091.383042002613, 2093.8953052347474, 1996.0, 2016.0826823795285, 2042.2137477071285, 2050.5796311756053, 2055.2395613623057, 7381.815454613624, 7409.666565004588, 7511.361534269594, 7512.5492470451945, 7513.812154696122, 4240.724352917081, 4395.824167033315, 4396.274614688573, 4400.185965596343, 4400.559944005574, 2711.1188863619204, 2778.7915906306907, 2817.3660926291627, 2833.744962953344, 2864.1980245531286, 801.587182600961, 824.2540500846743, 836.6318819719304, 849.613425891218, 850.9531975741331, 9786.461744604045, 9805.509724513746, 9859.950700246452, 9906.157976572073, 9921.156701680293, 3782.4893639358884, 3865.632764887331, 3944.6647035002347, 4036.8990775230855, 4065.2072845794787, 8542.359323050796, 8547.69212312672, 8550.1449855014, 8556.40105192643, 8561.657533698582, 4272.33778764292, 4278.657707383401, 4284.293091639907, 4284.935725964113, 4286.5284818669925, 3932.528096628366, 3936.5079365079364, 3937.724359294822, 3938.940915886264, 3939.8030098495533, 3195.6964088411564, 3265.869365225412, 3283.688049635281, 3286.1784553861535, 3340.1816554944194, 970.7670159161892, 972.2513664478312, 980.5587485631495, 986.033686986757, 994.472929347447, 763.8586861430653, 800.1758189065272, 809.6761295481737, 811.1645005644195, 815.963281652327, 4761.595264402496, 4769.856904292877, 4865.635077369141, 4937.234728616998, 5114.974425127851, 817.5054092274207, 860.6256278518864, 870.4907629036958, 874.6195404998846, 881.6870011146079, 3120.801178791711, 3380.5267262583257, 3392.4741665041465, 3396.4565669492763, 3500.632433594487, 8663.48019118855, 9014.864777028219, 9056.411333263317, 9067.455952642862, 9098.226650734628, 8995.910040899507, 8996.730098097067, 9026.0, 9029.819403611891, 9049.77375565616, 6760.864782704319, 6841.863162736817, 6856.280090590516, 6857.108575885103, 6861.656917154122, 4796.56830885222, 4840.636952228668, 4918.188498897642, 4966.776495057658, 5120.052790233819, 8063.758087257392, 8096.7166149184495, 8108.75673729789, 8165.428420010542, 8218.589070546568, 7985.920140798517, 8018.719344822904, 8052.436329457116, 8378.664853405795, 8460.915390846012, 5989.910151347646, 6047.818565443044, 6049.0, 6068.120122582112, 6071.848203794941, 6818.610281495777, 6944.305569443015, 7007.579545227302, 7033.120859892513, 7047.260037695968, 5029.874253143701, 6215.378462153749, 6223.968880155751, 6248.9062664059165, 6332.493400528039, 6269.937300627118, 6301.40136687014, 6304.464120549621, 6315.684215789101, 6384.329645387167, 5947.167396564571, 5967.76128954837, 6017.187679663364, 6021.578489505868, 6023.969880150571, 4351.499577548622, 4384.890377740455, 4466.910661786681, 4474.306482495218, 4625.491195968373, 4370.322599997005, 4481.619062379734, 4507.940633950953, 4530.524294949115, 4564.406627138451], "value": 3871.335957751984, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.24311439357285, 293.45124616966274, 295.779644165097, 296.05115604487605, 300.4981680593408, 4755.358026666399, 4791.0, 4811.542903424178, 4857.368542089528, 4860.684055536388, 4678.836240731575, 4753.263244197146, 4765.142274390609, 4768.880777980544, 4770.594499467541, 3584.9641503584958, 3683.926321473569, 3692.5015122958325, 3715.461258117571, 3718.4794128821986, 3596.5684117905757, 3758.4926034985338, 3773.6415040571237, 3787.9923640470593, 3815.618438156176, 3704.481372607837, 3717.1636381814146, 3726.795026273554, 3777.471154038437, 3780.9810950945207, 3517.505060349367, 3717.70258379329, 3722.4788529605876, 3730.1047748540427, 3737.9626203737885, 3293.2919422324076, 3302.4055669979393, 3303.0256074458093, 3316.154380632923, 3326.6507016763135, 4556.977215113903, 4560.042391097873, 4582.541745825424, 4593.793279302439, 4609.423822022247, 4259.9574004260185, 4278.272693642089, 4288.206681763883, 4288.356746488021, 4306.870793876189, 4695.765211739399, 4981.252812078181, 4983.7757300921185, 4986.152354099775, 4993.525615066563, 3516.331896939573, 3529.7882127072203, 3553.129483276588, 3553.289342131558, 3574.874879379235, 5191.818286359997, 5217.50433708797, 5220.530152286313, 5269.894602107975, 5289.391719952217, 3555.6977656898935, 3612.205314830733, 3624.3657359961903, 3657.6708096271464, 3659.304732100892, 3629.237860049366, 3631.5279013728045, 3641.927161456756, 3663.5420572428447, 3684.5578530576504, 4157.0, 4173.269677806372, 4175.874723758231, 4205.789710514462, 4207.516135644379, 4952.5542701157065, 4954.157793175097, 4955.72036863047, 4959.925601115986, 4960.156773348539, 1189.5717541684987, 1262.3372729316998, 1265.702559898423, 1266.4486004644236, 1266.9176503527242, 786.9016372953381, 800.5756948817136, 810.7446154461326, 814.5357146426599, 819.2913130142384, 4166.187823219376, 4242.978785106055, 4371.475422949266, 4374.091229332522, 4399.5160532341415, 5102.336696229467, 5108.821191258363, 5110.2590124431745, 5111.361079865017, 5120.564751996122, 4355.673324500675, 4364.323529852878, 4370.956290437119, 4375.978120109443, 4378.9928316487385, 2604.9088281910044, 2665.0, 2682.409869828635, 2698.1770559979004, 2712.742289482496, 4740.217864052462, 4748.548887855648, 4749.3852090289465, 4764.213904705684, 4765.976170119127, 5165.793368265227, 5171.793128274902, 5181.5854731621375, 5194.662346947436, 5222.8955420892125, 4569.9314510282375, 4722.929156062662, 4738.95261047392, 4740.786664600101, 4753.667243292936, 5085.973845561884, 5110.163859058258, 5112.616553758408, 5120.513551212629, 5164.225366195101, 4981.153203955409, 4988.326575912351, 5018.397792264952, 5041.899162016813, 5094.7962081516325, 4479.932801008053, 4790.353302304284, 4820.758962051954, 4829.9034019318715, 4830.95169048305, 3667.853285868642, 3675.1730860556163, 3695.113172838553, 3699.5005674233635, 3733.178700685845, 5182.922256166085, 5204.765785539736, 5205.843824685266, 5214.504622060898, 5245.449227831023, 4924.482929292516, 4937.407511098548, 4974.403071631427, 4983.3023376728015, 5013.573846223112, 4999.725015124058, 5001.299818025406, 5025.6482046256415, 5033.748312584283, 5038.47096054909, 4953.455119936876, 4980.626453016111, 4985.750712464434, 4999.725015124203, 5009.949900500948, 4788.162071637519, 4879.707217566957, 4891.364122664031, 5039.748012599282, 5042.168042272984, 4845.345878306383, 4859.837372369262, 4901.730404827768, 4903.5586797188425, 4904.8773780655765], "value": 3745.496232807296, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.7219095788811, 680.9421199198065, 685.6366125953247, 712.9001939728436, 740.9110906691197, 12734.55429059983, 13514.729705405898, 13521.729565408687, 13581.38883750231, 13738.0, 12147.331896745698, 12164.330961797097, 12171.087168462356, 12172.817407738868, 12192.939035304833, 623.5853157650157, 730.5397599512313, 738.4350971506801, 764.0296823034743, 766.4711349169083, 760.3461023519768, 761.4251240313555, 762.0, 762.3024932187042, 763.0080894836718, 803.1005274093023, 804.2801692485223, 804.9154838741936, 806.2622700229313, 806.4516129032256, 655.397034728049, 675.0144788608637, 679.7654809090856, 680.7651360280695, 793.1354823242665, 571.368637655389, 585.0843430032029, 585.3970410477215, 585.6017907822679, 586.7564960541371, 12862.228266304051, 12880.355982200947, 12894.355282235945, 12896.22622642635, 12902.54841080567, 11961.700957476045, 12272.877271227351, 12488.937555312164, 12892.935535322264, 12905.612831614973, 10831.891681083167, 11306.660800176009, 11457.713557161054, 11546.307221566733, 12160.270383777002, 4053.756774593534, 4078.225137223918, 4094.2220978014084, 4148.481439820022, 4152.0, 52643.736781316235, 55633.1655025179, 62382.37617623811, 62723.0, 62745.0, 10385.273030887765, 10560.155187584975, 10745.83881241782, 10774.892251077388, 10845.51195196218, 20706.792932070486, 21004.0, 21020.684689729667, 21028.684569731467, 21044.47388815292, 6843.965780171166, 7100.396466300319, 7120.71517139319, 7142.285771422816, 7386.741464048732, 3736.4768932349493, 3754.324221640131, 3836.5971572984436, 3845.020403881969, 3881.8253178606465, 2894.4066466374343, 3012.201766531871, 3019.909402717878, 3022.9244268893012, 3023.3046399328277, 494.06868053719, 506.6909185396905, 506.83527853447777, 507.5787096709722, 514.3570536828964, 577.644748479682, 610.664134725899, 611.6483022262217, 619.1115748900343, 621.1304174156218, 7983.800404989922, 8477.263661747083, 8550.78623034429, 8585.742427727178, 8673.132686731276, 498.10000543561455, 590.2916500199777, 593.4955288005161, 596.2755252368394, 599.2988203801563, 3980.940285895656, 4023.1953609277675, 4149.419081328617, 4228.217779710763, 4256.63078873447, 57012.71493642505, 57112.42887571071, 57124.71437642868, 57345.13982290269, 58086.4191358081, 74761.62619186979, 86981.56509217413, 87320.0, 87386.56306718553, 89605.0, 45209.999999999345, 60011.69994150001, 66808.66595667088, 71329.0, 81124.0, 7459.365953893763, 8286.212809783061, 8392.580370981548, 8420.284275836622, 8478.660853566034, 34690.30619387649, 37962.0, 40662.883995301294, 44067.55932440634, 44307.55692443034, 35270.47094293536, 36093.63906361008, 48487.51512484971, 56793.0, 58802.705986469795, 9295.163435290857, 9753.707388778348, 10416.21878359111, 10621.309614875008, 10959.06847917936, 10684.145268378355, 10741.087007604128, 10764.784704306026, 11264.15518836107, 11266.718332041764, 10149.087417857458, 10312.0, 10316.742081448025, 10608.0, 10817.675469735921, 9623.278254131108, 9963.402195868272, 10155.796884062129, 11081.72295692582, 11221.60724374643, 11290.887091128983, 11845.23006004607, 11884.76230475403, 12257.32584707814, 12507.27369483814, 10970.341779493256, 11088.501017454395, 11143.275687080313, 11148.0, 11352.943235284101, 10127.24045696561, 10231.846522302023, 10322.48387580633, 10322.535485903003, 10593.0], "value": 6363.795246561616, "unit": "score"}], "name": "dromaeo_css", "value": 6262.796405593413, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 129.0, 118.0, 117.0, 116.0, 115.0, 116.0, 114.0, 114.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 122.0, 147.0, 181.0, 122.0, 144.0, 144.0, 126.0, 192.0, 123.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 75.0, 165.0, 77.0, 78.0, 87.0, 78.0, 168.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 150.0, 88.0, 87.0, 89.0, 144.0, 87.0, 87.0, 141.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 73.0, 65.0], "value": 66.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 86.0, 83.0, 84.0, 81.0, 91.0, 88.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 144.0, 132.0, 153.0, 142.0, 138.0, 135.0, 136.0, 150.0, 130.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 176.0, 171.0, 172.0, 174.0, 170.0, 172.0, 168.0, 171.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 68.0, 78.0, 68.0, 69.0, 67.0, 68.0, 67.0, 67.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1581.5, "alertThreshold": 2.0}]} 08:32:18 INFO - Return code: 0 08:32:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:18 INFO - # TBPL SUCCESS # 08:32:18 INFO - Running post-action listener: _resource_record_post_action 08:32:18 INFO - [mozharness: 2016-08-24 15:32:18.494372Z] Finished run-tests step (success) 08:32:18 INFO - Running post-run listener: _resource_record_post_run 08:32:18 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 16384; Write bytes: 422780928; Read time: 272; Write time: 285772 08:32:18 INFO - TinderboxPrint: CPU usage
13.0% 08:32:18 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 272 08:32:18 INFO - TinderboxPrint: I/O write bytes / time
422,780,928 / 285,772 08:32:18 INFO - TinderboxPrint: CPU idle
8,335.3 (87.0%) 08:32:18 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 08:32:18 INFO - TinderboxPrint: Swap in / out
0 / 0 08:32:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114364416; Read time: 0; Write time: 114420 08:32:18 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 12288; Write bytes: 291721216; Read time: 256; Write time: 167268 08:32:19 INFO - Running post-run listener: _upload_blobber_files 08:32:19 INFO - Blob upload gear active. 08:32:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:19 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 08:32:19 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:32:19 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:32:19 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:32:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:32:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:20 INFO - (blobuploader) - INFO - Done attempting. 08:32:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:32:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:32:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:22 INFO - (blobuploader) - INFO - Done attempting. 08:32:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:25 INFO - (blobuploader) - INFO - Done attempting. 08:32:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:32:25 INFO - Return code: 0 08:32:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:32:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:32:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02f208ea5cb0f69d9bb547a960efa5db491468830188b1651c7e3660fe08df899ad390748912e27805cba90effd8fb0948a8f3fe9531982aa97a9f8cae6839e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/501d85d07aa29de4366c578b85cb0f40fc05d80b6d673bba7de035c83a92500a2535623c9461d0dc21235c61893685e38f05da7c07f80b07080ff213f28bb794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765722abaab08e2277e7943eefbfd1c0a97ac90c83d0cfaed05096212f877eaf30c50a82b9e96273ac7f14fff84f8e0025d76adfb52c202049b92432cc3fa6bd"} 08:32:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:32:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:32:25 INFO - Contents: 08:32:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02f208ea5cb0f69d9bb547a960efa5db491468830188b1651c7e3660fe08df899ad390748912e27805cba90effd8fb0948a8f3fe9531982aa97a9f8cae6839e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/501d85d07aa29de4366c578b85cb0f40fc05d80b6d673bba7de035c83a92500a2535623c9461d0dc21235c61893685e38f05da7c07f80b07080ff213f28bb794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765722abaab08e2277e7943eefbfd1c0a97ac90c83d0cfaed05096212f877eaf30c50a82b9e96273ac7f14fff84f8e0025d76adfb52c202049b92432cc3fa6bd"} 08:32:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:32:25 INFO - Copying logs to upload dir... 08:32:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:32:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.350211 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-24 08:32:24.859775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:32:24.863662) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02f208ea5cb0f69d9bb547a960efa5db491468830188b1651c7e3660fe08df899ad390748912e27805cba90effd8fb0948a8f3fe9531982aa97a9f8cae6839e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/501d85d07aa29de4366c578b85cb0f40fc05d80b6d673bba7de035c83a92500a2535623c9461d0dc21235c61893685e38f05da7c07f80b07080ff213f28bb794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765722abaab08e2277e7943eefbfd1c0a97ac90c83d0cfaed05096212f877eaf30c50a82b9e96273ac7f14fff84f8e0025d76adfb52c202049b92432cc3fa6bd"} build_url:https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011451 build_url: 'https://queue.taskcluster.net/v1/task/BMtqdMTySoGAf3F0nlW3zQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/02f208ea5cb0f69d9bb547a960efa5db491468830188b1651c7e3660fe08df899ad390748912e27805cba90effd8fb0948a8f3fe9531982aa97a9f8cae6839e3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/501d85d07aa29de4366c578b85cb0f40fc05d80b6d673bba7de035c83a92500a2535623c9461d0dc21235c61893685e38f05da7c07f80b07080ff213f28bb794", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/765722abaab08e2277e7943eefbfd1c0a97ac90c83d0cfaed05096212f877eaf30c50a82b9e96273ac7f14fff84f8e0025d76adfb52c202049b92432cc3fa6bd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 08:32:24.889876) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:32:24.890233) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1472051307.644629-633296588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 08:32:24.974278) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:32:24.974621) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 08:32:24.974915) ========= ========= Total master_lag: 0.18 =========