builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1476481815.04 results: success (0) buildid: 20161014115635 builduid: 327d3a806b87429d948d4c212bba1809 revision: 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.035989) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.036483) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.036779) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.051546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.051853) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 14:50:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.7M=0s 2016-10-14 14:50:15 (88.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.123830 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.189165) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.189456) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017472 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:15.239311) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 14:50:15.239638) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 --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=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 14:50:15,779 truncating revision to first 12 chars 2016-10-14 14:50:15,779 Setting DEBUG logging. 2016-10-14 14:50:15,779 attempt 1/10 2016-10-14 14:50:15,779 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7bc185ff4e8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 14:50:16,807 unpacking tar archive at: mozilla-aurora-7bc185ff4e8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.385527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 14:50:16.638531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:16.638859) ========= script_repo_revision: 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:16.639285) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:16.639561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 14:50:16.650184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-14 14:50:16.650584) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:50:17 INFO - MultiFileLogger online at 20161014 14:50:17 in /builds/slave/test 14:50:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:50:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:50:17 INFO - {'append_to_log': False, 14:50:17 INFO - 'base_work_dir': '/builds/slave/test', 14:50:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:50:17 INFO - 'branch': 'Mozilla-Aurora', 14:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 14:50:17 INFO - 'config_files': ('talos/linux_config.py',), 14:50:17 INFO - 'default_actions': ('clobber', 14:50:17 INFO - 'read-buildbot-config', 14:50:17 INFO - 'download-and-extract', 14:50:17 INFO - 'populate-webroot', 14:50:17 INFO - 'create-virtualenv', 14:50:17 INFO - 'install', 14:50:17 INFO - 'run-tests'), 14:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:50:17 INFO - 'download_minidump_stackwalk': True, 14:50:17 INFO - 'download_symbols': 'ondemand', 14:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 14:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 14:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:50:17 INFO - 'installer_path': 'installer.exe', 14:50:17 INFO - 'log_level': 'info', 14:50:17 INFO - 'log_name': 'talos', 14:50:17 INFO - 'log_to_console': True, 14:50:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:50:17 INFO - 'opt_config_files': (), 14:50:17 INFO - 'pip_index': False, 14:50:17 INFO - 'sps_profile': False, 14:50:17 INFO - 'sps_profile_interval': 0, 14:50:17 INFO - 'suite': 'dromaeojs', 14:50:17 INFO - 'system_bits': '32', 14:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:50:17 INFO - 'title': 'talos-linux64-ix-064', 14:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:50:17 INFO - 'use_talos_json': True, 14:50:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:50:17 INFO - 'work_dir': 'build'} 14:50:17 INFO - [mozharness: 2016-10-14 21:50:17.292573Z] Running clobber step. 14:50:17 INFO - Running pre-action listener: _resource_record_pre_action 14:50:17 INFO - Running main action method: clobber 14:50:17 INFO - rmtree: /builds/slave/test/build 14:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:50:17 INFO - Running post-action listener: _resource_record_post_action 14:50:17 INFO - [mozharness: 2016-10-14 21:50:17.748757Z] Finished clobber step (success) 14:50:17 INFO - [mozharness: 2016-10-14 21:50:17.748858Z] Running read-buildbot-config step. 14:50:17 INFO - Running pre-action listener: _resource_record_pre_action 14:50:17 INFO - Running main action method: read_buildbot_config 14:50:17 INFO - Using buildbot properties: 14:50:17 INFO - { 14:50:17 INFO - "project": "", 14:50:17 INFO - "product": "firefox", 14:50:17 INFO - "script_repo_revision": "production", 14:50:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 14:50:17 INFO - "repository": "", 14:50:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 14:50:17 INFO - "buildid": "20161014115635", 14:50:17 INFO - "pgo_build": "True", 14:50:17 INFO - "basedir": "/builds/slave/test", 14:50:17 INFO - "buildnumber": 576, 14:50:17 INFO - "slavename": "talos-linux64-ix-064", 14:50:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:50:17 INFO - "platform": "ubuntu64_hw", 14:50:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:50:17 INFO - "branch": "mozilla-aurora", 14:50:17 INFO - "repo_path": "releases/mozilla-aurora", 14:50:17 INFO - "revision": "7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8", 14:50:17 INFO - "stage_platform": "linux64-pgo", 14:50:17 INFO - "builduid": "327d3a806b87429d948d4c212bba1809", 14:50:17 INFO - "slavebuilddir": "test" 14:50:17 INFO - } 14:50:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2. 14:50:17 INFO - Running post-action listener: _resource_record_post_action 14:50:17 INFO - [mozharness: 2016-10-14 21:50:17.751372Z] Finished read-buildbot-config step (success) 14:50:17 INFO - [mozharness: 2016-10-14 21:50:17.751462Z] Running download-and-extract step. 14:50:17 INFO - Running pre-action listener: _resource_record_pre_action 14:50:17 INFO - Running main action method: download_and_extract 14:50:17 INFO - mkdir: /builds/slave/test/build/tests 14:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:17 INFO - trying https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:50:17 INFO - Downloading https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:50:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:50:18 INFO - Downloaded 1361 bytes. 14:50:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.test_packages.json 14:50:18 INFO - Using the following test package requirements: 14:50:18 INFO - {u'common': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:50:18 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:50:18 INFO - u'gtest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:50:18 INFO - u'jittest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'jsshell-linux-x86_64.zip'], 14:50:18 INFO - u'mochitest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:50:18 INFO - u'mozbase': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'], 14:50:18 INFO - u'reftest': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:50:18 INFO - u'talos': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:50:18 INFO - u'web-platform': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:50:18 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', 14:50:18 INFO - u'firefox-51.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:50:18 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:50:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:50:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:18 INFO - Fetch https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:50:18 INFO - Expected file size: 21906986 14:50:23 INFO - Downloading packages: [u'firefox-51.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:50:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip 14:50:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:50:23 INFO - Fetch https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.common.tests.zip into memory 14:50:23 INFO - Expected file size: 21906986 14:50:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip 14:50:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:50:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.talos.tests.zip into memory 14:50:29 INFO - Expected file size: 14414081 14:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:29 INFO - trying https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:50:29 INFO - Downloading https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:50:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:50:30 INFO - Downloaded 63985969 bytes. 14:50:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:50:30 INFO - mkdir: /builds/slave/test/properties 14:50:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:50:30 INFO - Writing to file /builds/slave/test/properties/build_url 14:50:30 INFO - Contents: 14:50:30 INFO - build_url:https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 14:50:31 INFO - Running post-action listener: _resource_record_post_action 14:50:31 INFO - Running post-action listener: set_extra_try_arguments 14:50:31 INFO - [mozharness: 2016-10-14 21:50:31.402782Z] Finished download-and-extract step (success) 14:50:31 INFO - [mozharness: 2016-10-14 21:50:31.403050Z] Running populate-webroot step. 14:50:31 INFO - Running pre-action listener: _resource_record_pre_action 14:50:31 INFO - Running main action method: populate_webroot 14:50:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:50:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:50:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:50:31 INFO - '--tppagecycles', 14:50:31 INFO - '7'], 14:50:31 INFO - 'tests': ['tsvgm']}}, 14:50:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:50:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:50:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:50:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:50:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:50:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['damp', 'tps']}, 14:50:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'tests': ['damp', 'tps']}, 14:50:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['dromaeo_dom']}, 14:50:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:50:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['basic_compositor_video']}, 14:50:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:50:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['a11yr', 14:50:31 INFO - 'ts_paint', 14:50:31 INFO - 'tpaint', 14:50:31 INFO - 'sessionrestore', 14:50:31 INFO - 'sessionrestore_no_auto_restore', 14:50:31 INFO - 'tabpaint']}, 14:50:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['tsvgx', 14:50:31 INFO - 'tsvgr_opacity', 14:50:31 INFO - 'tart', 14:50:31 INFO - 'tscrollx', 14:50:31 INFO - 'cart']}, 14:50:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:50:31 INFO - 'tsvgr_opacity', 14:50:31 INFO - 'tart', 14:50:31 INFO - 'tscrollx', 14:50:31 INFO - 'cart']}, 14:50:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'talos_options': ['--disable-e10s'], 14:50:31 INFO - 'tests': ['tp5o']}, 14:50:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'tests': ['tp5o']}, 14:50:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'talos_options': ['--disable-e10s', 14:50:31 INFO - '--xperf_path', 14:50:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:31 INFO - 'tests': ['tp5n']}, 14:50:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:50:31 INFO - 'talos_options': ['--xperf_path', 14:50:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:50:31 INFO - 'tests': ['tp5n']}}, 14:50:31 INFO - 'talos.zip': {'path': '', 14:50:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:50:31 INFO - Running post-action listener: _resource_record_post_action 14:50:31 INFO - [mozharness: 2016-10-14 21:50:31.423985Z] Finished populate-webroot step (success) 14:50:31 INFO - [mozharness: 2016-10-14 21:50:31.424074Z] Running create-virtualenv step. 14:50:31 INFO - Running pre-action listener: _resource_record_pre_action 14:50:31 INFO - Running main action method: create_virtualenv 14:50:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:50:31 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:50:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:50:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:50:31 INFO - Using real prefix '/usr' 14:50:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:50:32 INFO - Installing distribute.............................................................................................................................................................................................done. 14:50:33 INFO - Installing pip.................done. 14:50:34 INFO - Return code: 0 14:50:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:34 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:50:34 INFO - Using env: {'DISPLAY': ':0', 14:50:34 INFO - 'HOME': '/home/cltbld', 14:50:34 INFO - 'LANG': 'en_US.UTF-8', 14:50:34 INFO - 'LANGUAGE': 'en_US:en', 14:50:34 INFO - 'LOGNAME': 'cltbld', 14:50:34 INFO - 'MAIL': '/var/mail/cltbld', 14:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:34 INFO - 'MOZ_NO_REMOTE': '1', 14:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:34 INFO - 'NO_EM_RESTART': '1', 14:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:34 INFO - 'PWD': '/builds/slave/test', 14:50:34 INFO - 'SHELL': '/bin/bash', 14:50:34 INFO - 'SHLVL': '1', 14:50:34 INFO - 'TERM': 'linux', 14:50:34 INFO - 'TMOUT': '86400', 14:50:34 INFO - 'USER': 'cltbld', 14:50:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:34 INFO - '_': '/tools/buildbot/bin/python'} 14:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:50:34 INFO - Cleaning up... 14:50:34 INFO - Return code: 0 14:50:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:34 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:50:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:50:34 INFO - Using env: {'DISPLAY': ':0', 14:50:34 INFO - 'HOME': '/home/cltbld', 14:50:34 INFO - 'LANG': 'en_US.UTF-8', 14:50:34 INFO - 'LANGUAGE': 'en_US:en', 14:50:34 INFO - 'LOGNAME': 'cltbld', 14:50:34 INFO - 'MAIL': '/var/mail/cltbld', 14:50:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:34 INFO - 'MOZ_NO_REMOTE': '1', 14:50:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:34 INFO - 'NO_EM_RESTART': '1', 14:50:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:34 INFO - 'PWD': '/builds/slave/test', 14:50:34 INFO - 'SHELL': '/bin/bash', 14:50:34 INFO - 'SHLVL': '1', 14:50:34 INFO - 'TERM': 'linux', 14:50:34 INFO - 'TMOUT': '86400', 14:50:34 INFO - 'USER': 'cltbld', 14:50:34 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:34 INFO - '_': '/tools/buildbot/bin/python'} 14:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:34 INFO - Downloading/unpacking psutil>=3.1.1 14:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:50:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:36 INFO - Installing collected packages: psutil 14:50:36 INFO - Running setup.py install for psutil 14:50:36 INFO - building 'psutil._psutil_linux' extension 14:50:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:50:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:50:36 INFO - building 'psutil._psutil_posix' extension 14:50:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:50:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:50:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:50:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:50:36 INFO - Successfully installed psutil 14:50:36 INFO - Cleaning up... 14:50:37 INFO - Return code: 0 14:50:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:37 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:50:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:50:37 INFO - Using env: {'DISPLAY': ':0', 14:50:37 INFO - 'HOME': '/home/cltbld', 14:50:37 INFO - 'LANG': 'en_US.UTF-8', 14:50:37 INFO - 'LANGUAGE': 'en_US:en', 14:50:37 INFO - 'LOGNAME': 'cltbld', 14:50:37 INFO - 'MAIL': '/var/mail/cltbld', 14:50:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:37 INFO - 'MOZ_NO_REMOTE': '1', 14:50:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:37 INFO - 'NO_EM_RESTART': '1', 14:50:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:37 INFO - 'PWD': '/builds/slave/test', 14:50:37 INFO - 'SHELL': '/bin/bash', 14:50:37 INFO - 'SHLVL': '1', 14:50:37 INFO - 'TERM': 'linux', 14:50:37 INFO - 'TMOUT': '86400', 14:50:37 INFO - 'USER': 'cltbld', 14:50:37 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:37 INFO - '_': '/tools/buildbot/bin/python'} 14:50:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:50:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:50:39 INFO - Installing collected packages: mozsystemmonitor 14:50:39 INFO - Running setup.py install for mozsystemmonitor 14:50:39 INFO - Successfully installed mozsystemmonitor 14:50:39 INFO - Cleaning up... 14:50:39 INFO - Return code: 0 14:50:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:50: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')]} 14:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50: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')]} 14:50:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:39 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:50:39 INFO - Using env: {'DISPLAY': ':0', 14:50:39 INFO - 'HOME': '/home/cltbld', 14:50:39 INFO - 'LANG': 'en_US.UTF-8', 14:50:39 INFO - 'LANGUAGE': 'en_US:en', 14:50:39 INFO - 'LOGNAME': 'cltbld', 14:50:39 INFO - 'MAIL': '/var/mail/cltbld', 14:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:39 INFO - 'MOZ_NO_REMOTE': '1', 14:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:39 INFO - 'NO_EM_RESTART': '1', 14:50:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:39 INFO - 'PWD': '/builds/slave/test', 14:50:39 INFO - 'SHELL': '/bin/bash', 14:50:39 INFO - 'SHLVL': '1', 14:50:39 INFO - 'TERM': 'linux', 14:50:39 INFO - 'TMOUT': '86400', 14:50:39 INFO - 'USER': 'cltbld', 14:50:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:39 INFO - '_': '/tools/buildbot/bin/python'} 14:50:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:50:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:50:41 INFO - warning: no files found matching '*.txt' 14:50:41 INFO - no previously-included directories found matching 'build' 14:50:41 INFO - no previously-included directories found matching 'dist' 14:50:41 INFO - no previously-included directories found matching '.git*' 14:50:41 INFO - Installing collected packages: jsonschema, functools32 14:50:41 INFO - Running setup.py install for functools32 14:50:41 INFO - warning: no files found matching '*.txt' 14:50:41 INFO - no previously-included directories found matching 'build' 14:50:41 INFO - no previously-included directories found matching 'dist' 14:50:41 INFO - no previously-included directories found matching '.git*' 14:50:41 INFO - Successfully installed jsonschema functools32 14:50:41 INFO - Cleaning up... 14:50:41 INFO - Return code: 0 14:50:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:50:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:50:41 INFO - Using env: {'DISPLAY': ':0', 14:50:41 INFO - 'HOME': '/home/cltbld', 14:50:41 INFO - 'LANG': 'en_US.UTF-8', 14:50:41 INFO - 'LANGUAGE': 'en_US:en', 14:50:41 INFO - 'LOGNAME': 'cltbld', 14:50:41 INFO - 'MAIL': '/var/mail/cltbld', 14:50:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:41 INFO - 'MOZ_NO_REMOTE': '1', 14:50:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:41 INFO - 'NO_EM_RESTART': '1', 14:50:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:41 INFO - 'PWD': '/builds/slave/test', 14:50:41 INFO - 'SHELL': '/bin/bash', 14:50:41 INFO - 'SHLVL': '1', 14:50:41 INFO - 'TERM': 'linux', 14:50:41 INFO - 'TMOUT': '86400', 14:50:41 INFO - 'USER': 'cltbld', 14:50:41 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:41 INFO - '_': '/tools/buildbot/bin/python'} 14:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:50:42 INFO - Cleaning up... 14:50:42 INFO - Return code: 0 14:50:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:42 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:50:42 INFO - Using env: {'DISPLAY': ':0', 14:50:42 INFO - 'HOME': '/home/cltbld', 14:50:42 INFO - 'LANG': 'en_US.UTF-8', 14:50:42 INFO - 'LANGUAGE': 'en_US:en', 14:50:42 INFO - 'LOGNAME': 'cltbld', 14:50:42 INFO - 'MAIL': '/var/mail/cltbld', 14:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:42 INFO - 'MOZ_NO_REMOTE': '1', 14:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:42 INFO - 'NO_EM_RESTART': '1', 14:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:42 INFO - 'PWD': '/builds/slave/test', 14:50:42 INFO - 'SHELL': '/bin/bash', 14:50:42 INFO - 'SHLVL': '1', 14:50:42 INFO - 'TERM': 'linux', 14:50:42 INFO - 'TMOUT': '86400', 14:50:42 INFO - 'USER': 'cltbld', 14:50:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:42 INFO - '_': '/tools/buildbot/bin/python'} 14:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:50:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:50:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:45 INFO - Downloading docopt-0.6.1.tar.gz 14:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:50:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:50:45 INFO - Running setup.py install for blobuploader 14:50:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:50:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:50:45 INFO - Running setup.py install for requests 14:50:45 INFO - Running setup.py install for docopt 14:50:45 INFO - Successfully installed blobuploader requests docopt 14:50:45 INFO - Cleaning up... 14:50:45 INFO - Return code: 0 14:50:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50: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')]} 14:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50: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')]} 14:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:45 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:50:45 INFO - Using env: {'DISPLAY': ':0', 14:50:45 INFO - 'HOME': '/home/cltbld', 14:50:45 INFO - 'LANG': 'en_US.UTF-8', 14:50:45 INFO - 'LANGUAGE': 'en_US:en', 14:50:45 INFO - 'LOGNAME': 'cltbld', 14:50:45 INFO - 'MAIL': '/var/mail/cltbld', 14:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:45 INFO - 'MOZ_NO_REMOTE': '1', 14:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:45 INFO - 'NO_EM_RESTART': '1', 14:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:45 INFO - 'PWD': '/builds/slave/test', 14:50:45 INFO - 'SHELL': '/bin/bash', 14:50:45 INFO - 'SHLVL': '1', 14:50:45 INFO - 'TERM': 'linux', 14:50:45 INFO - 'TMOUT': '86400', 14:50:45 INFO - 'USER': 'cltbld', 14:50:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:45 INFO - '_': '/tools/buildbot/bin/python'} 14:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:45 INFO - Running setup.py (path:/tmp/pip-ijJnIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:46 INFO - Running setup.py (path:/tmp/pip-1KLLrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:46 INFO - Running setup.py (path:/tmp/pip-8AjU1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:46 INFO - Running setup.py (path:/tmp/pip-SsrBMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:46 INFO - Running setup.py (path:/tmp/pip-AtDrc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:46 INFO - Running setup.py (path:/tmp/pip-N3e6_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:50:46 INFO - Running setup.py (path:/tmp/pip-6yryPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:50:46 INFO - Running setup.py (path:/tmp/pip-j4IEls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:50:46 INFO - Running setup.py (path:/tmp/pip-zaO3JK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:50:46 INFO - Running setup.py (path:/tmp/pip-h3Sx62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:50:46 INFO - Running setup.py (path:/tmp/pip-F6eWxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:50:46 INFO - Running setup.py (path:/tmp/pip-7epU9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:50:46 INFO - Running setup.py (path:/tmp/pip-ulWytZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:50:46 INFO - Running setup.py (path:/tmp/pip-6DLc7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:50:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:46 INFO - Running setup.py (path:/tmp/pip-RBHUh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:50:47 INFO - Running setup.py (path:/tmp/pip-Y5dTPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:50:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:50:47 INFO - Running setup.py (path:/tmp/pip-W_b00b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:50:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:50:47 INFO - Running setup.py install for manifestparser 14:50:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Running setup.py install for mozcrash 14:50:47 INFO - Running setup.py install for mozdebug 14:50:47 INFO - Running setup.py install for mozdevice 14:50:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Running setup.py install for mozfile 14:50:47 INFO - Running setup.py install for mozhttpd 14:50:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Running setup.py install for mozinfo 14:50:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Running setup.py install for mozInstall 14:50:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:50:47 INFO - Running setup.py install for mozleak 14:50:48 INFO - Running setup.py install for mozlog 14:50:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Running setup.py install for moznetwork 14:50:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Running setup.py install for mozprocess 14:50:48 INFO - Running setup.py install for mozprofile 14:50:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Running setup.py install for mozrunner 14:50:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Running setup.py install for mozscreenshot 14:50:48 INFO - Running setup.py install for moztest 14:50:48 INFO - Running setup.py install for mozversion 14:50:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:50:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:50:48 INFO - Cleaning up... 14:50:48 INFO - Return code: 0 14:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:48 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:50:48 INFO - Using env: {'DISPLAY': ':0', 14:50:48 INFO - 'HOME': '/home/cltbld', 14:50:48 INFO - 'LANG': 'en_US.UTF-8', 14:50:48 INFO - 'LANGUAGE': 'en_US:en', 14:50:48 INFO - 'LOGNAME': 'cltbld', 14:50:48 INFO - 'MAIL': '/var/mail/cltbld', 14:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:48 INFO - 'MOZ_NO_REMOTE': '1', 14:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:48 INFO - 'NO_EM_RESTART': '1', 14:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:48 INFO - 'PWD': '/builds/slave/test', 14:50:48 INFO - 'SHELL': '/bin/bash', 14:50:48 INFO - 'SHLVL': '1', 14:50:48 INFO - 'TERM': 'linux', 14:50:48 INFO - 'TMOUT': '86400', 14:50:48 INFO - 'USER': 'cltbld', 14:50:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:48 INFO - '_': '/tools/buildbot/bin/python'} 14:50:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:50:49 INFO - Running setup.py (path:/tmp/pip-3GuX_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:50:49 INFO - Running setup.py (path:/tmp/pip-MfLZHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:50:49 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)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:50:49 INFO - Running setup.py (path:/tmp/pip-1H7Gr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:50:49 INFO - Running setup.py (path:/tmp/pip-Mdijn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:50:49 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)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:50:49 INFO - Running setup.py (path:/tmp/pip-BesTiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:50:49 INFO - Running setup.py (path:/tmp/pip-uePFwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:50:49 INFO - Running setup.py (path:/tmp/pip-4pLC9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:50:49 INFO - Running setup.py (path:/tmp/pip-eSmN2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:50:49 INFO - Running setup.py (path:/tmp/pip-R2ovRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:50:49 INFO - Running setup.py (path:/tmp/pip-hzCMSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:50:49 INFO - Running setup.py (path:/tmp/pip-O42W_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:50:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:50:50 INFO - Running setup.py (path:/tmp/pip-Jmh9Ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:50:50 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)) 14:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:50:50 INFO - Running setup.py (path:/tmp/pip-vWz5N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:50:50 INFO - Running setup.py (path:/tmp/pip-sYsIdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:50:50 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)) 14:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:50 INFO - Running setup.py (path:/tmp/pip-5yUxoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:50:50 INFO - Running setup.py (path:/tmp/pip-oldX7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:50:50 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)) 14:50:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:50:50 INFO - Running setup.py (path:/tmp/pip-1pjoKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:50:50 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)) 14:50:50 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)) 14:50:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:50:50 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)) 14:50:50 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)) 14:50:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:50:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:50:52 INFO - Downloading blessings-1.6.tar.gz 14:50:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:50:52 INFO - Installing collected packages: blessings 14:50:52 INFO - Running setup.py install for blessings 14:50:52 INFO - Successfully installed blessings 14:50:52 INFO - Cleaning up... 14:50:52 INFO - Return code: 0 14:50:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:50:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:50:52 INFO - Reading from file tmpfile_stdout 14:50:52 INFO - Current package versions: 14:50:52 INFO - argparse == 1.2.1 14:50:52 INFO - blessings == 1.6 14:50:52 INFO - blobuploader == 1.2.4 14:50:52 INFO - docopt == 0.6.1 14:50:52 INFO - functools32 == 3.2.3-2 14:50:52 INFO - jsonschema == 2.5.1 14:50:52 INFO - manifestparser == 1.1 14:50:52 INFO - mozInstall == 1.12 14:50:52 INFO - mozcrash == 0.17 14:50:52 INFO - mozdebug == 0.1 14:50:52 INFO - mozdevice == 0.48 14:50:52 INFO - mozfile == 1.2 14:50:52 INFO - mozhttpd == 0.7 14:50:52 INFO - mozinfo == 0.9 14:50:52 INFO - mozleak == 0.1 14:50:52 INFO - mozlog == 3.4 14:50:52 INFO - moznetwork == 0.27 14:50:52 INFO - mozprocess == 0.23 14:50:52 INFO - mozprofile == 0.28 14:50:52 INFO - mozrunner == 6.12 14:50:52 INFO - mozscreenshot == 0.1 14:50:52 INFO - mozsystemmonitor == 0.3 14:50:52 INFO - moztest == 0.7 14:50:52 INFO - mozversion == 1.4 14:50:52 INFO - psutil == 3.1.1 14:50:52 INFO - requests == 1.2.3 14:50:52 INFO - wsgiref == 0.1.2 14:50:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:50: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')]} 14:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50: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')]} 14:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:52 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:50:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:50:52 INFO - Using env: {'DISPLAY': ':0', 14:50:52 INFO - 'HOME': '/home/cltbld', 14:50:52 INFO - 'LANG': 'en_US.UTF-8', 14:50:52 INFO - 'LANGUAGE': 'en_US:en', 14:50:52 INFO - 'LOGNAME': 'cltbld', 14:50:52 INFO - 'MAIL': '/var/mail/cltbld', 14:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:52 INFO - 'MOZ_NO_REMOTE': '1', 14:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:52 INFO - 'NO_EM_RESTART': '1', 14:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:52 INFO - 'PWD': '/builds/slave/test', 14:50:52 INFO - 'SHELL': '/bin/bash', 14:50:52 INFO - 'SHLVL': '1', 14:50:52 INFO - 'TERM': 'linux', 14:50:52 INFO - 'TMOUT': '86400', 14:50:52 INFO - 'USER': 'cltbld', 14:50:52 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:52 INFO - '_': '/tools/buildbot/bin/python'} 14:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:50:53 INFO - Cleaning up... 14:50:53 INFO - Return code: 0 14:50:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:50:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:50:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:50:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:50:53 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 0x7fa5b5546f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21208a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21edca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:50:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:50:53 INFO - Using env: {'DISPLAY': ':0', 14:50:53 INFO - 'HOME': '/home/cltbld', 14:50:53 INFO - 'LANG': 'en_US.UTF-8', 14:50:53 INFO - 'LANGUAGE': 'en_US:en', 14:50:53 INFO - 'LOGNAME': 'cltbld', 14:50:53 INFO - 'MAIL': '/var/mail/cltbld', 14:50:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:50:53 INFO - 'MOZ_NO_REMOTE': '1', 14:50:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:50:53 INFO - 'NO_EM_RESTART': '1', 14:50:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:50:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:50:53 INFO - 'PWD': '/builds/slave/test', 14:50:53 INFO - 'SHELL': '/bin/bash', 14:50:53 INFO - 'SHLVL': '1', 14:50:53 INFO - 'TERM': 'linux', 14:50:53 INFO - 'TMOUT': '86400', 14:50:53 INFO - 'USER': 'cltbld', 14:50:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:50:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:50:53 INFO - '_': '/tools/buildbot/bin/python'} 14:50:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:50:53 INFO - Cleaning up... 14:50:53 INFO - Return code: 0 14:50:53 INFO - Running post-action listener: _resource_record_post_action 14:50:53 INFO - Running post-action listener: _start_resource_monitoring 14:50:53 INFO - Starting resource monitoring. 14:50:53 INFO - [mozharness: 2016-10-14 21:50:53.293277Z] Finished create-virtualenv step (success) 14:50:53 INFO - [mozharness: 2016-10-14 21:50:53.293777Z] Running install step. 14:50:53 INFO - Running pre-action listener: _resource_record_pre_action 14:50:53 INFO - Running main action method: install 14:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:50:53 INFO - Reading from file tmpfile_stdout 14:50:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:50:53 INFO - Reading from file tmpfile_stdout 14:50:53 INFO - Output received: 14:50:53 INFO - Usage: mozinstall [options] installer 14:50:53 INFO - Options: 14:50:53 INFO - -h, --help show this help message and exit 14:50:53 INFO - -d DEST, --destination=DEST 14:50:53 INFO - Directory to install application into. [default: 14:50:53 INFO - "/builds/slave/test"] 14:50:53 INFO - --app=APP Application being installed. [default: firefox] 14:50:53 INFO - mkdir: /builds/slave/test/build/application 14:50:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:50:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:51:09 INFO - Reading from file tmpfile_stdout 14:51:09 INFO - Output received: 14:51:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:51:09 INFO - Running post-action listener: _resource_record_post_action 14:51:09 INFO - [mozharness: 2016-10-14 21:51:09.554587Z] Finished install step (success) 14:51:09 INFO - [mozharness: 2016-10-14 21:51:09.554833Z] Running run-tests step. 14:51:09 INFO - Running pre-action listener: _resource_record_pre_action 14:51:09 INFO - Running main action method: run_tests 14:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:51:09 INFO - Python 2.7.3 14:51:09 INFO - Return code: 0 14:51:09 INFO - grabbing minidump binary from tooltool 14:51: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')]} 14:51:09 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 0x21eaf60>, '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 0x21ebd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ec1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:51:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:51:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:51:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:51:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:51:09 INFO - Return code: 0 14:51:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:51:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:51:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:51:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:51:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:51:09 INFO - Using env: {'DISPLAY': ':0', 14:51:09 INFO - 'HOME': '/home/cltbld', 14:51:09 INFO - 'LANG': 'en_US.UTF-8', 14:51:09 INFO - 'LANGUAGE': 'en_US:en', 14:51:09 INFO - 'LOGNAME': 'cltbld', 14:51:09 INFO - 'MAIL': '/var/mail/cltbld', 14:51:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:51:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:51:09 INFO - 'MOZ_NO_REMOTE': '1', 14:51:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:51:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:51:09 INFO - 'NO_EM_RESTART': '1', 14:51:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:51:09 INFO - 'PWD': '/builds/slave/test', 14:51:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:51:09 INFO - 'SHELL': '/bin/bash', 14:51:09 INFO - 'SHLVL': '1', 14:51:09 INFO - 'TERM': 'linux', 14:51:09 INFO - 'TMOUT': '86400', 14:51:09 INFO - 'USER': 'cltbld', 14:51:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161', 14:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:51:09 INFO - '_': '/tools/buildbot/bin/python'} 14:51:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:51:09 INFO - mozversion application_buildid: 20161014115635 14:51:09 INFO - mozversion application_changeset: 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 14:51:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:51:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:51:09 INFO - mozversion application_name: Firefox 14:51:09 INFO - mozversion application_remotingname: firefox-dev 14:51:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:51:09 INFO - mozversion application_vendor: Mozilla 14:51:09 INFO - mozversion application_version: 51.0a2 14:51:09 INFO - mozversion platform_buildid: 20161014115635 14:51:09 INFO - mozversion platform_changeset: 7bc185ff4e8b66536bf314f9cf8b03f7d7f0b9b8 14:51:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:51:09 INFO - mozversion platform_version: 51.0a2 14:51:09 INFO - using testdate: 1476481869 14:51:09 INFO - actual date: 1476481869 14:51:09 INFO - starting webserver on 'localhost:55239' 14:51:09 INFO - SUITE-START | Running 2 tests 14:51:09 INFO - TEST-START | dromaeo_css 14:51:09 INFO - operating with platform_type : linux_ 14:51:09 INFO - Initialising browser for dromaeo_css test... 14:51:09 INFO - TEST-INFO | started process 9356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0vk6K/profile http://localhost:55239/getInfo.html) 14:51:14 INFO - PROCESS | 9356 | __metrics Screen width/height:1600/1200 14:51:14 INFO - PROCESS | 9356 | colorDepth:24 14:51:14 INFO - PROCESS | 9356 | Browser inner width/height: 1024/697 14:51:14 INFO - PROCESS | 9356 | __metrics 14:51:14 INFO - PROCESS | 9356 | 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" 14:51:14 INFO - PROCESS | 9356 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:51:15 INFO - PROCESS | 9356 | console.error: PushService: 14:51:15 INFO - PROCESS | 9356 | stateChangeProcessEnqueue: Error transitioning state 14:51:15 INFO - PROCESS | 9356 | UnknownError 14:51:15 INFO - TEST-INFO | 9356: exit 0 14:51:15 INFO - Browser initialized. 14:51:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:51:15 INFO - TEST-INFO | started process 9448 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpw0vk6K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:51:27 INFO - PROCESS | 9448 | RSS: Main: 144306176 14:51:27 INFO - PROCESS | 9448 | 14:52:19 INFO - PROCESS | 9448 | 1476481939383 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] 14:54:27 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55239/tests/dromaeo/cssquery-ext.html) 14:54:28 INFO - PROCESS | 9448 | RSS: Main: 280363008 14:54:28 INFO - PROCESS | 9448 | 14:57:31 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-ext.html (next: http://localhost:55239/tests/dromaeo/cssquery-jquery.html) 14:57:31 INFO - PROCESS | 9448 | RSS: Main: 236285952 14:57:31 INFO - PROCESS | 9448 | 15:00:33 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55239/tests/dromaeo/cssquery-mootools.html) 15:00:34 INFO - PROCESS | 9448 | RSS: Main: 204967936 15:00:34 INFO - PROCESS | 9448 | 15:03:36 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55239/tests/dromaeo/cssquery-prototype.html) 15:03:36 INFO - PROCESS | 9448 | RSS: Main: 216854528 15:03:36 INFO - PROCESS | 9448 | 15:06:39 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55239/tests/dromaeo/cssquery-yui.html) 15:06:40 INFO - PROCESS | 9448 | RSS: Main: 175374336 15:06:40 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | Cycle 1(1): loaded http://localhost:55239/tests/dromaeo/cssquery-yui.html (next: http://localhost:55239/tests/dromaeo/cssquery-dojo.html) 15:09:42 INFO - PROCESS | 9448 | RSS: Main: 265101312 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | __start_tp_report 15:09:42 INFO - PROCESS | 9448 | _x_x_mozilla_page_load 15:09:42 INFO - PROCESS | 9448 | _x_x_mozilla_page_load_details 15:09:42 INFO - PROCESS | 9448 | |i|pagename|runs| 15:09:42 INFO - PROCESS | 9448 | |0;dojo.html;3096.969030309697;3143.1042152986397;3150.716435520803;3159.210197450637;3192.3136525646996;5503.339599248091;5518.889622207564;5523.143912693539;5566.471185237406;5575.721213939307;5517.310336207974;5577.721113944297;5578.944210557893;5584.050711379065;5592.189132575774;5012.724300163499;5031.974840125794;5055.292259083732;5099.15863882459;5132.5124113209185;4941.407031156266;4949.232868905326;4984.277279794428;5094.490550944913;5149.871253218681;5016.799328026875;5093.974530127344;5099.413567439755;5099.439061703229;5122.026814905156;5097.286379906816;5105.82129625465;5107.591392688576;5116.948830511703;5143.8456846294675;4878.951210487885;4882.780274887603;5024.547790698818;5036.974815125937;5076.390833100015;5360.892782144335;5374.543163831079;5428.348598168205;5493.093639549469;5500.064988951888;5852.795152169696;5876.382979787104;5894.823155305305;5895.528357731371;5900.43945825146;5669.177969194444;5911.733971971272;5929.851753706149;5939.049752039696;5940.049592065248;5333.413324534298;5430.56555475561;5481.314835645504;5488.012157811552;5489.011977844027;5977.551683623746;6008.939910600838;6012.849678758066;6014.51883849291;6015.969920150371;5626.2685850839125;5798.971005145032;5813.360530341659;5815.5929084963645;5816.592838501264;5757.65454072757;5776.768929242783;5836.358000619928;5840.678762668009;5846.619969701956;5749.511291540266;5825.0388685866355;5826.4464875837575;5828.271466066742;5834.358220595731;5827.067669172912;5877.294724633071;5877.676727780014;5906.675132867734;5918.467337939606;4551.658625603093;4552.453705555355;4559.224931761609;4559.247724125548;4589.2657174851865;3971.1660551284554;3971.801409929492;3999.920001599952;4054.9391759123637;4103.076807718299;5456.317960254968;5485.177223416519;5491.890162196813;5492.423295553989;5507.586930980193;5787.739551720183;5811.506021988093;5814.476697097281;5821.79623713168;5824.592278540546;5359.732013399314;5424.213489044067;5447.700376479332;5490.396056433789;5500.917486237709;5035.0685123252315;5082.085224659523;5117.513836185556;5155.5617772489;5174.586033117342;6087.512998960073;6088.847778805477;6098.939010609926;6101.938980610226;6102.267727872683;5693.174489699053;5916;5936.970315148396;5946.108083787293;5947.881042379042;5898.3216930053595;5987.401259873977;6050.576459647782;6067.059605761114;6131.601445906002;5775.537956963517;5825.70871456434;5826.592138550261;5831.300243970751;5837.591368604327;5860.0330945395235;5892.970535147297;5900.380460051632;5903.675297858487;5934.020886553671;5620.156976453564;5633.830985070291;5644.717764111861;5691.544676425959;5748.39641837601;5777.7977770777825;5805.912911306418;5806.535477161901;5806.867660806102;5825.94174058254;5746.540276777764;5747.051736463604;5748.626339287933;5750.763585829067;5763.423657634371;5621;5630.662160270397;5775.306963164448;5782.306123265067;5813.709314534171;5679.829605111853;5724.942750572441;5735.11105778605;5747.3103227612955;5768.682722450306 15:09:42 INFO - PROCESS | 9448 | |1;ext.html;580.875111850952;610.2981571193127;640.4044238857863;658.4501940879366;661.5137873662859;34858.30283394331;45348;46311.999999999956;46458.53541464584;46502.53497465024;47941;48314.51685483144;48337.27494087591;48397.03205935879;48461;8482.363822713321;9259.074092590738;9436.764080897963;9436.764080897963;9439.716808495721;8345.54099524526;10948.233623646347;11159.38623375714;11173.162012849029;11487.827682584768;11279.49242284095;11320.547178112865;11350.48922798476;11354.261972971772;11359.488823002943;11155.219134660536;11183.105351571854;11220;11238.100951923827;11257.887421125806;10998.945005275002;11060.944695276552;11068.335899846035;11070.833937490945;11075.16936229778;44598.77700611509;44789.328160077624;44841.32738008932;44941.32588011182;44954.77522612366;3808.3525800613684;3887.669548088416;3900.180961997984;3909.394043923168;4205.137946720914;34063.62470111969;34581;34693;34744.65255347439;35170.47244291338;4553.225951588238;4673.252279635276;4748.19280722278;4770.427548694144;4847.418309802811;338945;339341;339968;339987;341853;61918.69040654768;62673;62766.37233627697;62779.37220627827;62832.37167628357;39821.60178398237;41640;41689;43431.782841085595;65019.67490162614;18231.90884045571;18422.90788546049;18441.354552590594;18443.907780461013;18444;12634.494620215271;12928.965682745358;13687.384067716777;14001.719965600834;14107.153570785786;19539.610823534014;20114.19543218255;20341;20444.693329600068;20487.28294509685;7349.448791340671;7385.6307184640555;7408.370158565107;7538.736144234926;7795.011192836476;1003.267614641316;1075.4730182210817;1095.2388090277182;1145.5589598004829;1172.8358029875824;33436;34102.48846267308;34403.827980860435;34788.65211347854;34903.4764478533;1164.5050853387277;1195.4799662146993;1210.2919791921825;1241.6647505173553;1294.643972907458;17691.911540442474;18050.18774155166;18161.818381816276;18174.545636358933;18188.81811181898;606828;613081;613271;616112;618100;61172.69413652903;61751.38248617546;61815.6909215451;61874.69062654658;61899;1333.2533781082625;1375.587323802855;1378.6691194113341;1466.1056755379211;1484.4730120806958;31990.52014219835;36548.63451365452;36816.26367472689;37052.25895482129;37101.628983709816;58169;58720;58805.41194587999;59055.40944590499;59230.70384648222;381380;381923;384201;384599;384603;26580.734192657826;27216.319592010357;30166.84916575403;31327.686723132476;31506.52740208853;50066.499335006185;50229.74885125551;50395.49604504055;50530.49469505405;50614.746926265136;42869.571304287805;43206;43654.34518482162;45160.32259516044;45837.77081114573;41891.581084188765;42218.155636887706;42523;42782;44224;42303.788481057396;42847;43236.35145472758;43712;43914.78042609766;35270;37400.25199496049;37729.62270377261;37768;38483.615163848;28517.857410712815;28549.42901141924;28601.856990715747;28638.14085577436;28903.421931561672 15:09:42 INFO - PROCESS | 9448 | |2;jquery.html;395.97228194026394;410.38647222402534;410.4397497416028;412.76472410725887;434.5545815539072;14734.18961957092;16379.836201637994;20349.49126271844;20857.791422085775;20966.16135354584;19815.108320125593;20093;20381.59236815263;20680.37958861233;20932.58134837306;5732.426757324265;5795.130730390433;5945.583809133363;6001.87996240075;6045.425684559959;4028.133951200491;6092.29938557065;6126.23422072241;6130.816075517741;6132.294786099589;4305.870823875289;5999.340072592011;6103.45068943795;6164.29110652274;6173.660448675321;6097.329293777659;6129.080637904305;6163.291221509539;6642.368974947372;6663.100481434993;5987;5989.670568118751;5991.460768530853;5992.940070599282;5996.730147143389;14350.282485875769;14571.19858407787;14595.78106328406;14655.706885862222;17451.912740436215;2429.6821688823384;2495.2763698527406;2584;2675.732426757328;2682.0880900493926;10030.49847507629;10147.086762191364;10176.440295783728;10495.370277783357;10669.253152279343;1907.3133671878113;2015.4054553906485;2058.2281644383356;2072.6890966355018;2098.181709133439;69807.65096174537;72815.63592182005;75904.86142707863;79121.99999999942;79858;11024.834627480594;11494;11494.482748276349;11723.296602203895;11810.464639596968;16756.16219189036;16757.329706811834;16759.91620041892;16780.077095759607;16794.58013549671;8342.791430214293;8592.140785921358;8644.783880402914;8675.56622168889;8704.869426958601;8136.796580085545;8208.958955205186;8293.295069919124;8382.87425688615;8402.621882015324;4963.429205641325;5008.724520151354;5030.471800460972;5116.079105760924;5121.539061484485;1975.4370004548923;1993.531520092777;1998.4504261328252;2013.3959812056326;2015.4659015360942;1018.5976539266948;1028.943408112561;1040.5161599856103;1042.764215577162;1093.1418836213534;20062.197512099643;20548.486287842923;20701.79298207029;20726.792732072787;20753.481162971046;1024.5799222318813;1029.27950434696;1036.8185567525652;1044.1125043712784;1046.2257929132388;10654.520546575422;11382.658520244406;11521.884781152248;11648.53405863773;11753.941230293965;240591;241652;242518;243435;544385;98422.5078874601;103516.48241758894;103603.4819825896;109104.45447772711;110101;1064.856244406995;1095.9945200273949;1103.0734183286079;1118.139032944628;1138.4763009015946;18209.271629134688;18269.54326141857;18677.439676809718;18794;18844.434666960013;42807.785961069996;43456.34815477834;43598.782006089765;43841.78079109584;44586.3312050326;60339.698301508215;60624.696876515336;60900.69549652223;61410.69294653677;61989.380106200166;8947.642094316154;9027.729168124966;9141.222996045411;9257.490838003974;9354.29842761782;10121.645742398981;14067.648308791953;14247.501337453139;14386.712265754417;14664.486742963945;6382.521310901794;9218.631254749735;11833.585824496446;12357.691057723629;12445.315507646805;11858.584949526725;11864.347460889734;12057.457414416196;12122.818157727464;12403.441845116811;12173.087018473827;12220.45007974661;12317.199382040139;12543.3101179436;12572.748545029232;8994.460332380078;9002.369834111549;9083.318751093562;9350.43897366133;9567.282453816131;9406.811863762823;12084.51661933548;12318.568850090203;12486.875131248571;12609.93695031519 15:09:42 INFO - PROCESS | 9448 | |3;mootools.html;1375.573572192621;1458.7520121579328;1505.7364961131802;1640.1717132847918;1815.8002619711838;8000.159983201767;8666.480011199325;8916.108389161082;8989.820203595933;9255.44467331959;9010.72967810965;9030.413023153507;9043.864342034874;9100.726978190649;9103.271738260939;2489.526989871923;2513.7234904160528;2516.458961323315;2520.7479252074827;2523.129520315488;2428.210831479776;2527.4945010997876;2531.746825317472;2535.378832186117;2543.160756950211;2440.0727723465147;2441.2676197140877;2501.8999240030375;2508.5610018246825;2512.309114993382;2375.524895020994;2392.3062311929607;2400.3999000249937;2447.290285817111;2451.644511545816;2272.977270227293;2308.0767692922796;2308.9653655195184;2309.711286089239;2334.556434277482;8781.20969112783;8880.467171969638;8970.102989700978;8975.820483590356;8988.550572471415;5275.736213189325;5388.326459192601;5389.78440862365;5395.973020134914;5408.13469844823;3554.431290993429;3580.695640870503;3619.3123306571665;3622.3479773640734;3643.344198044351;1205.3551350027692;1227.5212667059855;1239.609523000261;1242.8135779633037;2210.171185805323;11672.591459298883;12107.576234831738;12114.273143611412;12115.091368147425;12129.21160124598;4614.284785858197;4691.601213896789;4788;4873.537013983666;4893.7063776173545;9760.609575617038;9881.110700036887;9886.4562449066;9889.752756181153;9896.307258491981;5587.888242235133;5593.888122237614;5594.916076258859;5595.860103497445;5598.076317407582;4365.454318210223;4652.255639097728;4690.484046754854;4705.082508910798;5215.504527069922;3932.292187406237;3942.191850670663;4032.1532478179324;4062.268791617478;4064.837406503707;1223.767484178021;1226.8957138643316;1235.0305010566663;1235.32057368447;1237.8452693413324;976.6484065736329;986.7582442301682;999.2355847776457;1003.5784970312486;1014.2241185493103;5984.2818861736;5985.982382994901;6009.369016253318;6014.428629280212;6431;483.6010291509519;487.97072175668865;495.7669895149274;498.9700617962934;501.30068554366454;4020.1758639478835;4165.708400412002;4331.6534677225745;4556.658250631216;4617.46899106607;10996.670099897015;11164.441777911072;11189.160812939062;11201.495932683049;11234.831477527843;11101.611443599597;11125.833112503318;11129.499172537255;11134.888651113548;11141.721456963478;7746.38028957682;8107.959460202661;8196.385271104571;8369.49783013021;8375.916240837636;6032.6983650818165;6074.7266373012435;6140.9692951536745;6164.753409863555;6255.687215639291;9800.509974501103;10096.19230461576;10338.741531461774;10353.63762268317;10367.896321036693;9472.810543788948;9808.068233517804;10381.169506439617;10533.9473302633;10659.573617055541;7535.773926782205;7694.730684426242;7843.372530197685;7931.682732690628;8010.639521221442;8619.094995025433;8643.654253829776;8647.221750042527;8709.91290087091;8724.083971183189;7761.92238077612;7778.688852445839;7802.726904558313;7809.726659566888;7975.082865470546;7682.270184332479;7742.264484873928;7779.338756205786;7838.764837054898;7989.800254993672;7201.927980720336;7352.338289553966;7356.043714317105;7356.190819009797;7357.484976051625;5264.552513036435;5297.602679798953;5318.920216196682;5336.09286421317;5527.032769265443;5163.793448262028;5237.266782650356;5295.973520132375;5334.253204551288;5494.5054945055135 15:09:42 INFO - PROCESS | 9448 | |4;prototype.html;345.844370033485;352.5804292891459;357.64414407664367;359.60084306419856;361.0720448447489;5235.502627250415;5393.164059570763;5474.2355110669105;5519.586031047667;5527.778888844447;5230.947690523094;5366.838994830161;5367.543758780508;5370.382406023299;5375.354957405107;4233.343831706075;4236.936445953298;4237.724547904391;4259.893502662428;4262.381954616579;4174.77038762868;4227.4292970448905;4252.489701235841;4270.711552104877;4288.927768057985;4207.389928460371;4208.516020657633;4215.030542975118;4217.557156498569;4233.51314598822;4204.264253755596;4204.810783514734;4226.640735537483;4248.4052232687445;4260.488741351027;3635.745497815154;3751.9249615007548;3754.099016236111;3762.529683789526;3769.5853456119803;5259.3951695555115;5270.525652691276;5271.367435907678;5272.683638981635;5282.498162674539;4847.394075740533;4851.927221091686;4886.6561695533655;4892.363992680965;4902;5453.890922181534;5595.1886976388605;5646.20953066571;5648.774049038034;5694.886102277973;4115.8971025724595;4117.608827161415;4118.19695159444;4119.732217405859;4135.648469880064;5838.328592211865;5875.648600821793;5893.675847828367;5923.585349025613;5951.49412299955;4097.713160078766;4180.665546756252;4201.705880588391;4210.7473551587;4210.7684077375425;4247.405363249148;4259.701820872509;4259.914801703949;4268.189044081614;4285.207236661166;4830.347903033045;4834.129856625771;4855.878603034882;4858.246971719389;4896.730679812645;5470.507654311131;5642.266505354278;5672.560798856449;5747.712614369349;5753.194552762533;1348.1641382342814;1357.9049466537444;1371.35546293242;1393.7212557488542;1397.489916180607;987.8814542254976;1000.1998401279093;1006.9446180460145;1020.6580795433464;1029.9639512617023;5405.70268635221;5405.945940540623;5411;5416.485433883775;5419.756110975016;5713.5714821388565;5719.914201286984;5726.398728133569;5775.16260142277;5785.768569257267;5228.137357335997;5402.594805389612;5464.480874316933;5481.095619222783;5509.173623956439;2698.892044318205;2709.4581083782928;2725.9591106133425;2739.712335202452;2749.2164733050986;5215.322008138917;5216.400113986864;5306.575473962073;5325.813596524103;5354.892902142014;5214.296070030573;5622.184783206412;5959.880802383928;5986.371430999682;5993.940060599425;5981.820545383733;5993.580449368589;6025.337212906665;6044.879102418015;6066.361132907199;5665.461781130786;5834.766609335748;5889.852753681021;5929.199558059607;5936.851578710567;5796.362400135898;5812.18629391894;5817.272840894888;5818.7090645466715;5820.854478638068;6020.849478763066;6049.425304596057;6100.572959892765;6127.3566275540425;6142.877142457215;4098.897527561835;4211.031462763521;4223.282042052797;4223.5565265646665;4241.87274381769;5630.268065151504;5891.882162356815;5897.616654917417;5907.666471743723;5967.6419414835245;5557.499825015768;5699.971500142473;5701.600887937804;5718.342390625131;5727.39862314451;5619.173768525164;5636.802711905064;5687.5449964001955;5711.828645140652;5723.971380143073;5543.3902270751;5595.5803314752375;5618.157276408408;5637;5660.85847853807;5669.376368599368;5682.204491371129;5712.285964254468;5721.771129154788;5748.252727145445;5428.37573679032;5591.210812539948;5608.551315894637;5646.971765141148;5648.758122274827 15:09:42 INFO - PROCESS | 9448 | |5;yui.html;798.8761741929999;810.3233799777186;853.7140058080543;880.4409200157905;892.3708785306358;16065.196740163003;17241;17303.56741081472;17321.653566928653;17382;16045.197740112977;16511.33954641813;16527.66944661109;16542.421015264466;16586;839.2069494327862;867.600903584352;870.8693695945627;871.1767379826067;871.716692075075;878.1964502480223;881.1937077574012;882.1090698394604;883.0639522106555;883.9071897450772;925.2228128372166;926.4070994563485;927.2257664849858;927.2442958988403;927.4852456886425;917.0829170829171;917.3716004536881;922.7831459606987;923.1138107416888;923.3628796130648;674.5210900260821;675.5642610516238;676.0535250649131;676.2730065179951;676.7665155521337;16335.509934701979;16343.591410214722;16347.509574712778;16377.754333685005;16384;15590.298436570381;15994;16089.597760055975;16363.672726545521;16699.83300166995;12989.740205195843;13083.803742943768;13274.46902123914;13344.466221351135;13514.32428378577;4128.876133715993;4157.064660451374;4238.258304796648;4254.170436764832;4264.701470897038;90354.5482272591;90818.5459072707;91157;91779;91877.5406122965;11896.762064758655;11957.760844783055;12219.26684398939;12293.463317085365;12523.812142817866;23625;23711.881440592686;23719.644205336936;23760.524789504114;23761;8085.151059138823;8541.95729021351;8576.099509551408;8739.43193692408;8805.471671699719;5020.523050310215;5172.327597412387;5218.739063046833;5274.472552744772;5305.495977882095;3535.7171426285836;3641.217138315275;3673.669369756681;3681.815909204529;3684.9631503685155;639.3223183425583;651.6904470376628;659.0492143255921;659.2912618934664;667.4293479075418;717.6483523073656;727.7707522130512;795.1611050341829;808.8301456694043;824.7360844529812;9789.118979291898;10381.377117372982;10399.012093851223;10599.894001060045;10618.840717389245;661.7485355564854;738.2710169087917;751.1099347273498;752.9774106776805;755.2900273742664;4968.776405061781;5009.348784657971;5090.720010399464;5108.489151084936;5132.486751324837;128316;130263;133647.33176334057;136012;137968.31015844856;88871;91527.54236228776;92344.07655923355;99865.50067249617;102260;89924.550377249;91476.54261728648;92324.53837730903;95077.5246123765;95184;9824;9995.800083998425;10261.9486902565;10878.238523303293;11179.217454778087;53844.73077634744;55419.44580554143;55824;56008;57015.714921425126;69296.30703692899;79257.60371198106;79618.6019069901;81055;81232.18767812246;13616.795748063985;13863.237521936391;13876.653083672989;13896.374663140385;14203.502877399242;16104.27530761142;16216.513504594881;16443.424480143138;16597.91701041487;17406.216720247874;15400.84599154039;15519.146446945526;15562;16599;16640.50078497647;14343;14471;14690.485832995793;15345.156016419203;15347.61630959235;15125;15261.465848695243;15317.157556334063;16246.106464144586;16260.674786503967;12026.699332516408;12160.270383777002;12645.114841961342;12729.745405092031;13024.153430027018;11014.559417623526;11564.768704626029;12115.81826272589;12239.87760122423;12814.55149069778 15:09:42 INFO - PROCESS | 9448 | __end_tp_report 15:09:42 INFO - PROCESS | 9448 | __start_cc_report 15:09:42 INFO - PROCESS | 9448 | _x_x_mozilla_cycle_collect,1085 15:09:42 INFO - PROCESS | 9448 | __end_cc_report 15:09:42 INFO - PROCESS | 9448 | __startTimestamp1476482982876__endTimestamp 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | ------- Summary: start ------- 15:09:42 INFO - PROCESS | 9448 | Number of tests: 6 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#0] dojo.html Cycles:165 Average:5463.55 Median:5679.83 stddev:609.90 (10.7%) stddev-sans-first:582.83 15:09:42 INFO - PROCESS | 9448 | Values: 3097.0 3143.1 3150.7 3159.2 3192.3 5503.3 5518.9 5523.1 5566.5 5575.7 5517.3 5577.7 5578.9 5584.1 5592.2 5012.7 5032.0 5055.3 5099.2 5132.5 4941.4 4949.2 4984.3 5094.5 5149.9 5016.8 5094.0 5099.4 5099.4 5122.0 5097.3 5105.8 5107.6 5116.9 5143.8 4879.0 4882.8 5024.5 5037.0 5076.4 5360.9 5374.5 5428.3 5493.1 5500.1 5852.8 5876.4 5894.8 5895.5 5900.4 5669.2 5911.7 5929.9 5939.0 5940.0 5333.4 5430.6 5481.3 5488.0 5489.0 5977.6 6008.9 6012.8 6014.5 6016.0 5626.3 5799.0 5813.4 5815.6 5816.6 5757.7 5776.8 5836.4 5840.7 5846.6 5749.5 5825.0 5826.4 5828.3 5834.4 5827.1 5877.3 5877.7 5906.7 5918.5 4551.7 4552.5 4559.2 4559.2 4589.3 3971.2 3971.8 3999.9 4054.9 4103.1 5456.3 5485.2 5491.9 5492.4 5507.6 5787.7 5811.5 5814.5 5821.8 5824.6 5359.7 5424.2 5447.7 5490.4 5500.9 5035.1 5082.1 5117.5 5155.6 5174.6 6087.5 6088.8 6098.9 6101.9 6102.3 5693.2 5916.0 5937.0 5946.1 5947.9 5898.3 5987.4 6050.6 6067.1 6131.6 5775.5 5825.7 5826.6 5831.3 5837.6 5860.0 5893.0 5900.4 5903.7 5934.0 5620.2 5633.8 5644.7 5691.5 5748.4 5777.8 5805.9 5806.5 5806.9 5825.9 5746.5 5747.1 5748.6 5750.8 5763.4 5621.0 5630.7 5775.3 5782.3 5813.7 5679.8 5724.9 5735.1 5747.3 5768.7 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#1] ext.html Cycles:180 Average:61888.09 Median:381651.50 stddev:122545.10 (32.1%) stddev-sans-first:122802.42 15:09:42 INFO - PROCESS | 9448 | Values: 580.9 610.3 640.4 658.5 661.5 34858.3 45348.0 46312.0 46458.5 46502.5 47941.0 48314.5 48337.3 48397.0 48461.0 8482.4 9259.1 9436.8 9436.8 9439.7 8345.5 10948.2 11159.4 11173.2 11487.8 11279.5 11320.5 11350.5 11354.3 11359.5 11155.2 11183.1 11220.0 11238.1 11257.9 10998.9 11060.9 11068.3 11070.8 11075.2 44598.8 44789.3 44841.3 44941.3 44954.8 3808.4 3887.7 3900.2 3909.4 4205.1 34063.6 34581.0 34693.0 34744.7 35170.5 4553.2 4673.3 4748.2 4770.4 4847.4 338945.0 339341.0 339968.0 339987.0 341853.0 61918.7 62673.0 62766.4 62779.4 62832.4 39821.6 41640.0 41689.0 43431.8 65019.7 18231.9 18422.9 18441.4 18443.9 18444.0 12634.5 12929.0 13687.4 14001.7 14107.2 19539.6 20114.2 20341.0 20444.7 20487.3 7349.4 7385.6 7408.4 7538.7 7795.0 1003.3 1075.5 1095.2 1145.6 1172.8 33436.0 34102.5 34403.8 34788.7 34903.5 1164.5 1195.5 1210.3 1241.7 1294.6 17691.9 18050.2 18161.8 18174.5 18188.8 606828.0 613081.0 613271.0 616112.0 618100.0 61172.7 61751.4 61815.7 61874.7 61899.0 1333.3 1375.6 1378.7 1466.1 1484.5 31990.5 36548.6 36816.3 37052.3 37101.6 58169.0 58720.0 58805.4 59055.4 59230.7 381380.0 381923.0 384201.0 384599.0 384603.0 26580.7 27216.3 30166.8 31327.7 31506.5 50066.5 50229.7 50395.5 50530.5 50614.7 42869.6 43206.0 43654.3 45160.3 45837.8 41891.6 42218.2 42523.0 42782.0 44224.0 42303.8 42847.0 43236.4 43712.0 43914.8 35270.0 37400.3 37729.6 37768.0 38483.6 28517.9 28549.4 28601.9 28638.1 28903.4 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#2] jquery.html Cycles:180 Average:24201.24 Median:20740.14 stddev:55714.48 (268.6%) stddev-sans-first:55842.11 15:09:42 INFO - PROCESS | 9448 | Values: 396.0 410.4 410.4 412.8 434.6 14734.2 16379.8 20349.5 20857.8 20966.2 19815.1 20093.0 20381.6 20680.4 20932.6 5732.4 5795.1 5945.6 6001.9 6045.4 4028.1 6092.3 6126.2 6130.8 6132.3 4305.9 5999.3 6103.5 6164.3 6173.7 6097.3 6129.1 6163.3 6642.4 6663.1 5987.0 5989.7 5991.5 5992.9 5996.7 14350.3 14571.2 14595.8 14655.7 17451.9 2429.7 2495.3 2584.0 2675.7 2682.1 10030.5 10147.1 10176.4 10495.4 10669.3 1907.3 2015.4 2058.2 2072.7 2098.2 69807.7 72815.6 75904.9 79122.0 79858.0 11024.8 11494.0 11494.5 11723.3 11810.5 16756.2 16757.3 16759.9 16780.1 16794.6 8342.8 8592.1 8644.8 8675.6 8704.9 8136.8 8209.0 8293.3 8382.9 8402.6 4963.4 5008.7 5030.5 5116.1 5121.5 1975.4 1993.5 1998.5 2013.4 2015.5 1018.6 1028.9 1040.5 1042.8 1093.1 20062.2 20548.5 20701.8 20726.8 20753.5 1024.6 1029.3 1036.8 1044.1 1046.2 10654.5 11382.7 11521.9 11648.5 11753.9 240591.0 241652.0 242518.0 243435.0 544385.0 98422.5 103516.5 103603.5 109104.5 110101.0 1064.9 1096.0 1103.1 1118.1 1138.5 18209.3 18269.5 18677.4 18794.0 18844.4 42807.8 43456.3 43598.8 43841.8 44586.3 60339.7 60624.7 60900.7 61410.7 61989.4 8947.6 9027.7 9141.2 9257.5 9354.3 10121.6 14067.6 14247.5 14386.7 14664.5 6382.5 9218.6 11833.6 12357.7 12445.3 11858.6 11864.3 12057.5 12122.8 12403.4 12173.1 12220.5 12317.2 12543.3 12572.7 8994.5 9002.4 9083.3 9350.4 9567.3 9406.8 12084.5 12318.6 12486.9 12609.9 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#3] mootools.html Cycles:180 Average:5891.28 Median:497.37 stddev:3290.46 (661.6%) stddev-sans-first:3282.18 15:09:42 INFO - PROCESS | 9448 | Values: 1375.6 1458.8 1505.7 1640.2 1815.8 8000.2 8666.5 8916.1 8989.8 9255.4 9010.7 9030.4 9043.9 9100.7 9103.3 2489.5 2513.7 2516.5 2520.7 2523.1 2428.2 2527.5 2531.7 2535.4 2543.2 2440.1 2441.3 2501.9 2508.6 2512.3 2375.5 2392.3 2400.4 2447.3 2451.6 2273.0 2308.1 2309.0 2309.7 2334.6 8781.2 8880.5 8970.1 8975.8 8988.6 5275.7 5388.3 5389.8 5396.0 5408.1 3554.4 3580.7 3619.3 3622.3 3643.3 1205.4 1227.5 1239.6 1242.8 2210.2 11672.6 12107.6 12114.3 12115.1 12129.2 4614.3 4691.6 4788.0 4873.5 4893.7 9760.6 9881.1 9886.5 9889.8 9896.3 5587.9 5593.9 5594.9 5595.9 5598.1 4365.5 4652.3 4690.5 4705.1 5215.5 3932.3 3942.2 4032.2 4062.3 4064.8 1223.8 1226.9 1235.0 1235.3 1237.8 976.6 986.8 999.2 1003.6 1014.2 5984.3 5986.0 6009.4 6014.4 6431.0 483.6 488.0 495.8 499.0 501.3 4020.2 4165.7 4331.7 4556.7 4617.5 10996.7 11164.4 11189.2 11201.5 11234.8 11101.6 11125.8 11129.5 11134.9 11141.7 7746.4 8108.0 8196.4 8369.5 8375.9 6032.7 6074.7 6141.0 6164.8 6255.7 9800.5 10096.2 10338.7 10353.6 10367.9 9472.8 9808.1 10381.2 10533.9 10659.6 7535.8 7694.7 7843.4 7931.7 8010.6 8619.1 8643.7 8647.2 8709.9 8724.1 7761.9 7778.7 7802.7 7809.7 7975.1 7682.3 7742.3 7779.3 7838.8 7989.8 7201.9 7352.3 7356.0 7356.2 7357.5 5264.6 5297.6 5318.9 5336.1 5527.0 5163.8 5237.3 5296.0 5334.3 5494.5 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#4] prototype.html Cycles:180 Average:4759.42 Median:5372.87 stddev:1403.99 (26.1%) stddev-sans-first:1368.28 15:09:42 INFO - PROCESS | 9448 | Values: 345.8 352.6 357.6 359.6 361.1 5235.5 5393.2 5474.2 5519.6 5527.8 5230.9 5366.8 5367.5 5370.4 5375.4 4233.3 4236.9 4237.7 4259.9 4262.4 4174.8 4227.4 4252.5 4270.7 4288.9 4207.4 4208.5 4215.0 4217.6 4233.5 4204.3 4204.8 4226.6 4248.4 4260.5 3635.7 3751.9 3754.1 3762.5 3769.6 5259.4 5270.5 5271.4 5272.7 5282.5 4847.4 4851.9 4886.7 4892.4 4902.0 5453.9 5595.2 5646.2 5648.8 5694.9 4115.9 4117.6 4118.2 4119.7 4135.6 5838.3 5875.6 5893.7 5923.6 5951.5 4097.7 4180.7 4201.7 4210.7 4210.8 4247.4 4259.7 4259.9 4268.2 4285.2 4830.3 4834.1 4855.9 4858.2 4896.7 5470.5 5642.3 5672.6 5747.7 5753.2 1348.2 1357.9 1371.4 1393.7 1397.5 987.9 1000.2 1006.9 1020.7 1030.0 5405.7 5405.9 5411.0 5416.5 5419.8 5713.6 5719.9 5726.4 5775.2 5785.8 5228.1 5402.6 5464.5 5481.1 5509.2 2698.9 2709.5 2726.0 2739.7 2749.2 5215.3 5216.4 5306.6 5325.8 5354.9 5214.3 5622.2 5959.9 5986.4 5993.9 5981.8 5993.6 6025.3 6044.9 6066.4 5665.5 5834.8 5889.9 5929.2 5936.9 5796.4 5812.2 5817.3 5818.7 5820.9 6020.8 6049.4 6100.6 6127.4 6142.9 4098.9 4211.0 4223.3 4223.6 4241.9 5630.3 5891.9 5897.6 5907.7 5967.6 5557.5 5700.0 5701.6 5718.3 5727.4 5619.2 5636.8 5687.5 5711.8 5724.0 5543.4 5595.6 5618.2 5637.0 5660.9 5669.4 5682.2 5712.3 5721.8 5748.3 5428.4 5591.2 5608.6 5647.0 5648.8 15:09:42 INFO - PROCESS | 9448 | 15:09:42 INFO - PROCESS | 9448 | [#5] yui.html Cycles:180 Average:22698.15 Median:4246.21 stddev:32688.57 (769.8%) stddev-sans-first:32738.91 15:09:42 INFO - PROCESS | 9448 | Values: 798.9 810.3 853.7 880.4 892.4 16065.2 17241.0 17303.6 17321.7 17382.0 16045.2 16511.3 16527.7 16542.4 16586.0 839.2 867.6 870.9 871.2 871.7 878.2 881.2 882.1 883.1 883.9 925.2 926.4 927.2 927.2 927.5 917.1 917.4 922.8 923.1 923.4 674.5 675.6 676.1 676.3 676.8 16335.5 16343.6 16347.5 16377.8 16384.0 15590.3 15994.0 16089.6 16363.7 16699.8 12989.7 13083.8 13274.5 13344.5 13514.3 4128.9 4157.1 4238.3 4254.2 4264.7 90354.5 90818.5 91157.0 91779.0 91877.5 11896.8 11957.8 12219.3 12293.5 12523.8 23625.0 23711.9 23719.6 23760.5 23761.0 8085.2 8542.0 8576.1 8739.4 8805.5 5020.5 5172.3 5218.7 5274.5 5305.5 3535.7 3641.2 3673.7 3681.8 3685.0 639.3 651.7 659.0 659.3 667.4 717.6 727.8 795.2 808.8 824.7 9789.1 10381.4 10399.0 10599.9 10618.8 661.7 738.3 751.1 753.0 755.3 4968.8 5009.3 5090.7 5108.5 5132.5 128316.0 130263.0 133647.3 136012.0 137968.3 88871.0 91527.5 92344.1 99865.5 102260.0 89924.6 91476.5 92324.5 95077.5 95184.0 9824.0 9995.8 10261.9 10878.2 11179.2 53844.7 55419.4 55824.0 56008.0 57015.7 69296.3 79257.6 79618.6 81055.0 81232.2 13616.8 13863.2 13876.7 13896.4 14203.5 16104.3 16216.5 16443.4 16597.9 17406.2 15400.8 15519.1 15562.0 16599.0 16640.5 14343.0 14471.0 14690.5 15345.2 15347.6 15125.0 15261.5 15317.2 16246.1 16260.7 12026.7 12160.3 12645.1 12729.7 13024.2 11014.6 11564.8 12115.8 12239.9 12814.6 15:09:42 INFO - PROCESS | 9448 | -------- Summary: end -------- 15:09:42 INFO - PROCESS | 9448 | 15:09:43 INFO - TEST-INFO | 9448: exit 0 15:09:43 INFO - TEST-OK | dromaeo_css | took 1113810ms 15:09:43 INFO - TEST-START | kraken 15:09:43 INFO - operating with platform_type : linux_ 15:09:43 INFO - Initialising browser for kraken test... 15:09:43 INFO - TEST-INFO | started process 9766 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXAOJv/profile http://localhost:55239/getInfo.html) 15:09:47 INFO - PROCESS | 9766 | __metrics Screen width/height:1600/1200 15:09:47 INFO - PROCESS | 9766 | colorDepth:24 15:09:47 INFO - PROCESS | 9766 | Browser inner width/height: 1024/697 15:09:47 INFO - PROCESS | 9766 | __metrics 15:09:48 INFO - PROCESS | 9766 | 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" 15:09:48 INFO - PROCESS | 9766 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:09:49 INFO - PROCESS | 9766 | console.error: PushService: 15:09:49 INFO - PROCESS | 9766 | stateChangeProcessEnqueue: Error transitioning state 15:09:49 INFO - PROCESS | 9766 | UnknownError 15:09:49 INFO - TEST-INFO | 9766: exit 0 15:09:49 INFO - Browser initialized. 15:09:49 INFO - Running cycle 1/1 for kraken test... 15:09:49 INFO - TEST-INFO | started process 9859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxXAOJv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:10:01 INFO - PROCESS | 9859 | RSS: Main: 144543744 15:10:01 INFO - PROCESS | 9859 | 15:10:04 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55239/tests/kraken/driver.html?testName=audio-beat-detection) 15:10:04 INFO - PROCESS | 9859 | RSS: Main: 186322944 15:10:04 INFO - PROCESS | 9859 | 15:10:07 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55239/tests/kraken/driver.html?testName=audio-dft) 15:10:08 INFO - PROCESS | 9859 | RSS: Main: 175849472 15:10:08 INFO - PROCESS | 9859 | 15:10:10 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55239/tests/kraken/driver.html?testName=audio-fft) 15:10:11 INFO - PROCESS | 9859 | RSS: Main: 266047488 15:10:11 INFO - PROCESS | 9859 | 15:10:13 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55239/tests/kraken/driver.html?testName=audio-oscillator) 15:10:14 INFO - PROCESS | 9859 | RSS: Main: 173359104 15:10:14 INFO - PROCESS | 9859 | 15:10:16 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:10:16 INFO - PROCESS | 9859 | RSS: Main: 175173632 15:10:16 INFO - PROCESS | 9859 | 15:10:19 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55239/tests/kraken/driver.html?testName=imaging-darkroom) 15:10:20 INFO - PROCESS | 9859 | RSS: Main: 210575360 15:10:20 INFO - PROCESS | 9859 | 15:10:23 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55239/tests/kraken/driver.html?testName=imaging-desaturate) 15:10:24 INFO - PROCESS | 9859 | RSS: Main: 209080320 15:10:24 INFO - PROCESS | 9859 | 15:10:27 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55239/tests/kraken/driver.html?testName=json-parse-financial) 15:10:27 INFO - PROCESS | 9859 | RSS: Main: 209084416 15:10:27 INFO - PROCESS | 9859 | 15:10:29 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:10:29 INFO - PROCESS | 9859 | RSS: Main: 171450368 15:10:29 INFO - PROCESS | 9859 | 15:10:31 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:10:31 INFO - PROCESS | 9859 | RSS: Main: 177557504 15:10:31 INFO - PROCESS | 9859 | 15:10:33 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:10:34 INFO - PROCESS | 9859 | RSS: Main: 188223488 15:10:34 INFO - PROCESS | 9859 | 15:10:37 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:10:37 INFO - PROCESS | 9859 | RSS: Main: 197152768 15:10:37 INFO - PROCESS | 9859 | 15:10:40 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:10:41 INFO - PROCESS | 9859 | RSS: Main: 193699840 15:10:41 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | Cycle 1(1): loaded http://localhost:55239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55239/tests/kraken/driver.html?testName=ai-astar) 15:10:42 INFO - PROCESS | 9859 | RSS: Main: 244682752 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | __start_tp_report 15:10:42 INFO - PROCESS | 9859 | _x_x_mozilla_page_load 15:10:42 INFO - PROCESS | 9859 | _x_x_mozilla_page_load_details 15:10:42 INFO - PROCESS | 9859 | |i|pagename|runs| 15:10:42 INFO - PROCESS | 9859 | |0;ai-astar;109;112;114;111;113;112;112;111;110;111 15:10:42 INFO - PROCESS | 9859 | |1;audio-beat-detection;143;124;127;164;116;119;116;123;159;118 15:10:42 INFO - PROCESS | 9859 | |2;audio-dft;160;160;160;159;160;160;162;160;161;160 15:10:42 INFO - PROCESS | 9859 | |3;audio-fft;74;75;75;106;76;76;76;75;104;75 15:10:42 INFO - PROCESS | 9859 | |4;audio-oscillator;82;80;113;81;81;82;111;82;81;104 15:10:42 INFO - PROCESS | 9859 | |5;imaging-gaussian-blur;118;117;117;118;117;117;117;118;117;117 15:10:42 INFO - PROCESS | 9859 | |6;imaging-darkroom;147;146;145;145;147;145;146;146;147;146 15:10:42 INFO - PROCESS | 9859 | |7;imaging-desaturate;94;95;95;95;95;94;95;95;95;94 15:10:42 INFO - PROCESS | 9859 | |8;json-parse-financial;50;52;52;49;49;50;50;51;50;50 15:10:42 INFO - PROCESS | 9859 | |9;json-stringify-tinderbox;60;59;60;59;60;59;59;59;59;59 15:10:42 INFO - PROCESS | 9859 | |10;stanford-crypto-aes;75;73;72;83;74;75;74;78;73;73 15:10:42 INFO - PROCESS | 9859 | |11;stanford-crypto-ccm;122;134;128;123;119;121;127;118;161;118 15:10:42 INFO - PROCESS | 9859 | |12;stanford-crypto-pbkdf2;156;154;155;154;152;150;154;150;152;155 15:10:42 INFO - PROCESS | 9859 | |13;stanford-crypto-sha256-iterative;62;61;62;61;61;62;62;65;60;61 15:10:42 INFO - PROCESS | 9859 | __end_tp_report 15:10:42 INFO - PROCESS | 9859 | __start_cc_report 15:10:42 INFO - PROCESS | 9859 | _x_x_mozilla_cycle_collect,1623 15:10:42 INFO - PROCESS | 9859 | __end_cc_report 15:10:42 INFO - PROCESS | 9859 | __startTimestamp1476483042891__endTimestamp 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | ------- Summary: start ------- 15:10:42 INFO - PROCESS | 9859 | Number of tests: 14 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:1.43 (1.3%) stddev-sans-first:1.20 15:10:42 INFO - PROCESS | 9859 | Values: 109.0 112.0 114.0 111.0 113.0 112.0 112.0 111.0 110.0 111.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:125.50 stddev:17.98 (14.3%) stddev-sans-first:18.53 15:10:42 INFO - PROCESS | 9859 | Values: 143.0 124.0 127.0 164.0 116.0 119.0 116.0 123.0 159.0 118.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 15:10:42 INFO - PROCESS | 9859 | Values: 160.0 160.0 160.0 159.0 160.0 160.0 162.0 160.0 161.0 160.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.00 stddev:12.57 (16.8%) stddev-sans-first:13.06 15:10:42 INFO - PROCESS | 9859 | Values: 74.0 75.0 75.0 106.0 76.0 76.0 76.0 75.0 104.0 75.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:81.00 stddev:13.74 (17.0%) stddev-sans-first:14.29 15:10:42 INFO - PROCESS | 9859 | Values: 82.0 80.0 113.0 81.0 81.0 82.0 111.0 82.0 81.0 104.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:10:42 INFO - PROCESS | 9859 | Values: 118.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 15:10:42 INFO - PROCESS | 9859 | Values: 147.0 146.0 145.0 145.0 147.0 145.0 146.0 146.0 147.0 146.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:10:42 INFO - PROCESS | 9859 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 94.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:1.06 (2.1%) stddev-sans-first:1.12 15:10:42 INFO - PROCESS | 9859 | Values: 50.0 52.0 52.0 49.0 49.0 50.0 50.0 51.0 50.0 50.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 15:10:42 INFO - PROCESS | 9859 | Values: 60.0 59.0 60.0 59.0 60.0 59.0 59.0 59.0 59.0 59.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:3.27 (4.4%) stddev-sans-first:3.46 15:10:42 INFO - PROCESS | 9859 | Values: 75.0 73.0 72.0 83.0 74.0 75.0 74.0 78.0 73.0 73.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:125.00 stddev:12.95 (10.4%) stddev-sans-first:13.60 15:10:42 INFO - PROCESS | 9859 | Values: 122.0 134.0 128.0 123.0 119.0 121.0 127.0 118.0 161.0 118.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.00 stddev:2.10 (1.4%) stddev-sans-first:1.96 15:10:42 INFO - PROCESS | 9859 | Values: 156.0 154.0 155.0 154.0 152.0 150.0 154.0 150.0 152.0 155.0 15:10:42 INFO - PROCESS | 9859 | 15:10:42 INFO - PROCESS | 9859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.41 15:10:42 INFO - PROCESS | 9859 | Values: 62.0 61.0 62.0 61.0 61.0 62.0 62.0 65.0 60.0 61.0 15:10:42 INFO - PROCESS | 9859 | -------- Summary: end -------- 15:10:42 INFO - PROCESS | 9859 | 15:10:43 INFO - TEST-INFO | 9859: exit 0 15:10:43 INFO - TEST-OK | kraken | took 60251ms 15:10:43 INFO - SUITE-END | took 1174s 15:10:44 INFO - Completed test suite (00:19:34) 15:10:44 INFO - javascript benchmark 15:10:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.969030309697, 3143.1042152986397, 3150.716435520803, 3159.210197450637, 3192.3136525646996, 5503.339599248091, 5518.889622207564, 5523.143912693539, 5566.471185237406, 5575.721213939307, 5517.310336207974, 5577.721113944297, 5578.944210557893, 5584.050711379065, 5592.189132575774, 5012.724300163499, 5031.974840125794, 5055.292259083732, 5099.15863882459, 5132.5124113209185, 4941.407031156266, 4949.232868905326, 4984.277279794428, 5094.490550944913, 5149.871253218681, 5016.799328026875, 5093.974530127344, 5099.413567439755, 5099.439061703229, 5122.026814905156, 5097.286379906816, 5105.82129625465, 5107.591392688576, 5116.948830511703, 5143.8456846294675, 4878.951210487885, 4882.780274887603, 5024.547790698818, 5036.974815125937, 5076.390833100015, 5360.892782144335, 5374.543163831079, 5428.348598168205, 5493.093639549469, 5500.064988951888, 5852.795152169696, 5876.382979787104, 5894.823155305305, 5895.528357731371, 5900.43945825146, 5669.177969194444, 5911.733971971272, 5929.851753706149, 5939.049752039696, 5940.049592065248, 5333.413324534298, 5430.56555475561, 5481.314835645504, 5488.012157811552, 5489.011977844027, 5977.551683623746, 6008.939910600838, 6012.849678758066, 6014.51883849291, 6015.969920150371, 5626.2685850839125, 5798.971005145032, 5813.360530341659, 5815.5929084963645, 5816.592838501264, 5757.65454072757, 5776.768929242783, 5836.358000619928, 5840.678762668009, 5846.619969701956, 5749.511291540266, 5825.0388685866355, 5826.4464875837575, 5828.271466066742, 5834.358220595731, 5827.067669172912, 5877.294724633071, 5877.676727780014, 5906.675132867734, 5918.467337939606, 4551.658625603093, 4552.453705555355, 4559.224931761609, 4559.247724125548, 4589.2657174851865, 3971.1660551284554, 3971.801409929492, 3999.920001599952, 4054.9391759123637, 4103.076807718299, 5456.317960254968, 5485.177223416519, 5491.890162196813, 5492.423295553989, 5507.586930980193, 5787.739551720183, 5811.506021988093, 5814.476697097281, 5821.79623713168, 5824.592278540546, 5359.732013399314, 5424.213489044067, 5447.700376479332, 5490.396056433789, 5500.917486237709, 5035.0685123252315, 5082.085224659523, 5117.513836185556, 5155.5617772489, 5174.586033117342, 6087.512998960073, 6088.847778805477, 6098.939010609926, 6101.938980610226, 6102.267727872683, 5693.174489699053, 5916.0, 5936.970315148396, 5946.108083787293, 5947.881042379042, 5898.3216930053595, 5987.401259873977, 6050.576459647782, 6067.059605761114, 6131.601445906002, 5775.537956963517, 5825.70871456434, 5826.592138550261, 5831.300243970751, 5837.591368604327, 5860.0330945395235, 5892.970535147297, 5900.380460051632, 5903.675297858487, 5934.020886553671, 5620.156976453564, 5633.830985070291, 5644.717764111861, 5691.544676425959, 5748.39641837601, 5777.7977770777825, 5805.912911306418, 5806.535477161901, 5806.867660806102, 5825.94174058254, 5746.540276777764, 5747.051736463604, 5748.626339287933, 5750.763585829067, 5763.423657634371, 5621.0, 5630.662160270397, 5775.306963164448, 5782.306123265067, 5813.709314534171, 5679.829605111853, 5724.942750572441, 5735.11105778605, 5747.3103227612955, 5768.682722450306], "value": 5422.576765264691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.875111850952, 610.2981571193127, 640.4044238857863, 658.4501940879366, 661.5137873662859, 34858.30283394331, 45348.0, 46311.999999999956, 46458.53541464584, 46502.53497465024, 47941.0, 48314.51685483144, 48337.27494087591, 48397.03205935879, 48461.0, 8482.363822713321, 9259.074092590738, 9436.764080897963, 9436.764080897963, 9439.716808495721, 8345.54099524526, 10948.233623646347, 11159.38623375714, 11173.162012849029, 11487.827682584768, 11279.49242284095, 11320.547178112865, 11350.48922798476, 11354.261972971772, 11359.488823002943, 11155.219134660536, 11183.105351571854, 11220.0, 11238.100951923827, 11257.887421125806, 10998.945005275002, 11060.944695276552, 11068.335899846035, 11070.833937490945, 11075.16936229778, 44598.77700611509, 44789.328160077624, 44841.32738008932, 44941.32588011182, 44954.77522612366, 3808.3525800613684, 3887.669548088416, 3900.180961997984, 3909.394043923168, 4205.137946720914, 34063.62470111969, 34581.0, 34693.0, 34744.65255347439, 35170.47244291338, 4553.225951588238, 4673.252279635276, 4748.19280722278, 4770.427548694144, 4847.418309802811, 338945.0, 339341.0, 339968.0, 339987.0, 341853.0, 61918.69040654768, 62673.0, 62766.37233627697, 62779.37220627827, 62832.37167628357, 39821.60178398237, 41640.0, 41689.0, 43431.782841085595, 65019.67490162614, 18231.90884045571, 18422.90788546049, 18441.354552590594, 18443.907780461013, 18444.0, 12634.494620215271, 12928.965682745358, 13687.384067716777, 14001.719965600834, 14107.153570785786, 19539.610823534014, 20114.19543218255, 20341.0, 20444.693329600068, 20487.28294509685, 7349.448791340671, 7385.6307184640555, 7408.370158565107, 7538.736144234926, 7795.011192836476, 1003.267614641316, 1075.4730182210817, 1095.2388090277182, 1145.5589598004829, 1172.8358029875824, 33436.0, 34102.48846267308, 34403.827980860435, 34788.65211347854, 34903.4764478533, 1164.5050853387277, 1195.4799662146993, 1210.2919791921825, 1241.6647505173553, 1294.643972907458, 17691.911540442474, 18050.18774155166, 18161.818381816276, 18174.545636358933, 18188.81811181898, 606828.0, 613081.0, 613271.0, 616112.0, 618100.0, 61172.69413652903, 61751.38248617546, 61815.6909215451, 61874.69062654658, 61899.0, 1333.2533781082625, 1375.587323802855, 1378.6691194113341, 1466.1056755379211, 1484.4730120806958, 31990.52014219835, 36548.63451365452, 36816.26367472689, 37052.25895482129, 37101.628983709816, 58169.0, 58720.0, 58805.41194587999, 59055.40944590499, 59230.70384648222, 381380.0, 381923.0, 384201.0, 384599.0, 384603.0, 26580.734192657826, 27216.319592010357, 30166.84916575403, 31327.686723132476, 31506.52740208853, 50066.499335006185, 50229.74885125551, 50395.49604504055, 50530.49469505405, 50614.746926265136, 42869.571304287805, 43206.0, 43654.34518482162, 45160.32259516044, 45837.77081114573, 41891.581084188765, 42218.155636887706, 42523.0, 42782.0, 44224.0, 42303.788481057396, 42847.0, 43236.35145472758, 43712.0, 43914.78042609766, 35270.0, 37400.25199496049, 37729.62270377261, 37768.0, 38483.615163848, 28517.857410712815, 28549.42901141924, 28601.856990715747, 28638.14085577436, 28903.421931561672], "value": 21487.63154484943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.97228194026394, 410.38647222402534, 410.4397497416028, 412.76472410725887, 434.5545815539072, 14734.18961957092, 16379.836201637994, 20349.49126271844, 20857.791422085775, 20966.16135354584, 19815.108320125593, 20093.0, 20381.59236815263, 20680.37958861233, 20932.58134837306, 5732.426757324265, 5795.130730390433, 5945.583809133363, 6001.87996240075, 6045.425684559959, 4028.133951200491, 6092.29938557065, 6126.23422072241, 6130.816075517741, 6132.294786099589, 4305.870823875289, 5999.340072592011, 6103.45068943795, 6164.29110652274, 6173.660448675321, 6097.329293777659, 6129.080637904305, 6163.291221509539, 6642.368974947372, 6663.100481434993, 5987.0, 5989.670568118751, 5991.460768530853, 5992.940070599282, 5996.730147143389, 14350.282485875769, 14571.19858407787, 14595.78106328406, 14655.706885862222, 17451.912740436215, 2429.6821688823384, 2495.2763698527406, 2584.0, 2675.732426757328, 2682.0880900493926, 10030.49847507629, 10147.086762191364, 10176.440295783728, 10495.370277783357, 10669.253152279343, 1907.3133671878113, 2015.4054553906485, 2058.2281644383356, 2072.6890966355018, 2098.181709133439, 69807.65096174537, 72815.63592182005, 75904.86142707863, 79121.99999999942, 79858.0, 11024.834627480594, 11494.0, 11494.482748276349, 11723.296602203895, 11810.464639596968, 16756.16219189036, 16757.329706811834, 16759.91620041892, 16780.077095759607, 16794.58013549671, 8342.791430214293, 8592.140785921358, 8644.783880402914, 8675.56622168889, 8704.869426958601, 8136.796580085545, 8208.958955205186, 8293.295069919124, 8382.87425688615, 8402.621882015324, 4963.429205641325, 5008.724520151354, 5030.471800460972, 5116.079105760924, 5121.539061484485, 1975.4370004548923, 1993.531520092777, 1998.4504261328252, 2013.3959812056326, 2015.4659015360942, 1018.5976539266948, 1028.943408112561, 1040.5161599856103, 1042.764215577162, 1093.1418836213534, 20062.197512099643, 20548.486287842923, 20701.79298207029, 20726.792732072787, 20753.481162971046, 1024.5799222318813, 1029.27950434696, 1036.8185567525652, 1044.1125043712784, 1046.2257929132388, 10654.520546575422, 11382.658520244406, 11521.884781152248, 11648.53405863773, 11753.941230293965, 240591.0, 241652.0, 242518.0, 243435.0, 544385.0, 98422.5078874601, 103516.48241758894, 103603.4819825896, 109104.45447772711, 110101.0, 1064.856244406995, 1095.9945200273949, 1103.0734183286079, 1118.139032944628, 1138.4763009015946, 18209.271629134688, 18269.54326141857, 18677.439676809718, 18794.0, 18844.434666960013, 42807.785961069996, 43456.34815477834, 43598.782006089765, 43841.78079109584, 44586.3312050326, 60339.698301508215, 60624.696876515336, 60900.69549652223, 61410.69294653677, 61989.380106200166, 8947.642094316154, 9027.729168124966, 9141.222996045411, 9257.490838003974, 9354.29842761782, 10121.645742398981, 14067.648308791953, 14247.501337453139, 14386.712265754417, 14664.486742963945, 6382.521310901794, 9218.631254749735, 11833.585824496446, 12357.691057723629, 12445.315507646805, 11858.584949526725, 11864.347460889734, 12057.457414416196, 12122.818157727464, 12403.441845116811, 12173.087018473827, 12220.45007974661, 12317.199382040139, 12543.3101179436, 12572.748545029232, 8994.460332380078, 9002.369834111549, 9083.318751093562, 9350.43897366133, 9567.282453816131, 9406.811863762823, 12084.51661933548, 12318.568850090203, 12486.875131248571, 12609.93695031519], "value": 9354.886583574633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.573572192621, 1458.7520121579328, 1505.7364961131802, 1640.1717132847918, 1815.8002619711838, 8000.159983201767, 8666.480011199325, 8916.108389161082, 8989.820203595933, 9255.44467331959, 9010.72967810965, 9030.413023153507, 9043.864342034874, 9100.726978190649, 9103.271738260939, 2489.526989871923, 2513.7234904160528, 2516.458961323315, 2520.7479252074827, 2523.129520315488, 2428.210831479776, 2527.4945010997876, 2531.746825317472, 2535.378832186117, 2543.160756950211, 2440.0727723465147, 2441.2676197140877, 2501.8999240030375, 2508.5610018246825, 2512.309114993382, 2375.524895020994, 2392.3062311929607, 2400.3999000249937, 2447.290285817111, 2451.644511545816, 2272.977270227293, 2308.0767692922796, 2308.9653655195184, 2309.711286089239, 2334.556434277482, 8781.20969112783, 8880.467171969638, 8970.102989700978, 8975.820483590356, 8988.550572471415, 5275.736213189325, 5388.326459192601, 5389.78440862365, 5395.973020134914, 5408.13469844823, 3554.431290993429, 3580.695640870503, 3619.3123306571665, 3622.3479773640734, 3643.344198044351, 1205.3551350027692, 1227.5212667059855, 1239.609523000261, 1242.8135779633037, 2210.171185805323, 11672.591459298883, 12107.576234831738, 12114.273143611412, 12115.091368147425, 12129.21160124598, 4614.284785858197, 4691.601213896789, 4788.0, 4873.537013983666, 4893.7063776173545, 9760.609575617038, 9881.110700036887, 9886.4562449066, 9889.752756181153, 9896.307258491981, 5587.888242235133, 5593.888122237614, 5594.916076258859, 5595.860103497445, 5598.076317407582, 4365.454318210223, 4652.255639097728, 4690.484046754854, 4705.082508910798, 5215.504527069922, 3932.292187406237, 3942.191850670663, 4032.1532478179324, 4062.268791617478, 4064.837406503707, 1223.767484178021, 1226.8957138643316, 1235.0305010566663, 1235.32057368447, 1237.8452693413324, 976.6484065736329, 986.7582442301682, 999.2355847776457, 1003.5784970312486, 1014.2241185493103, 5984.2818861736, 5985.982382994901, 6009.369016253318, 6014.428629280212, 6431.0, 483.6010291509519, 487.97072175668865, 495.7669895149274, 498.9700617962934, 501.30068554366454, 4020.1758639478835, 4165.708400412002, 4331.6534677225745, 4556.658250631216, 4617.46899106607, 10996.670099897015, 11164.441777911072, 11189.160812939062, 11201.495932683049, 11234.831477527843, 11101.611443599597, 11125.833112503318, 11129.499172537255, 11134.888651113548, 11141.721456963478, 7746.38028957682, 8107.959460202661, 8196.385271104571, 8369.49783013021, 8375.916240837636, 6032.6983650818165, 6074.7266373012435, 6140.9692951536745, 6164.753409863555, 6255.687215639291, 9800.509974501103, 10096.19230461576, 10338.741531461774, 10353.63762268317, 10367.896321036693, 9472.810543788948, 9808.068233517804, 10381.169506439617, 10533.9473302633, 10659.573617055541, 7535.773926782205, 7694.730684426242, 7843.372530197685, 7931.682732690628, 8010.639521221442, 8619.094995025433, 8643.654253829776, 8647.221750042527, 8709.91290087091, 8724.083971183189, 7761.92238077612, 7778.688852445839, 7802.726904558313, 7809.726659566888, 7975.082865470546, 7682.270184332479, 7742.264484873928, 7779.338756205786, 7838.764837054898, 7989.800254993672, 7201.927980720336, 7352.338289553966, 7356.043714317105, 7356.190819009797, 7357.484976051625, 5264.552513036435, 5297.602679798953, 5318.920216196682, 5336.09286421317, 5527.032769265443, 5163.793448262028, 5237.266782650356, 5295.973520132375, 5334.253204551288, 5494.5054945055135], "value": 4686.4488882659825, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.844370033485, 352.5804292891459, 357.64414407664367, 359.60084306419856, 361.0720448447489, 5235.502627250415, 5393.164059570763, 5474.2355110669105, 5519.586031047667, 5527.778888844447, 5230.947690523094, 5366.838994830161, 5367.543758780508, 5370.382406023299, 5375.354957405107, 4233.343831706075, 4236.936445953298, 4237.724547904391, 4259.893502662428, 4262.381954616579, 4174.77038762868, 4227.4292970448905, 4252.489701235841, 4270.711552104877, 4288.927768057985, 4207.389928460371, 4208.516020657633, 4215.030542975118, 4217.557156498569, 4233.51314598822, 4204.264253755596, 4204.810783514734, 4226.640735537483, 4248.4052232687445, 4260.488741351027, 3635.745497815154, 3751.9249615007548, 3754.099016236111, 3762.529683789526, 3769.5853456119803, 5259.3951695555115, 5270.525652691276, 5271.367435907678, 5272.683638981635, 5282.498162674539, 4847.394075740533, 4851.927221091686, 4886.6561695533655, 4892.363992680965, 4902.0, 5453.890922181534, 5595.1886976388605, 5646.20953066571, 5648.774049038034, 5694.886102277973, 4115.8971025724595, 4117.608827161415, 4118.19695159444, 4119.732217405859, 4135.648469880064, 5838.328592211865, 5875.648600821793, 5893.675847828367, 5923.585349025613, 5951.49412299955, 4097.713160078766, 4180.665546756252, 4201.705880588391, 4210.7473551587, 4210.7684077375425, 4247.405363249148, 4259.701820872509, 4259.914801703949, 4268.189044081614, 4285.207236661166, 4830.347903033045, 4834.129856625771, 4855.878603034882, 4858.246971719389, 4896.730679812645, 5470.507654311131, 5642.266505354278, 5672.560798856449, 5747.712614369349, 5753.194552762533, 1348.1641382342814, 1357.9049466537444, 1371.35546293242, 1393.7212557488542, 1397.489916180607, 987.8814542254976, 1000.1998401279093, 1006.9446180460145, 1020.6580795433464, 1029.9639512617023, 5405.70268635221, 5405.945940540623, 5411.0, 5416.485433883775, 5419.756110975016, 5713.5714821388565, 5719.914201286984, 5726.398728133569, 5775.16260142277, 5785.768569257267, 5228.137357335997, 5402.594805389612, 5464.480874316933, 5481.095619222783, 5509.173623956439, 2698.892044318205, 2709.4581083782928, 2725.9591106133425, 2739.712335202452, 2749.2164733050986, 5215.322008138917, 5216.400113986864, 5306.575473962073, 5325.813596524103, 5354.892902142014, 5214.296070030573, 5622.184783206412, 5959.880802383928, 5986.371430999682, 5993.940060599425, 5981.820545383733, 5993.580449368589, 6025.337212906665, 6044.879102418015, 6066.361132907199, 5665.461781130786, 5834.766609335748, 5889.852753681021, 5929.199558059607, 5936.851578710567, 5796.362400135898, 5812.18629391894, 5817.272840894888, 5818.7090645466715, 5820.854478638068, 6020.849478763066, 6049.425304596057, 6100.572959892765, 6127.3566275540425, 6142.877142457215, 4098.897527561835, 4211.031462763521, 4223.282042052797, 4223.5565265646665, 4241.87274381769, 5630.268065151504, 5891.882162356815, 5897.616654917417, 5907.666471743723, 5967.6419414835245, 5557.499825015768, 5699.971500142473, 5701.600887937804, 5718.342390625131, 5727.39862314451, 5619.173768525164, 5636.802711905064, 5687.5449964001955, 5711.828645140652, 5723.971380143073, 5543.3902270751, 5595.5803314752375, 5618.157276408408, 5637.0, 5660.85847853807, 5669.376368599368, 5682.204491371129, 5712.285964254468, 5721.771129154788, 5748.252727145445, 5428.37573679032, 5591.210812539948, 5608.551315894637, 5646.971765141148, 5648.758122274827], "value": 4315.774699309973, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.8761741929999, 810.3233799777186, 853.7140058080543, 880.4409200157905, 892.3708785306358, 16065.196740163003, 17241.0, 17303.56741081472, 17321.653566928653, 17382.0, 16045.197740112977, 16511.33954641813, 16527.66944661109, 16542.421015264466, 16586.0, 839.2069494327862, 867.600903584352, 870.8693695945627, 871.1767379826067, 871.716692075075, 878.1964502480223, 881.1937077574012, 882.1090698394604, 883.0639522106555, 883.9071897450772, 925.2228128372166, 926.4070994563485, 927.2257664849858, 927.2442958988403, 927.4852456886425, 917.0829170829171, 917.3716004536881, 922.7831459606987, 923.1138107416888, 923.3628796130648, 674.5210900260821, 675.5642610516238, 676.0535250649131, 676.2730065179951, 676.7665155521337, 16335.509934701979, 16343.591410214722, 16347.509574712778, 16377.754333685005, 16384.0, 15590.298436570381, 15994.0, 16089.597760055975, 16363.672726545521, 16699.83300166995, 12989.740205195843, 13083.803742943768, 13274.46902123914, 13344.466221351135, 13514.32428378577, 4128.876133715993, 4157.064660451374, 4238.258304796648, 4254.170436764832, 4264.701470897038, 90354.5482272591, 90818.5459072707, 91157.0, 91779.0, 91877.5406122965, 11896.762064758655, 11957.760844783055, 12219.26684398939, 12293.463317085365, 12523.812142817866, 23625.0, 23711.881440592686, 23719.644205336936, 23760.524789504114, 23761.0, 8085.151059138823, 8541.95729021351, 8576.099509551408, 8739.43193692408, 8805.471671699719, 5020.523050310215, 5172.327597412387, 5218.739063046833, 5274.472552744772, 5305.495977882095, 3535.7171426285836, 3641.217138315275, 3673.669369756681, 3681.815909204529, 3684.9631503685155, 639.3223183425583, 651.6904470376628, 659.0492143255921, 659.2912618934664, 667.4293479075418, 717.6483523073656, 727.7707522130512, 795.1611050341829, 808.8301456694043, 824.7360844529812, 9789.118979291898, 10381.377117372982, 10399.012093851223, 10599.894001060045, 10618.840717389245, 661.7485355564854, 738.2710169087917, 751.1099347273498, 752.9774106776805, 755.2900273742664, 4968.776405061781, 5009.348784657971, 5090.720010399464, 5108.489151084936, 5132.486751324837, 128316.0, 130263.0, 133647.33176334057, 136012.0, 137968.31015844856, 88871.0, 91527.54236228776, 92344.07655923355, 99865.50067249617, 102260.0, 89924.550377249, 91476.54261728648, 92324.53837730903, 95077.5246123765, 95184.0, 9824.0, 9995.800083998425, 10261.9486902565, 10878.238523303293, 11179.217454778087, 53844.73077634744, 55419.44580554143, 55824.0, 56008.0, 57015.714921425126, 69296.30703692899, 79257.60371198106, 79618.6019069901, 81055.0, 81232.18767812246, 13616.795748063985, 13863.237521936391, 13876.653083672989, 13896.374663140385, 14203.502877399242, 16104.27530761142, 16216.513504594881, 16443.424480143138, 16597.91701041487, 17406.216720247874, 15400.84599154039, 15519.146446945526, 15562.0, 16599.0, 16640.50078497647, 14343.0, 14471.0, 14690.485832995793, 15345.156016419203, 15347.61630959235, 15125.0, 15261.465848695243, 15317.157556334063, 16246.106464144586, 16260.674786503967, 12026.699332516408, 12160.270383777002, 12645.114841961342, 12729.745405092031, 13024.153430027018, 11014.559417623526, 11564.768704626029, 12115.81826272589, 12239.87760122423, 12814.55149069778], "value": 8222.918673633167, "unit": "score"}], "name": "dromaeo_css", "value": 7523.177616660114, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 114.0, 111.0, 113.0, 112.0, 112.0, 111.0, 110.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 127.0, 164.0, 116.0, 119.0, 116.0, 123.0, 159.0, 118.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 159.0, 160.0, 160.0, 162.0, 160.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 106.0, 76.0, 76.0, 76.0, 75.0, 104.0, 75.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 113.0, 81.0, 81.0, 82.0, 111.0, 82.0, 81.0, 104.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 49.0, 49.0, 50.0, 50.0, 51.0, 50.0, 50.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 83.0, 74.0, 75.0, 74.0, 78.0, 73.0, 73.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 134.0, 128.0, 123.0, 119.0, 121.0, 127.0, 118.0, 161.0, 118.0], "value": 127.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 155.0, 154.0, 152.0, 150.0, 154.0, 150.0, 152.0, 155.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 61.0, 61.0, 62.0, 62.0, 65.0, 60.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1458.1, "alertThreshold": 2.0}]} 15:10:44 INFO - Return code: 0 15:10:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:10:44 INFO - # TBPL SUCCESS # 15:10:44 INFO - Running post-action listener: _resource_record_post_action 15:10:44 INFO - [mozharness: 2016-10-14 22:10:44.202845Z] Finished run-tests step (success) 15:10:44 INFO - Running post-run listener: _resource_record_post_run 15:10:44 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 367063040; Read time: 40; Write time: 207616 15:10:44 INFO - TinderboxPrint: CPU usage
12.9% 15:10:44 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 40 15:10:44 INFO - TinderboxPrint: I/O write bytes / time
367,063,040 / 207,616 15:10:44 INFO - TinderboxPrint: CPU idle
8,269.8 (87.1%) 15:10:44 INFO - TinderboxPrint: CPU user
1,184.4 (12.5%) 15:10:44 INFO - TinderboxPrint: Swap in / out
0 / 0 15:10:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 119173120; Read time: 0; Write time: 66872 15:10:44 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247881728; Read time: 20; Write time: 140744 15:10:44 INFO - Running post-run listener: _upload_blobber_files 15:10:44 INFO - Blob upload gear active. 15:10:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:10:44 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 15:10:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:10:45 INFO - (blobuploader) - INFO - Open directory for files ... 15:10:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:10:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:10:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:46 INFO - (blobuploader) - INFO - Done attempting. 15:10:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:10:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:52 INFO - (blobuploader) - INFO - Done attempting. 15:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:10:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:10:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:10:52 INFO - (blobuploader) - INFO - Done attempting. 15:10:52 INFO - (blobuploader) - INFO - Iteration through files over. 15:10:52 INFO - Return code: 0 15:10:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:10:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:10:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45f0b3cde17e44091eba2ffeaec7f706c44da6c930fdd2c4c356fb6a205581985762d3a05edb5550fb3fc636da03ef8f49c8a8fda2d8932e868e52030182548b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab95bcc173902f5e90c742e81bb7ae9961aaa1fa803ead25f716173ffcbad4697dfc16c5b5d138c004fe6b6c5b3c398a0c40fc32b0b69a440e315b1b70b72db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412cc0195be6482506e02dcda3dbd13aa30735db3d6ee7fdb5a0d7d43e20aafb635b8f3cd24ae44f003c164301dd82d5bb3b748964ded7cf74d0f5a328f542d8"} 15:10:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:10:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:10:52 INFO - Contents: 15:10:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45f0b3cde17e44091eba2ffeaec7f706c44da6c930fdd2c4c356fb6a205581985762d3a05edb5550fb3fc636da03ef8f49c8a8fda2d8932e868e52030182548b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab95bcc173902f5e90c742e81bb7ae9961aaa1fa803ead25f716173ffcbad4697dfc16c5b5d138c004fe6b6c5b3c398a0c40fc32b0b69a440e315b1b70b72db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412cc0195be6482506e02dcda3dbd13aa30735db3d6ee7fdb5a0d7d43e20aafb635b8f3cd24ae44f003c164301dd82d5bb3b748964ded7cf74d0f5a328f542d8"} 15:10:52 INFO - Running post-run listener: copy_logs_to_upload_dir 15:10:52 INFO - Copying logs to upload dir... 15:10:52 INFO - mkdir: /builds/slave/test/build/upload/logs 15:10:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.781094 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-14 15:10:52.423831) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:10:52.427169) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45f0b3cde17e44091eba2ffeaec7f706c44da6c930fdd2c4c356fb6a205581985762d3a05edb5550fb3fc636da03ef8f49c8a8fda2d8932e868e52030182548b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab95bcc173902f5e90c742e81bb7ae9961aaa1fa803ead25f716173ffcbad4697dfc16c5b5d138c004fe6b6c5b3c398a0c40fc32b0b69a440e315b1b70b72db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412cc0195be6482506e02dcda3dbd13aa30735db3d6ee7fdb5a0d7d43e20aafb635b8f3cd24ae44f003c164301dd82d5bb3b748964ded7cf74d0f5a328f542d8"} build_url:https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/fTDruzQRRZujePHpQQqT2g/artifacts/public/build/firefox-51.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45f0b3cde17e44091eba2ffeaec7f706c44da6c930fdd2c4c356fb6a205581985762d3a05edb5550fb3fc636da03ef8f49c8a8fda2d8932e868e52030182548b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab95bcc173902f5e90c742e81bb7ae9961aaa1fa803ead25f716173ffcbad4697dfc16c5b5d138c004fe6b6c5b3c398a0c40fc32b0b69a440e315b1b70b72db4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/412cc0195be6482506e02dcda3dbd13aa30735db3d6ee7fdb5a0d7d43e20aafb635b8f3cd24ae44f003c164301dd82d5bb3b748964ded7cf74d0f5a328f542d8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 15:10:52.453153) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:10:52.453709) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1476480300.23107-297575161 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004417 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 15:10:52.535790) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:10:52.536099) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 15:10:52.536416) ========= ========= Total master_lag: 0.14 =========