builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1472340522.86 results: success (0) buildid: 20160827154713 builduid: 0603ca73489a4221b0b8cbc73b1bb88e revision: b02228e2a9eb38fa2a1a947f7943def10c5310be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:42.861182) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:42.861617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:42.861900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:42.924446) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:42.924728) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-27 16:28:43-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-27 16:28:44 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.335925 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.279096) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.279411) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.335355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.335669) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b02228e2a9eb38fa2a1a947f7943def10c5310be --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev b02228e2a9eb38fa2a1a947f7943def10c5310be --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=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-27 16:28:44,392 truncating revision to first 12 chars 2016-08-27 16:28:44,392 Setting DEBUG logging. 2016-08-27 16:28:44,392 attempt 1/10 2016-08-27 16:28:44,392 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b02228e2a9eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-27 16:28:44,661 unpacking tar archive at: fx-team-b02228e2a9eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.558403 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.908264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.908547) ========= script_repo_revision: b02228e2a9eb38fa2a1a947f7943def10c5310be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.908922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.909252) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-27 16:28:43.921424) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-27 16:28:43.921694) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:28:45 INFO - MultiFileLogger online at 20160827 16:28:45 in /builds/slave/test 16:28:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:28:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:28:45 INFO - {'append_to_log': False, 16:28:45 INFO - 'base_work_dir': '/builds/slave/test', 16:28:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:28:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:28:45 INFO - 'branch': 'Fx-Team-Non-PGO', 16:28:45 INFO - 'buildbot_json_path': 'buildprops.json', 16:28:45 INFO - 'config_files': ('talos/linux_config.py',), 16:28:45 INFO - 'default_actions': ('clobber', 16:28:45 INFO - 'read-buildbot-config', 16:28:45 INFO - 'download-and-extract', 16:28:45 INFO - 'populate-webroot', 16:28:45 INFO - 'create-virtualenv', 16:28:45 INFO - 'install', 16:28:45 INFO - 'run-tests'), 16:28:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:28:45 INFO - 'download_minidump_stackwalk': True, 16:28:45 INFO - 'download_symbols': 'ondemand', 16:28:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:28:45 INFO - 'tooltool.py': '/tools/tooltool.py', 16:28:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:28:45 INFO - '/tools/misc-python/virtualenv.py')}, 16:28:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:28:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:28:45 INFO - 'installer_path': 'installer.exe', 16:28:45 INFO - 'log_level': 'info', 16:28:45 INFO - 'log_name': 'talos', 16:28:45 INFO - 'log_to_console': True, 16:28:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:28:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:28:45 INFO - 'opt_config_files': (), 16:28:45 INFO - 'pip_index': False, 16:28:45 INFO - 'sps_profile': False, 16:28:45 INFO - 'sps_profile_interval': 0, 16:28:45 INFO - 'suite': 'dromaeojs', 16:28:45 INFO - 'system_bits': '32', 16:28:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:28:45 INFO - 'title': 'talos-linux64-ix-061', 16:28:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:28:45 INFO - 'use_talos_json': True, 16:28:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:28:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:28:45 INFO - 'work_dir': 'build'} 16:28:45 INFO - [mozharness: 2016-08-27 23:28:45.076980Z] Running clobber step. 16:28:45 INFO - Running pre-action listener: _resource_record_pre_action 16:28:45 INFO - Running main action method: clobber 16:28:45 INFO - rmtree: /builds/slave/test/build 16:28:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:28:45 INFO - Running post-action listener: _resource_record_post_action 16:28:45 INFO - [mozharness: 2016-08-27 23:28:45.540530Z] Finished clobber step (success) 16:28:45 INFO - [mozharness: 2016-08-27 23:28:45.540632Z] Running read-buildbot-config step. 16:28:45 INFO - Running pre-action listener: _resource_record_pre_action 16:28:45 INFO - Running main action method: read_buildbot_config 16:28:45 INFO - Using buildbot properties: 16:28:45 INFO - { 16:28:45 INFO - "project": "", 16:28:45 INFO - "product": "firefox", 16:28:45 INFO - "script_repo_revision": "production", 16:28:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:28:45 INFO - "repository": "", 16:28:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:28:45 INFO - "buildid": "20160827154713", 16:28:45 INFO - "pgo_build": "False", 16:28:45 INFO - "basedir": "/builds/slave/test", 16:28:45 INFO - "buildnumber": 1897, 16:28:45 INFO - "slavename": "talos-linux64-ix-061", 16:28:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:28:45 INFO - "platform": "ubuntu64_hw", 16:28:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:28:45 INFO - "branch": "fx-team", 16:28:45 INFO - "repo_path": "integration/fx-team", 16:28:45 INFO - "revision": "b02228e2a9eb38fa2a1a947f7943def10c5310be", 16:28:45 INFO - "stage_platform": "linux64", 16:28:45 INFO - "builduid": "0603ca73489a4221b0b8cbc73b1bb88e", 16:28:45 INFO - "slavebuilddir": "test" 16:28:45 INFO - } 16:28:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:28:45 INFO - Running post-action listener: _resource_record_post_action 16:28:45 INFO - [mozharness: 2016-08-27 23:28:45.543070Z] Finished read-buildbot-config step (success) 16:28:45 INFO - [mozharness: 2016-08-27 23:28:45.543161Z] Running download-and-extract step. 16:28:45 INFO - Running pre-action listener: _resource_record_pre_action 16:28:45 INFO - Running main action method: download_and_extract 16:28:45 INFO - mkdir: /builds/slave/test/build/tests 16:28: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')]} 16:28:45 INFO - trying https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:28:45 INFO - Downloading https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:28:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:28:46 INFO - Downloaded 1361 bytes. 16:28:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:28:46 INFO - Using the following test package requirements: 16:28:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:28:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:28:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'jsshell-linux-x86_64.zip'], 16:28:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:28:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:28:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:28:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:28:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:28:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:28:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:28:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:46 INFO - trying https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:28:46 INFO - Downloading https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:28:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:28:47 INFO - Downloaded 20304670 bytes. 16:28:47 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:28:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:28:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:51 INFO - trying https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:28:51 INFO - Downloading https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:28:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:28:52 INFO - Downloaded 20304670 bytes. 16:28:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 16:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:57 INFO - trying https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:57 INFO - Downloading https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:28:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:28:58 INFO - Downloaded 14413998 bytes. 16:28:58 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 16:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:28:59 INFO - trying https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:59 INFO - Downloading https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:28:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:29:01 INFO - Downloaded 55859777 bytes. 16:29:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:29:01 INFO - mkdir: /builds/slave/test/properties 16:29:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:29:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:29:01 INFO - Contents: 16:29:01 INFO - build_url:https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:29:01 INFO - Running post-action listener: _resource_record_post_action 16:29:01 INFO - Running post-action listener: set_extra_try_arguments 16:29:01 INFO - [mozharness: 2016-08-27 23:29:01.987063Z] Finished download-and-extract step (success) 16:29:01 INFO - [mozharness: 2016-08-27 23:29:01.987291Z] Running populate-webroot step. 16:29:01 INFO - Running pre-action listener: _resource_record_pre_action 16:29:01 INFO - Running main action method: populate_webroot 16:29:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:29:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:29:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:29:01 INFO - '--tppagecycles', 16:29:01 INFO - '7'], 16:29:01 INFO - 'tests': ['tsvgm']}}, 16:29:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:29:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:29:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:29:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:29:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:29:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:29:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:01 INFO - 'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:29:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['damp', 'tps']}, 16:29:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'tests': ['damp', 'tps']}, 16:29:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['dromaeo_dom']}, 16:29:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:29:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['basic_compositor_video']}, 16:29:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:29:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['a11yr', 16:29:02 INFO - 'ts_paint', 16:29:02 INFO - 'tpaint', 16:29:02 INFO - 'sessionrestore', 16:29:02 INFO - 'sessionrestore_no_auto_restore', 16:29:02 INFO - 'tabpaint']}, 16:29:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['tsvgx', 16:29:02 INFO - 'tsvgr_opacity', 16:29:02 INFO - 'tart', 16:29:02 INFO - 'tscrollx', 16:29:02 INFO - 'cart']}, 16:29:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:29:02 INFO - 'tsvgr_opacity', 16:29:02 INFO - 'tart', 16:29:02 INFO - 'tscrollx', 16:29:02 INFO - 'cart']}, 16:29:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'talos_options': ['--disable-e10s'], 16:29:02 INFO - 'tests': ['tp5o']}, 16:29:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'tests': ['tp5o']}, 16:29:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'talos_options': ['--disable-e10s', 16:29:02 INFO - '--xperf_path', 16:29:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:02 INFO - 'tests': ['tp5n']}, 16:29:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:29:02 INFO - 'talos_options': ['--xperf_path', 16:29:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:29:02 INFO - 'tests': ['tp5n']}}, 16:29:02 INFO - 'talos.zip': {'path': '', 16:29:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:29:02 INFO - Running post-action listener: _resource_record_post_action 16:29:02 INFO - [mozharness: 2016-08-27 23:29:02.005995Z] Finished populate-webroot step (success) 16:29:02 INFO - [mozharness: 2016-08-27 23:29:02.006086Z] Running create-virtualenv step. 16:29:02 INFO - Running pre-action listener: _resource_record_pre_action 16:29:02 INFO - Running main action method: create_virtualenv 16:29:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:29:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:29:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:29:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:29:02 INFO - Using real prefix '/usr' 16:29:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:29:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:29:04 INFO - Installing pip.................done. 16:29:04 INFO - Return code: 0 16:29:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:29:04 INFO - Using env: {'DISPLAY': ':0', 16:29:04 INFO - 'HOME': '/home/cltbld', 16:29:04 INFO - 'LANG': 'en_US.UTF-8', 16:29:04 INFO - 'LANGUAGE': 'en_US:en', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MAIL': '/var/mail/cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SHLVL': '1', 16:29:04 INFO - 'TERM': 'linux', 16:29:04 INFO - 'TMOUT': '86400', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - '_': '/tools/buildbot/bin/python'} 16:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:29:04 INFO - Cleaning up... 16:29:04 INFO - Return code: 0 16:29:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:04 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:29:04 INFO - Using env: {'DISPLAY': ':0', 16:29:04 INFO - 'HOME': '/home/cltbld', 16:29:04 INFO - 'LANG': 'en_US.UTF-8', 16:29:04 INFO - 'LANGUAGE': 'en_US:en', 16:29:04 INFO - 'LOGNAME': 'cltbld', 16:29:04 INFO - 'MAIL': '/var/mail/cltbld', 16:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:04 INFO - 'MOZ_NO_REMOTE': '1', 16:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:04 INFO - 'NO_EM_RESTART': '1', 16:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:04 INFO - 'PWD': '/builds/slave/test', 16:29:04 INFO - 'SHELL': '/bin/bash', 16:29:04 INFO - 'SHLVL': '1', 16:29:04 INFO - 'TERM': 'linux', 16:29:04 INFO - 'TMOUT': '86400', 16:29:04 INFO - 'USER': 'cltbld', 16:29:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:04 INFO - '_': '/tools/buildbot/bin/python'} 16:29:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:04 INFO - Downloading/unpacking psutil>=3.1.1 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:29:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:07 INFO - Installing collected packages: psutil 16:29:07 INFO - Running setup.py install for psutil 16:29:07 INFO - building 'psutil._psutil_linux' extension 16:29:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:29:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:29:07 INFO - building 'psutil._psutil_posix' extension 16:29:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:29:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:29:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:29:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:29:07 INFO - Successfully installed psutil 16:29:07 INFO - Cleaning up... 16:29:07 INFO - Return code: 0 16:29:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:07 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:29:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:29:07 INFO - Using env: {'DISPLAY': ':0', 16:29:07 INFO - 'HOME': '/home/cltbld', 16:29:07 INFO - 'LANG': 'en_US.UTF-8', 16:29:07 INFO - 'LANGUAGE': 'en_US:en', 16:29:07 INFO - 'LOGNAME': 'cltbld', 16:29:07 INFO - 'MAIL': '/var/mail/cltbld', 16:29:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:07 INFO - 'MOZ_NO_REMOTE': '1', 16:29:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:07 INFO - 'NO_EM_RESTART': '1', 16:29:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:07 INFO - 'PWD': '/builds/slave/test', 16:29:07 INFO - 'SHELL': '/bin/bash', 16:29:07 INFO - 'SHLVL': '1', 16:29:07 INFO - 'TERM': 'linux', 16:29:07 INFO - 'TMOUT': '86400', 16:29:07 INFO - 'USER': 'cltbld', 16:29:07 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:07 INFO - '_': '/tools/buildbot/bin/python'} 16:29:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:29:09 INFO - Installing collected packages: mozsystemmonitor 16:29:09 INFO - Running setup.py install for mozsystemmonitor 16:29:09 INFO - Successfully installed mozsystemmonitor 16:29:09 INFO - Cleaning up... 16:29:09 INFO - Return code: 0 16:29:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:29: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')]} 16:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29: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')]} 16:29:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:09 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:29:09 INFO - Using env: {'DISPLAY': ':0', 16:29:09 INFO - 'HOME': '/home/cltbld', 16:29:09 INFO - 'LANG': 'en_US.UTF-8', 16:29:09 INFO - 'LANGUAGE': 'en_US:en', 16:29:09 INFO - 'LOGNAME': 'cltbld', 16:29:09 INFO - 'MAIL': '/var/mail/cltbld', 16:29:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:09 INFO - 'MOZ_NO_REMOTE': '1', 16:29:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:09 INFO - 'NO_EM_RESTART': '1', 16:29:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:09 INFO - 'PWD': '/builds/slave/test', 16:29:09 INFO - 'SHELL': '/bin/bash', 16:29:09 INFO - 'SHLVL': '1', 16:29:09 INFO - 'TERM': 'linux', 16:29:09 INFO - 'TMOUT': '86400', 16:29:09 INFO - 'USER': 'cltbld', 16:29:09 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:09 INFO - '_': '/tools/buildbot/bin/python'} 16:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:10 INFO - Downloading/unpacking jsonschema==2.5.1 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:29:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:12 INFO - Downloading functools32-3.2.3-2.tar.gz 16:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:29:12 INFO - warning: no files found matching '*.txt' 16:29:12 INFO - no previously-included directories found matching 'build' 16:29:12 INFO - no previously-included directories found matching 'dist' 16:29:12 INFO - no previously-included directories found matching '.git*' 16:29:12 INFO - Installing collected packages: jsonschema, functools32 16:29:12 INFO - Running setup.py install for functools32 16:29:12 INFO - warning: no files found matching '*.txt' 16:29:12 INFO - no previously-included directories found matching 'build' 16:29:12 INFO - no previously-included directories found matching 'dist' 16:29:12 INFO - no previously-included directories found matching '.git*' 16:29:12 INFO - Successfully installed jsonschema functools32 16:29:12 INFO - Cleaning up... 16:29:12 INFO - Return code: 0 16:29:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:29:12 INFO - Using env: {'DISPLAY': ':0', 16:29:12 INFO - 'HOME': '/home/cltbld', 16:29:12 INFO - 'LANG': 'en_US.UTF-8', 16:29:12 INFO - 'LANGUAGE': 'en_US:en', 16:29:12 INFO - 'LOGNAME': 'cltbld', 16:29:12 INFO - 'MAIL': '/var/mail/cltbld', 16:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:12 INFO - 'MOZ_NO_REMOTE': '1', 16:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:12 INFO - 'NO_EM_RESTART': '1', 16:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:12 INFO - 'PWD': '/builds/slave/test', 16:29:12 INFO - 'SHELL': '/bin/bash', 16:29:12 INFO - 'SHLVL': '1', 16:29:12 INFO - 'TERM': 'linux', 16:29:12 INFO - 'TMOUT': '86400', 16:29:12 INFO - 'USER': 'cltbld', 16:29:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:12 INFO - '_': '/tools/buildbot/bin/python'} 16:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:29:12 INFO - Cleaning up... 16:29:12 INFO - Return code: 0 16:29:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:12 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:29:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:29:12 INFO - Using env: {'DISPLAY': ':0', 16:29:12 INFO - 'HOME': '/home/cltbld', 16:29:12 INFO - 'LANG': 'en_US.UTF-8', 16:29:12 INFO - 'LANGUAGE': 'en_US:en', 16:29:12 INFO - 'LOGNAME': 'cltbld', 16:29:12 INFO - 'MAIL': '/var/mail/cltbld', 16:29:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:12 INFO - 'MOZ_NO_REMOTE': '1', 16:29:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:12 INFO - 'NO_EM_RESTART': '1', 16:29:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:12 INFO - 'PWD': '/builds/slave/test', 16:29:12 INFO - 'SHELL': '/bin/bash', 16:29:12 INFO - 'SHLVL': '1', 16:29:12 INFO - 'TERM': 'linux', 16:29:12 INFO - 'TMOUT': '86400', 16:29:12 INFO - 'USER': 'cltbld', 16:29:12 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:12 INFO - '_': '/tools/buildbot/bin/python'} 16:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:12 INFO - Downloading/unpacking blobuploader==1.2.4 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:29:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:29:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:15 INFO - Downloading docopt-0.6.1.tar.gz 16:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:29:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:29:15 INFO - Running setup.py install for blobuploader 16:29:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:29:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:29:15 INFO - Running setup.py install for requests 16:29:16 INFO - Running setup.py install for docopt 16:29:16 INFO - Successfully installed blobuploader requests docopt 16:29:16 INFO - Cleaning up... 16:29:16 INFO - Return code: 0 16:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:16 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:16 INFO - Using env: {'DISPLAY': ':0', 16:29:16 INFO - 'HOME': '/home/cltbld', 16:29:16 INFO - 'LANG': 'en_US.UTF-8', 16:29:16 INFO - 'LANGUAGE': 'en_US:en', 16:29:16 INFO - 'LOGNAME': 'cltbld', 16:29:16 INFO - 'MAIL': '/var/mail/cltbld', 16:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:16 INFO - 'MOZ_NO_REMOTE': '1', 16:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:16 INFO - 'NO_EM_RESTART': '1', 16:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:16 INFO - 'PWD': '/builds/slave/test', 16:29:16 INFO - 'SHELL': '/bin/bash', 16:29:16 INFO - 'SHLVL': '1', 16:29:16 INFO - 'TERM': 'linux', 16:29:16 INFO - 'TMOUT': '86400', 16:29:16 INFO - 'USER': 'cltbld', 16:29:16 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:16 INFO - '_': '/tools/buildbot/bin/python'} 16:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:16 INFO - Running setup.py (path:/tmp/pip-9kza_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:16 INFO - Running setup.py (path:/tmp/pip-ZIxG_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:16 INFO - Running setup.py (path:/tmp/pip-3TmQQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:16 INFO - Running setup.py (path:/tmp/pip-KZO9pm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:16 INFO - Running setup.py (path:/tmp/pip-_YWTvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:17 INFO - Running setup.py (path:/tmp/pip-aIZkEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:17 INFO - Running setup.py (path:/tmp/pip-TKJmoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:17 INFO - Running setup.py (path:/tmp/pip-QTAU5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:17 INFO - Running setup.py (path:/tmp/pip-nsYmJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:17 INFO - Running setup.py (path:/tmp/pip-IINCEc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:17 INFO - Running setup.py (path:/tmp/pip-zuGew3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:17 INFO - Running setup.py (path:/tmp/pip-CnP2X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:17 INFO - Running setup.py (path:/tmp/pip-tXeB6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:17 INFO - Running setup.py (path:/tmp/pip-bfNs8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:17 INFO - Running setup.py (path:/tmp/pip-SIV5xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:17 INFO - Running setup.py (path:/tmp/pip-5uxfPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:17 INFO - Running setup.py (path:/tmp/pip-WYB3jU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:29:17 INFO - Running setup.py install for manifestparser 16:29:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozcrash 16:29:18 INFO - Running setup.py install for mozdebug 16:29:18 INFO - Running setup.py install for mozdevice 16:29:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozfile 16:29:18 INFO - Running setup.py install for mozhttpd 16:29:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozinfo 16:29:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozInstall 16:29:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for mozleak 16:29:18 INFO - Running setup.py install for mozlog 16:29:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:29:18 INFO - Running setup.py install for moznetwork 16:29:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozprocess 16:29:19 INFO - Running setup.py install for mozprofile 16:29:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozrunner 16:29:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Running setup.py install for mozscreenshot 16:29:19 INFO - Running setup.py install for moztest 16:29:19 INFO - Running setup.py install for mozversion 16:29:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:29:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:29:19 INFO - Cleaning up... 16:29:19 INFO - Return code: 0 16:29:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:19 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:19 INFO - Using env: {'DISPLAY': ':0', 16:29:19 INFO - 'HOME': '/home/cltbld', 16:29:19 INFO - 'LANG': 'en_US.UTF-8', 16:29:19 INFO - 'LANGUAGE': 'en_US:en', 16:29:19 INFO - 'LOGNAME': 'cltbld', 16:29:19 INFO - 'MAIL': '/var/mail/cltbld', 16:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:19 INFO - 'MOZ_NO_REMOTE': '1', 16:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:19 INFO - 'NO_EM_RESTART': '1', 16:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:19 INFO - 'PWD': '/builds/slave/test', 16:29:19 INFO - 'SHELL': '/bin/bash', 16:29:19 INFO - 'SHLVL': '1', 16:29:19 INFO - 'TERM': 'linux', 16:29:19 INFO - 'TMOUT': '86400', 16:29:19 INFO - 'USER': 'cltbld', 16:29:19 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:19 INFO - '_': '/tools/buildbot/bin/python'} 16:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:29:19 INFO - Running setup.py (path:/tmp/pip-Ytbr49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:29:19 INFO - Running setup.py (path:/tmp/pip-kiOLIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:29:20 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)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:29:20 INFO - Running setup.py (path:/tmp/pip-XGDtrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:29:20 INFO - Running setup.py (path:/tmp/pip-0WQogE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:29:20 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)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:29:20 INFO - Running setup.py (path:/tmp/pip-Xer8Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:29:20 INFO - Running setup.py (path:/tmp/pip-fhMS48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:29:20 INFO - Running setup.py (path:/tmp/pip-y26YQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:29:20 INFO - Running setup.py (path:/tmp/pip-3nVi0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:29:20 INFO - Running setup.py (path:/tmp/pip-ufYVUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:29:20 INFO - Running setup.py (path:/tmp/pip-v6ZjXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:29:20 INFO - Running setup.py (path:/tmp/pip-arKW1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:29:20 INFO - Running setup.py (path:/tmp/pip-lDG4xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:29:20 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)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:29:20 INFO - Running setup.py (path:/tmp/pip-LKmHFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:29:20 INFO - Running setup.py (path:/tmp/pip-GTsuux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:29:20 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)) 16:29:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:20 INFO - Running setup.py (path:/tmp/pip-ch2bKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:29:21 INFO - Running setup.py (path:/tmp/pip-juCv8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:29:21 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)) 16:29:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:29:21 INFO - Running setup.py (path:/tmp/pip-R5t8vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:29:21 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)) 16:29:21 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)) 16:29:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:29:21 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)) 16:29:21 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)) 16:29:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:29:23 INFO - Downloading blessings-1.6.tar.gz 16:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:29:23 INFO - Installing collected packages: blessings 16:29:23 INFO - Running setup.py install for blessings 16:29:23 INFO - Successfully installed blessings 16:29:23 INFO - Cleaning up... 16:29:23 INFO - Return code: 0 16:29:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:23 INFO - Reading from file tmpfile_stdout 16:29:23 INFO - Current package versions: 16:29:23 INFO - argparse == 1.2.1 16:29:23 INFO - blessings == 1.6 16:29:23 INFO - blobuploader == 1.2.4 16:29:23 INFO - docopt == 0.6.1 16:29:23 INFO - functools32 == 3.2.3-2 16:29:23 INFO - jsonschema == 2.5.1 16:29:23 INFO - manifestparser == 1.1 16:29:23 INFO - mozInstall == 1.12 16:29:23 INFO - mozcrash == 0.17 16:29:23 INFO - mozdebug == 0.1 16:29:23 INFO - mozdevice == 0.48 16:29:23 INFO - mozfile == 1.2 16:29:23 INFO - mozhttpd == 0.7 16:29:23 INFO - mozinfo == 0.9 16:29:23 INFO - mozleak == 0.1 16:29:23 INFO - mozlog == 3.3 16:29:23 INFO - moznetwork == 0.27 16:29:23 INFO - mozprocess == 0.23 16:29:23 INFO - mozprofile == 0.28 16:29:23 INFO - mozrunner == 6.12 16:29:23 INFO - mozscreenshot == 0.1 16:29:23 INFO - mozsystemmonitor == 0.3 16:29:23 INFO - moztest == 0.7 16:29:23 INFO - mozversion == 1.4 16:29:23 INFO - psutil == 3.1.1 16:29:23 INFO - requests == 1.2.3 16:29:23 INFO - wsgiref == 0.1.2 16:29:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:23 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:29:23 INFO - Using env: {'DISPLAY': ':0', 16:29:23 INFO - 'HOME': '/home/cltbld', 16:29:23 INFO - 'LANG': 'en_US.UTF-8', 16:29:23 INFO - 'LANGUAGE': 'en_US:en', 16:29:23 INFO - 'LOGNAME': 'cltbld', 16:29:23 INFO - 'MAIL': '/var/mail/cltbld', 16:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:23 INFO - 'MOZ_NO_REMOTE': '1', 16:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:23 INFO - 'NO_EM_RESTART': '1', 16:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:23 INFO - 'PWD': '/builds/slave/test', 16:29:23 INFO - 'SHELL': '/bin/bash', 16:29:23 INFO - 'SHLVL': '1', 16:29:23 INFO - 'TERM': 'linux', 16:29:23 INFO - 'TMOUT': '86400', 16:29:23 INFO - 'USER': 'cltbld', 16:29:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:23 INFO - '_': '/tools/buildbot/bin/python'} 16:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:29:23 INFO - Cleaning up... 16:29:23 INFO - Return code: 0 16:29:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:29:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:29:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:29:23 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 0x7f9ff92aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27d6420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:29:23 INFO - Using env: {'DISPLAY': ':0', 16:29:23 INFO - 'HOME': '/home/cltbld', 16:29:23 INFO - 'LANG': 'en_US.UTF-8', 16:29:23 INFO - 'LANGUAGE': 'en_US:en', 16:29:23 INFO - 'LOGNAME': 'cltbld', 16:29:23 INFO - 'MAIL': '/var/mail/cltbld', 16:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:23 INFO - 'MOZ_NO_REMOTE': '1', 16:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:23 INFO - 'NO_EM_RESTART': '1', 16:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:23 INFO - 'PWD': '/builds/slave/test', 16:29:23 INFO - 'SHELL': '/bin/bash', 16:29:23 INFO - 'SHLVL': '1', 16:29:23 INFO - 'TERM': 'linux', 16:29:23 INFO - 'TMOUT': '86400', 16:29:23 INFO - 'USER': 'cltbld', 16:29:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:23 INFO - '_': '/tools/buildbot/bin/python'} 16:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:29:23 INFO - Cleaning up... 16:29:23 INFO - Return code: 0 16:29:23 INFO - Running post-action listener: _resource_record_post_action 16:29:23 INFO - Running post-action listener: _start_resource_monitoring 16:29:23 INFO - Starting resource monitoring. 16:29:23 INFO - [mozharness: 2016-08-27 23:29:23.993784Z] Finished create-virtualenv step (success) 16:29:23 INFO - [mozharness: 2016-08-27 23:29:23.994292Z] Running install step. 16:29:23 INFO - Running pre-action listener: _resource_record_pre_action 16:29:23 INFO - Running main action method: install 16:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:29:24 INFO - Reading from file tmpfile_stdout 16:29:24 INFO - Detecting whether we're running mozinstall >=1.0... 16:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:29:24 INFO - Reading from file tmpfile_stdout 16:29:24 INFO - Output received: 16:29:24 INFO - Usage: mozinstall [options] installer 16:29:24 INFO - Options: 16:29:24 INFO - -h, --help show this help message and exit 16:29:24 INFO - -d DEST, --destination=DEST 16:29:24 INFO - Directory to install application into. [default: 16:29:24 INFO - "/builds/slave/test"] 16:29:24 INFO - --app=APP Application being installed. [default: firefox] 16:29:24 INFO - mkdir: /builds/slave/test/build/application 16:29:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:29:40 INFO - Reading from file tmpfile_stdout 16:29:40 INFO - Output received: 16:29:40 INFO - /builds/slave/test/build/application/firefox/firefox 16:29:40 INFO - Running post-action listener: _resource_record_post_action 16:29:40 INFO - [mozharness: 2016-08-27 23:29:40.437768Z] Finished install step (success) 16:29:40 INFO - [mozharness: 2016-08-27 23:29:40.438110Z] Running run-tests step. 16:29:40 INFO - Running pre-action listener: _resource_record_pre_action 16:29:40 INFO - Running main action method: run_tests 16:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:29:40 INFO - Python 2.7.3 16:29:40 INFO - Return code: 0 16:29:40 INFO - grabbing minidump binary from tooltool 16:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:29:40 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 0x2864d20>, '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 0x2865c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28660b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:29:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:29:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:29:40 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:29:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:29:40 INFO - Return code: 0 16:29:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:29:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:29:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:29:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:29:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 16:29:40 INFO - Using env: {'DISPLAY': ':0', 16:29:40 INFO - 'HOME': '/home/cltbld', 16:29:40 INFO - 'LANG': 'en_US.UTF-8', 16:29:40 INFO - 'LANGUAGE': 'en_US:en', 16:29:40 INFO - 'LOGNAME': 'cltbld', 16:29:40 INFO - 'MAIL': '/var/mail/cltbld', 16:29:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:29:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:29:40 INFO - 'MOZ_NO_REMOTE': '1', 16:29:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:29:40 INFO - 'NO_EM_RESTART': '1', 16:29:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:29:40 INFO - 'PWD': '/builds/slave/test', 16:29:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:29:40 INFO - 'SHELL': '/bin/bash', 16:29:40 INFO - 'SHLVL': '1', 16:29:40 INFO - 'TERM': 'linux', 16:29:40 INFO - 'TMOUT': '86400', 16:29:40 INFO - 'USER': 'cltbld', 16:29:40 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625', 16:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:29:40 INFO - '_': '/tools/buildbot/bin/python'} 16:29:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 16:29:40 INFO - mozversion application_buildid: 20160827154713 16:29:40 INFO - mozversion application_changeset: b02228e2a9eb38fa2a1a947f7943def10c5310be 16:29:40 INFO - mozversion application_display_name: Nightly 16:29:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:29:40 INFO - mozversion application_name: Firefox 16:29:40 INFO - mozversion application_remotingname: firefox 16:29:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:29:40 INFO - mozversion application_vendor: Mozilla 16:29:40 INFO - mozversion application_version: 51.0a1 16:29:40 INFO - mozversion platform_buildid: 20160827154713 16:29:40 INFO - mozversion platform_changeset: b02228e2a9eb38fa2a1a947f7943def10c5310be 16:29:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:29:40 INFO - mozversion platform_version: 51.0a1 16:29:40 INFO - using testdate: 1472340580 16:29:40 INFO - actual date: 1472340580 16:29:40 INFO - starting webserver on 'localhost:47876' 16:29:40 INFO - SUITE-START | Running 2 tests 16:29:40 INFO - TEST-START | dromaeo_css 16:29:40 INFO - operating with platform_type : linux_ 16:29:40 INFO - Initialising browser for dromaeo_css test... 16:29:40 INFO - TEST-INFO | started process 23703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjq67i/profile http://localhost:47876/getInfo.html) 16:29:45 INFO - PROCESS | 23703 | __metrics Screen width/height:1600/1200 16:29:45 INFO - PROCESS | 23703 | colorDepth:24 16:29:45 INFO - PROCESS | 23703 | Browser inner width/height: 1024/697 16:29:45 INFO - PROCESS | 23703 | __metrics 16:29:46 INFO - PROCESS | 23703 | 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" 16:29:46 INFO - PROCESS | 23703 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:46 INFO - PROCESS | 23703 | console.error: PushService: 16:29:46 INFO - PROCESS | 23703 | stateChangeProcessEnqueue: Error transitioning state 16:29:46 INFO - PROCESS | 23703 | UnknownError 16:29:47 INFO - TEST-INFO | 23703: exit 0 16:29:47 INFO - Browser initialized. 16:29:47 INFO - Running cycle 1/1 for dromaeo_css test... 16:29:47 INFO - TEST-INFO | started process 23786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCjq67i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:59 INFO - PROCESS | 23786 | RSS: Main: 182476800 16:29:59 INFO - PROCESS | 23786 | 16:30:50 INFO - PROCESS | 23786 | 1472340650986 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] 16:33:04 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47876/tests/dromaeo/cssquery-ext.html) 16:33:05 INFO - PROCESS | 23786 | RSS: Main: 310837248 16:33:05 INFO - PROCESS | 23786 | 16:36:08 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-ext.html (next: http://localhost:47876/tests/dromaeo/cssquery-jquery.html) 16:36:09 INFO - PROCESS | 23786 | RSS: Main: 270127104 16:36:09 INFO - PROCESS | 23786 | 16:39:11 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47876/tests/dromaeo/cssquery-mootools.html) 16:39:12 INFO - PROCESS | 23786 | RSS: Main: 257978368 16:39:12 INFO - PROCESS | 23786 | 16:42:14 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47876/tests/dromaeo/cssquery-prototype.html) 16:42:15 INFO - PROCESS | 23786 | RSS: Main: 218390528 16:42:15 INFO - PROCESS | 23786 | 16:45:18 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47876/tests/dromaeo/cssquery-yui.html) 16:45:18 INFO - PROCESS | 23786 | RSS: Main: 219234304 16:45:18 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | Cycle 1(1): loaded http://localhost:47876/tests/dromaeo/cssquery-yui.html (next: http://localhost:47876/tests/dromaeo/cssquery-dojo.html) 16:48:21 INFO - PROCESS | 23786 | RSS: Main: 303587328 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | __start_tp_report 16:48:21 INFO - PROCESS | 23786 | _x_x_mozilla_page_load 16:48:21 INFO - PROCESS | 23786 | _x_x_mozilla_page_load_details 16:48:21 INFO - PROCESS | 23786 | |i|pagename|runs| 16:48:21 INFO - PROCESS | 23786 | |0;dojo.html;2592.248248008077;2620.6069089636558;2628.8422694638334;2666.5600175970953;2687.0863906271866;4679.064187162573;4725.976370118149;4727.55088266615;4774.665773395864;4861.440934292553;4742.596879265258;4770.570648641621;4783.449903261126;4792.592629626486;4802.207635740107;4380.145871555048;4404.185225733234;4475.30632751924;4484.932726009096;4512.278035514319;4434.911301773963;4436.778161091948;4442.62237709795;4454.376387305763;4467.41923549938;4394.802233899466;4537.205988951937;4538.00163963929;4551.522090180533;4565.497795242521;4255.8084886180195;4358.564143585648;4388.385626012361;4416.602505774464;4436.64506839452;4272.6795490338345;4302.290122129845;4357.41174941382;4373.562643735633;4384.188925048876;4746.5490778376;4748.810047598092;4764.142454358214;4822.927656085161;4856.198727210006;5133.281340612317;5161.81933632321;5173.58611311098;5176.8964620707375;5242.8689282767855;5029.245613158019;5031.496850314976;5074.782052307457;5075.213341932006;5095.159298715707;4663.813447462064;4707.788149533313;4714.599259062949;4714.787834547454;4787.16224660683;5079.568236699848;5187.507186817246;5197.948020519822;5200.375954885438;5247.527722504993;4987.725675087832;5041.546260836469;5053.9241911371355;5061.519155680205;5127.46161653021;5133.922991155136;5134.306868572769;5137.2037334213255;5149;5192.844214673566;4948.529889660476;5106.234064890296;5110.97444512775;5112.105381558213;5119.692818430832;4949.183384741477;4993.625478089158;5000.099982003201;5058.317127187856;5063.367079115111;4339.5660433956355;4343.5656434356315;4344.45694288214;4395.077033822869;4395.626371758436;3756.7370284079852;3784.4890939723336;3820.1786615877163;3820.7707537547835;3824.7131465140224;4292.806823692878;4353.10761293934;4365.694401391936;4370.978145109254;4413.977930110329;5148.150555158357;5148.330717006766;5151.175811870083;5154.948450515447;5200.271961925334;4413.646908247332;4418.447694038246;4419.248727716296;4454.57681520255;4480.327950807405;4533.229351010336;4589.609883159902;4617.422822147231;4618.1918164321105;4630.976845115752;4796.304535842353;4814.037192561572;4815.3499277597075;4871.658983871095;4879.146149423907;5115.667481613683;5118.718470484159;5125.051865404912;5137.383513978197;5145.382554093533;4726.62187025044;4788;4819.566239038503;4844.612431005582;4849.684770489906;5076.111680455831;5080.695158290514;5081.034603425337;5081.161608334583;5152.072626927189;5088.847334579968;5091.719955402488;5094.949050509447;5101.6173786966865;5150.304708864255;4961.677490963076;4990.775415106256;5016.799328026838;5024.673396229234;5044.394672639307;5026.396832380138;5034.647574669738;5034.874128146826;5039;5066.72133032672;4944.456109827845;4952.1828898232825;4958.677685950402;4970.279309500174;5015.523525265094;4860.92708609364;4912.533309335608;4989.575886049582;4991.80032798684;5027;4870.683405578626;4888.266759986031;4893.363862697826;4914.852554423373;4943.555080042814 16:48:21 INFO - PROCESS | 23786 | |1;ext.html;533.0671325180933;536.7477285675731;550.1472717288202;558.9776408943643;572.2446370790557;25868.74131258687;28882.42235155298;37396.06509837259;37836.43245351322;37946.430803537965;37116.44325335122;37422;37551.248975020484;37589.436158457574;37694.62305376946;7364.926350736504;7500.474966752329;7500.549967001997;7508.8122796929965;7516;7557.47097703161;7633.084029916417;7647.732329368473;7648.196939321375;7652.464327497078;7681.923180768176;7727.072751269828;7727.61361931904;7729.111152217511;7747.109082455533;7645.350145237661;7668.233176682343;7689.807754806118;7704.3451306639;7706;7540.6229688515905;7585.81035474112;7598.582077985709;7603.7338693145475;7605.619719014083;36018.09954751126;36332;36362.27275454476;36400.27199456022;36412.0896977575;2762.958555621667;2856.957145642796;2862.155664079081;3015.9547606785914;3247.3667634811222;27507.17478475649;27544.586831197346;27636.861815690994;27889.58165627517;28374.574381384296;3223.4358987177384;3247.626522949867;3296.307775367176;3315.5689760331;3332.500124981248;241634;241809;242461;242466;243075;47586.76206619014;47823.282650760266;47854;47884.760576196895;47911.28133078007;31633;32594.511082333785;32652.183695407806;33875.83062084674;33924.15189620279;14608.488702895347;14807.70384592302;14818.777718334233;14835.184064876536;14843.554693359216;11173.776524469466;11226.326420414802;11227.27022743519;11231.887681123248;11246.775064498665;16965.830341696426;17139.571510712332;17162.656746865243;17212.655746885244;17277.65444691099;6806.659667016629;6875.518713690094;6901.171859376806;6949.131358580177;6966;753.2279413601103;867.1285358214953;878.8462019146624;896.4666023715879;940.191435365585;25821.225363239133;26734.732652673225;26785.464290714077;27222.319442014108;27406.5889011665;862.3313887627461;886.6990209776313;896.5606852642159;916.702071826659;949.9097585729345;13393.73212535744;13905.582832515041;14254.3585538651;14257.714845703027;14539.491117810825;359558;364486;364956;365468;365671;45696.3145552817;46263;46308.3053754194;46478;46505.53494465012;1036.9170466362673;1085.9674209773718;1086.9293495922739;1113.782812351616;1153.371412580146;24356;27333.86333068322;27484.312892177855;27820.44359112766;27824.304392390353;37646;38163.80918095392;38281.234375312895;38292;38331;290568;291869;292290;292947;293502;21118;21168.259110931045;23466.413339665964;24081.75918240795;24284.87857560701;38736.22527549489;39160.80419597884;40076.398854017796;40340.1931961365;41098.38352424776;33634;34441;34487.82756086203;34593;34865;34390.82804585961;34523.82738086294;34827.30345393129;34995.825020874734;35460;33407.331853363285;33546.496802547495;33958.15104622305;34161.658383415845;34186.829065855505;28883.711162888943;31103.222419439695;31139;31238.531422029144;31419;23928;24084.27747167588;24251.300944278435;24417.38956526101;24462.531017369725 16:48:21 INFO - PROCESS | 23786 | |2;jquery.html;342.8975842665829;360.1338780233538;360.7745159275452;365.53029357275886;389.0545973284918;12615.495380184793;14645.926770366146;16470.258838352274;16765.245563949622;17472.737908931376;13876.236806975612;14595.854041459583;14701.1914344711;14807.259637018133;14942.701145977075;4633.559811817872;4804.399450068724;5170.224466330043;5195.246689230059;5195.584353251749;3475.1138459692743;3614.060344310485;5108.872278193056;5181.559567436772;5182.896342073156;3680.0431887709256;3688.409854423293;4015.915702760268;5999.910001349961;6007.609505382136;6050.757969681207;6058.515318774532;6064.666443345593;6065.727042283063;6066.605670631439;5194.71429071401;5345.812896548602;5378.650387724785;5379.623426360117;5380.21986811914;12699.301538415384;12768.170068945488;12790.296533690644;19358.41924742246;20029.29897453582;1684.713598688226;1875.981240187608;1902.6194761047846;2333.4516388648653;2335.673005779175;9304.720858374192;9673.70978870635;9811.803763924752;11117.444127793578;12567.748645027048;1680.420255012019;1703.4463799265288;1712.6489069740674;1781.5278951077976;1796.7843858736906;46067;56167.71916140393;63130;70028.6498567509;70106.9483957736;9644;9841.311108222499;9936.751581210528;9958.601655933826;10069.496525173712;14032.438702451787;14056.789148162785;14059.929700351433;14070.577882663536;14084;6984.580925144508;7013.473989450709;7205.531640443354;7234.855302894018;7244.239354867663;6453.386928241809;6522.478201743849;6558.836029099215;6669.599824010575;6789.796306110825;4294.506131794821;4320.827166913288;4400.251957167289;4437.866863994085;4457.687961842705;1760.5475482726802;1809.7013992691323;1841.0392931528147;1847.464235371754;1849.2048419179612;718.4001358865302;783.6826085435408;806.8345989072226;865.2774932931073;947.2942657720042;15988.36046558148;16559.17204139788;16698.499045028424;16874.74687879683;17519.38682146144;806.1132753970703;810.3719617296524;838.3460900497622;842.4860834890711;889.0131953531575;9073.301251971849;9679;9706.563204655808;9768.827740671164;9846.261530385107;371882;372367;374014;375971;392744;61384;64767;77695.61152194203;78061.21938780653;78961.60519197368;884.7964968057254;892.2326798952765;912.8813254276902;914.0356923445696;916.6929078758691;15806.68386632284;15911.124888131264;16268;16495.505134845975;16697.248623811716;36584.45123323099;37201;37347;37718.62281377261;38615.2276954465;45267.54732452765;47290.76354618205;50563;51540.74229628828;52104.47895521148;7261.273872612696;7535.171131175457;7657.57883316423;7802.921970780447;7845.5684937329;10006.649767258112;11506.712332191762;11989;12246.693832653898;12266.386680665753;10084.243681723754;10220.744481388025;10309.22680798958;10774.245802794043;10885.074768644754;4410.250257456304;6495.610263384212;8957.417767845069;9497.192738617296;9926.702198934043;10320.535575898952;10572.788544228919;10607.628732994308;10726.892731072589;10977.341359518454;7514.849703006019;7528;7563.319301262913;7811.609419529114;7834.255745704149;9157.404768690014;9607.951960240154;10059.446730429896;10261.02520260574;10297.53661085268 16:48:21 INFO - PROCESS | 23786 | |3;mootools.html;1284.3963337231498;1358.178302127213;1358.8369395672514;1605.462170172992;1660.1201363277466;6786.762463313785;7216.458765592575;7372.225916278794;7928.048634163908;7941.404394670401;7277.417806575474;7472.626368681557;7473.738419155331;7485.812854678636;7487.550746955187;2145.9463513412134;2170.848040637156;2171.055590817999;2171.446281198292;2188.3106821351303;1886.7169924511365;1969.9015049247553;2036.684313931343;2101.485136141647;2153.1064608187585;2174.70641463402;2199.516106456577;2201.0315461197024;2201.680756290337;2205.3604454708116;2120.904559294828;2138.8075073243403;2156.3423155937435;2160.5138843760187;2162.1243396424475;2142.3572928121503;2158.0612433591436;2158.136745301876;2158.719366482363;2167.1223154622403;7610.505317154367;7636.656350464243;7673.155952845183;7727.613619319011;7760.340371068466;4483.282674772021;4595.770211489412;4606.585407313358;4611;4623.907521849578;2779.63864697588;2911.083008852205;2940.0444855422074;2950.5279155335043;2972.583838262645;844.3582877013514;891.5943245823134;900.2258058070055;923.4505469245788;924.4607728132651;9826.754331141707;9838.262130340181;9911.851322230172;9945;9961.80076398468;3734.1598140418187;3995.4606128172904;4244.363345498138;4261.062566235423;4262.381954616563;8697;8708.085651006553;8713;8723.302135829119;8884.200421962054;4477.485089214782;4477.776111194427;4477.9924516984065;4482.170798402306;4484.775761211927;4027.1140349123148;4053.1691003344245;4068.8575899843363;4069.7558146511305;4077.041895154636;3401.5407919930985;3460.0830779843363;3476.3047390521997;3494.2312691207894;3534.8055856927604;988.2933702402817;1062.2298833345762;1063.994680026595;1072.6835583502886;1078.5470102556944;674.5581644023173;718.7556230881421;781.968721251155;796.2992566541407;804.6700852650386;4925.13810083234;5001.624878134155;5068.847934561969;5098.9490105098475;5331.786728530893;834.2241715204917;835.2023817254508;848.253536887535;863.568215892054;869.4739682492128;3267.330197309546;3331.1006028372203;3336.132605522582;3441.4149594568985;3539.0267676388685;8754;9193.95403022994;9231.35380523357;9277.350585458953;9308.581113849757;8969.775755606162;9132.589033493508;9151.90848091524;9172.541372931326;9187.724368268962;6840.828979275558;6904.171499420001;6955;6957.304269573002;6991.720331186797;4876.268559716071;4963.950360496493;4992.550670439678;4994.875128121826;5159.17453207485;8145.185481451807;8379.413441059067;8418.95790521068;8491.108433614381;8514.233718965323;8478.32173426112;8678.002029766658;8701.8694719578;8851.60167792438;8852.070532593985;6226.875462490815;6299.30707622152;6605.57063790852;6738.056672066013;6749.122614060141;7573.659185336784;7633.389328853567;7634.50375725576;7637.350825179699;7642.159362470013;6772.25505194438;6842.144731908512;6846.349596788297;6863.965680171567;7039.718411263492;6613.603183808987;6629.303923088007;6645.767398141042;6649.235337936006;6675.732970681119;5605.747741351731;6107.6640784757265;6142.109394137914;6150.292716337678;6162.969185154225;4363.912721745483;4367.366731823804;4391.231534481389;4420.093880754502;4421.867343979686;4316.417283666665;4333.674974376998;4418.889527761831;4465.821367145408;4555.293929440942 16:48:21 INFO - PROCESS | 23786 | |4;prototype.html;296.90647446054504;298.9446952313822;304.81863291341654;310.25383951596405;311.11332701799887;4862.61099112071;4898.730569818658;4898.730569818658;4916.443449406306;4957.529034741703;4807.6153907687385;4809.110314591794;4835.806567737295;4860.562549370556;4866.46468888422;3652.6164752700984;3756.192418629994;3756.6431189037135;3770.415585584225;3778.886633401002;3629.6751685634686;3761.1725420407465;3799.2591444668165;3806.9428958565645;3817.5991520890325;3740.2706472237924;3758.32350176968;3762.400979583666;3773.245350929811;3775.263823554408;3514.5782506099176;3668.156324045458;3747.756395834262;3753.530808648919;3771.4531392948006;3200.2319443333663;3207.182168547029;3214.9517757233425;3215.887443939451;3234.822084785336;4641.398717442477;4662.836800711959;4671.743054132022;4683.648726345504;4704.29435584665;4220.36694495825;4222.5221172589345;4232.746035237865;4233.089885674564;4277.679174061957;4778.4982576829625;5005.774740136702;5019.598432125421;5045.974770126126;5095.859738909667;3594.676479116892;3600.3519366514015;3600.4959305697225;3600.6039335673054;3611.6207798181076;5248.766539863129;5278.392984806758;5295;5308.283381743492;5314.468553144693;3608.6030536640947;3687.2441149564274;3699.1861790406606;3714.7399682022;3725.9441108383394;3724.478572999782;3726.496922915426;3739.718771549353;3741.063265336752;3774.8867533974026;4259.1268789897995;4264.189803937242;4269.295566231599;4277.508086570084;4280.957190428118;4907.950920490821;5039.7228152451235;5060.645754797129;5077.521897500224;5088.491150884956;1284.5953524639708;1289.4262053386153;1293.4373547506864;1298.5519995601503;1301.3493253373313;801.4389927051087;822.8808820004789;834.2616784146074;835.7116794705817;838.6980686952692;4323.286657701444;4335.723745033883;4459.420275364182;4500.482444518857;4516.796744146455;5162.638615296968;5181.844544663666;5193.922091168635;5208.947910520922;5224.249876291485;4467.486239082482;4475.530069342737;4482.574155455227;4485.102979404067;4510.391097201836;2610.955617752876;2736.835789852615;2750.6974232834373;2752.6146339512484;2753.408017276295;4874.683145595525;4877.292792545061;4879;4903.41159060915;4913.434954980152;5044.672096313801;5276.234945932895;5291.259223708684;5297.655652382583;5300.178472336794;4861.440934292531;4871.926921096116;4882.6826256293225;4886.853394398174;4899;5159.380874294959;5164.664296820694;5171.560417364566;5199.636025478331;5205.5835533158015;4938.246992095204;5073.568746656428;5085.982803439253;5134.922976155435;5136.152534831711;4896.755162241945;4904.215325548038;4909.7545122743;4917.754112294299;4928.260760885896;3611.963880361163;3636.7272454565486;3642.417213245868;3669.321175582526;3673.118451571657;5003.799848006039;5175.663581867167;5181.409295352324;5189.351331083614;5206.817761378334;4981.42713587942;4986.650934434555;5026.220935754964;5037.672551284155;5040.605712286634;4901.90196196067;4974.577160941216;4979.302897594267;4982.701037937735;4992.72540010303;4708.976455117702;4908.288298196813;4931.334269873664;4937.654364194472;4951.72765497901;4774.832880849153;4819.542143496362;4981.850544483671;5002.624803139706;5027.9748601258225;4867.3915760529935;4899.730514821719;4933.753312334441;4939.925901111558;4941.604671626334 16:48:21 INFO - PROCESS | 23786 | |5;yui.html;599.9280086389634;615.6983078291637;616.4359610955976;715.8854583266675;725.3689290317425;11370.204085714004;12905.032122590796;12995.610131696041;13026.804597931026;13048.608541743739;12695.301758403284;12928.935355323234;12991.675208119777;13020.804687929665;13023.28371939543;613.524518498163;732.6666366803091;733.0653416893464;761.7181642792175;761.7562380038362;769.5536588778496;771.2095102519934;772.8802035684478;774.624307211005;774.9263819937097;813.5484805932705;815.5351449673689;816.5917041479261;816.7672213419177;816.848882956652;634.2484156274807;760.6919197724931;781.3085419403811;784.4900814470583;808.1918081918081;577.4600748300353;579.0474669169193;580.3818932836516;580.41668123536;580.5007693383686;11606.187566870323;11635.476403561775;11640.243384180001;11722.35527046012;11773.470193841298;11335.603253886075;11434.599789007345;11717.414129293586;11844.289342639384;12192.939035304855;8942;9403.717888463358;11007.844176361526;11095.223334366598;11272.210945233837;3897.4348719435525;3916.099297161669;3926.175503144343;3927;3988.960110398888;51325.74337128291;51367.74316128396;51539.71150721225;51664.48335516634;52049;9235.722928312027;9279.350445468888;9283.164515193665;9306.115918987685;9312.8603070954;16565.08892010951;16567.088810115318;16596;16626.58433539171;16658.08380539058;5828.766849326064;5916.497097746654;5981.581289309794;6048.032314829607;6083.847903802441;3345.9498107528407;3349.179451034512;3357.496375543688;3413.3173365327034;3490.7905525668034;2686.462707458516;2791.497530444499;2799.9860000699864;2800.915972520828;2801.2856721536286;482.47410322748374;484.8739327774804;488.1749842765715;492.1682356816968;496.8310774336743;443.1911761036122;453.80259587079723;457.1291689331828;481.8988611023794;520.2664243416764;6601.470624644046;6782.898256526156;6861.313868613199;7110.253423390573;7181.712731490682;450.63048300393365;464.42643335480653;469.3522938345062;508.69732509156995;521.9947800521946;3287.3260981498734;3378.3412234614507;3387.2548039431285;3507.596626387947;3515.261795023023;54977.45022549803;56387.43612563822;57842.7107864458;104098.4795076035;104696.47651761844;84544;85143;90244;91311.54344228236;91346;61765.691171543855;77275;77408;77530.61234693791;78134.60932695415;6502.967485162544;6636.867262654623;6685.231198412245;6762.087118239171;6933.341332573397;43654.78172609117;43949.12101757883;44807.863449558216;45231;46509;57843.71078144582;60292.397076028676;65723;66369.33630663824;69265.65367173131;8460.703875364332;8583.914160858312;8646.135386461303;8922;9050.773730656787;8851.645934162561;8872.201501864864;9057.230135438562;9102.362834601514;9153.633854646007;9061.13919177677;9156.542172891463;9195.540222988957;9239.953800231226;9286.442813431217;8464.873026904725;8480.618372173143;8511.446755960842;8525.701600443954;8629.827403452022;8245.134260902758;8262.793430164054;8281.461704989157;8284.627191776264;8289.95855020721;7175.605341706257;7215.7474488394755;7307.890381644386;7338.77983660491;7444.962775186306;6726.831829204309;7180.353768160681;7206.927930720835;7270.345668889825;7474.925250747423 16:48:21 INFO - PROCESS | 23786 | __end_tp_report 16:48:21 INFO - PROCESS | 23786 | __start_cc_report 16:48:21 INFO - PROCESS | 23786 | _x_x_mozilla_cycle_collect,1154 16:48:21 INFO - PROCESS | 23786 | __end_cc_report 16:48:21 INFO - PROCESS | 23786 | __startTimestamp1472341701839__endTimestamp 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | ------- Summary: start ------- 16:48:21 INFO - PROCESS | 23786 | Number of tests: 6 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#0] dojo.html Cycles:165 Average:4729.80 Median:4860.93 stddev:496.80 (10.2%) stddev-sans-first:469.18 16:48:21 INFO - PROCESS | 23786 | Values: 2592.2 2620.6 2628.8 2666.6 2687.1 4679.1 4726.0 4727.6 4774.7 4861.4 4742.6 4770.6 4783.4 4792.6 4802.2 4380.1 4404.2 4475.3 4484.9 4512.3 4434.9 4436.8 4442.6 4454.4 4467.4 4394.8 4537.2 4538.0 4551.5 4565.5 4255.8 4358.6 4388.4 4416.6 4436.6 4272.7 4302.3 4357.4 4373.6 4384.2 4746.5 4748.8 4764.1 4822.9 4856.2 5133.3 5161.8 5173.6 5176.9 5242.9 5029.2 5031.5 5074.8 5075.2 5095.2 4663.8 4707.8 4714.6 4714.8 4787.2 5079.6 5187.5 5197.9 5200.4 5247.5 4987.7 5041.5 5053.9 5061.5 5127.5 5133.9 5134.3 5137.2 5149.0 5192.8 4948.5 5106.2 5111.0 5112.1 5119.7 4949.2 4993.6 5000.1 5058.3 5063.4 4339.6 4343.6 4344.5 4395.1 4395.6 3756.7 3784.5 3820.2 3820.8 3824.7 4292.8 4353.1 4365.7 4371.0 4414.0 5148.2 5148.3 5151.2 5154.9 5200.3 4413.6 4418.4 4419.2 4454.6 4480.3 4533.2 4589.6 4617.4 4618.2 4631.0 4796.3 4814.0 4815.3 4871.7 4879.1 5115.7 5118.7 5125.1 5137.4 5145.4 4726.6 4788.0 4819.6 4844.6 4849.7 5076.1 5080.7 5081.0 5081.2 5152.1 5088.8 5091.7 5094.9 5101.6 5150.3 4961.7 4990.8 5016.8 5024.7 5044.4 5026.4 5034.6 5034.9 5039.0 5066.7 4944.5 4952.2 4958.7 4970.3 5015.5 4860.9 4912.5 4989.6 4991.8 5027.0 4870.7 4888.3 4893.4 4914.9 4943.6 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#1] ext.html Cycles:180 Average:44035.16 Median:34505.83 stddev:79851.83 (231.4%) stddev-sans-first:80009.04 16:48:21 INFO - PROCESS | 23786 | Values: 533.1 536.7 550.1 559.0 572.2 25868.7 28882.4 37396.1 37836.4 37946.4 37116.4 37422.0 37551.2 37589.4 37694.6 7364.9 7500.5 7500.5 7508.8 7516.0 7557.5 7633.1 7647.7 7648.2 7652.5 7681.9 7727.1 7727.6 7729.1 7747.1 7645.4 7668.2 7689.8 7704.3 7706.0 7540.6 7585.8 7598.6 7603.7 7605.6 36018.1 36332.0 36362.3 36400.3 36412.1 2763.0 2857.0 2862.2 3016.0 3247.4 27507.2 27544.6 27636.9 27889.6 28374.6 3223.4 3247.6 3296.3 3315.6 3332.5 241634.0 241809.0 242461.0 242466.0 243075.0 47586.8 47823.3 47854.0 47884.8 47911.3 31633.0 32594.5 32652.2 33875.8 33924.2 14608.5 14807.7 14818.8 14835.2 14843.6 11173.8 11226.3 11227.3 11231.9 11246.8 16965.8 17139.6 17162.7 17212.7 17277.7 6806.7 6875.5 6901.2 6949.1 6966.0 753.2 867.1 878.8 896.5 940.2 25821.2 26734.7 26785.5 27222.3 27406.6 862.3 886.7 896.6 916.7 949.9 13393.7 13905.6 14254.4 14257.7 14539.5 359558.0 364486.0 364956.0 365468.0 365671.0 45696.3 46263.0 46308.3 46478.0 46505.5 1036.9 1086.0 1086.9 1113.8 1153.4 24356.0 27333.9 27484.3 27820.4 27824.3 37646.0 38163.8 38281.2 38292.0 38331.0 290568.0 291869.0 292290.0 292947.0 293502.0 21118.0 21168.3 23466.4 24081.8 24284.9 38736.2 39160.8 40076.4 40340.2 41098.4 33634.0 34441.0 34487.8 34593.0 34865.0 34390.8 34523.8 34827.3 34995.8 35460.0 33407.3 33546.5 33958.2 34161.7 34186.8 28883.7 31103.2 31139.0 31238.5 31419.0 23928.0 24084.3 24251.3 24417.4 24462.5 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#2] jquery.html Cycles:180 Average:23282.49 Median:4447.78 stddev:62212.28 (1398.7%) stddev-sans-first:62362.96 16:48:21 INFO - PROCESS | 23786 | Values: 342.9 360.1 360.8 365.5 389.1 12615.5 14645.9 16470.3 16765.2 17472.7 13876.2 14595.9 14701.2 14807.3 14942.7 4633.6 4804.4 5170.2 5195.2 5195.6 3475.1 3614.1 5108.9 5181.6 5182.9 3680.0 3688.4 4015.9 5999.9 6007.6 6050.8 6058.5 6064.7 6065.7 6066.6 5194.7 5345.8 5378.7 5379.6 5380.2 12699.3 12768.2 12790.3 19358.4 20029.3 1684.7 1876.0 1902.6 2333.5 2335.7 9304.7 9673.7 9811.8 11117.4 12567.7 1680.4 1703.4 1712.6 1781.5 1796.8 46067.0 56167.7 63130.0 70028.6 70106.9 9644.0 9841.3 9936.8 9958.6 10069.5 14032.4 14056.8 14059.9 14070.6 14084.0 6984.6 7013.5 7205.5 7234.9 7244.2 6453.4 6522.5 6558.8 6669.6 6789.8 4294.5 4320.8 4400.3 4437.9 4457.7 1760.5 1809.7 1841.0 1847.5 1849.2 718.4 783.7 806.8 865.3 947.3 15988.4 16559.2 16698.5 16874.7 17519.4 806.1 810.4 838.3 842.5 889.0 9073.3 9679.0 9706.6 9768.8 9846.3 371882.0 372367.0 374014.0 375971.0 392744.0 61384.0 64767.0 77695.6 78061.2 78961.6 884.8 892.2 912.9 914.0 916.7 15806.7 15911.1 16268.0 16495.5 16697.2 36584.5 37201.0 37347.0 37718.6 38615.2 45267.5 47290.8 50563.0 51540.7 52104.5 7261.3 7535.2 7657.6 7802.9 7845.6 10006.6 11506.7 11989.0 12246.7 12266.4 10084.2 10220.7 10309.2 10774.2 10885.1 4410.3 6495.6 8957.4 9497.2 9926.7 10320.5 10572.8 10607.6 10726.9 10977.3 7514.8 7528.0 7563.3 7811.6 7834.3 9157.4 9608.0 10059.4 10261.0 10297.5 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#3] mootools.html Cycles:180 Average:4966.94 Median:6124.89 stddev:2749.68 (44.9%) stddev-sans-first:2743.47 16:48:21 INFO - PROCESS | 23786 | Values: 1284.4 1358.2 1358.8 1605.5 1660.1 6786.8 7216.5 7372.2 7928.0 7941.4 7277.4 7472.6 7473.7 7485.8 7487.6 2145.9 2170.8 2171.1 2171.4 2188.3 1886.7 1969.9 2036.7 2101.5 2153.1 2174.7 2199.5 2201.0 2201.7 2205.4 2120.9 2138.8 2156.3 2160.5 2162.1 2142.4 2158.1 2158.1 2158.7 2167.1 7610.5 7636.7 7673.2 7727.6 7760.3 4483.3 4595.8 4606.6 4611.0 4623.9 2779.6 2911.1 2940.0 2950.5 2972.6 844.4 891.6 900.2 923.5 924.5 9826.8 9838.3 9911.9 9945.0 9961.8 3734.2 3995.5 4244.4 4261.1 4262.4 8697.0 8708.1 8713.0 8723.3 8884.2 4477.5 4477.8 4478.0 4482.2 4484.8 4027.1 4053.2 4068.9 4069.8 4077.0 3401.5 3460.1 3476.3 3494.2 3534.8 988.3 1062.2 1064.0 1072.7 1078.5 674.6 718.8 782.0 796.3 804.7 4925.1 5001.6 5068.8 5098.9 5331.8 834.2 835.2 848.3 863.6 869.5 3267.3 3331.1 3336.1 3441.4 3539.0 8754.0 9194.0 9231.4 9277.4 9308.6 8969.8 9132.6 9151.9 9172.5 9187.7 6840.8 6904.2 6955.0 6957.3 6991.7 4876.3 4964.0 4992.6 4994.9 5159.2 8145.2 8379.4 8419.0 8491.1 8514.2 8478.3 8678.0 8701.9 8851.6 8852.1 6226.9 6299.3 6605.6 6738.1 6749.1 7573.7 7633.4 7634.5 7637.4 7642.2 6772.3 6842.1 6846.3 6864.0 7039.7 6613.6 6629.3 6645.8 6649.2 6675.7 5605.7 6107.7 6142.1 6150.3 6163.0 4363.9 4367.4 4391.2 4420.1 4421.9 4316.4 4333.7 4418.9 4465.8 4555.3 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#4] prototype.html Cycles:180 Average:4177.00 Median:4827.67 stddev:1215.59 (25.2%) stddev-sans-first:1183.60 16:48:21 INFO - PROCESS | 23786 | Values: 296.9 298.9 304.8 310.3 311.1 4862.6 4898.7 4898.7 4916.4 4957.5 4807.6 4809.1 4835.8 4860.6 4866.5 3652.6 3756.2 3756.6 3770.4 3778.9 3629.7 3761.2 3799.3 3806.9 3817.6 3740.3 3758.3 3762.4 3773.2 3775.3 3514.6 3668.2 3747.8 3753.5 3771.5 3200.2 3207.2 3215.0 3215.9 3234.8 4641.4 4662.8 4671.7 4683.6 4704.3 4220.4 4222.5 4232.7 4233.1 4277.7 4778.5 5005.8 5019.6 5046.0 5095.9 3594.7 3600.4 3600.5 3600.6 3611.6 5248.8 5278.4 5295.0 5308.3 5314.5 3608.6 3687.2 3699.2 3714.7 3725.9 3724.5 3726.5 3739.7 3741.1 3774.9 4259.1 4264.2 4269.3 4277.5 4281.0 4908.0 5039.7 5060.6 5077.5 5088.5 1284.6 1289.4 1293.4 1298.6 1301.3 801.4 822.9 834.3 835.7 838.7 4323.3 4335.7 4459.4 4500.5 4516.8 5162.6 5181.8 5193.9 5208.9 5224.2 4467.5 4475.5 4482.6 4485.1 4510.4 2611.0 2736.8 2750.7 2752.6 2753.4 4874.7 4877.3 4879.0 4903.4 4913.4 5044.7 5276.2 5291.3 5297.7 5300.2 4861.4 4871.9 4882.7 4886.9 4899.0 5159.4 5164.7 5171.6 5199.6 5205.6 4938.2 5073.6 5086.0 5134.9 5136.2 4896.8 4904.2 4909.8 4917.8 4928.3 3612.0 3636.7 3642.4 3669.3 3673.1 5003.8 5175.7 5181.4 5189.4 5206.8 4981.4 4986.7 5026.2 5037.7 5040.6 4901.9 4974.6 4979.3 4982.7 4992.7 4709.0 4908.3 4931.3 4937.7 4951.7 4774.8 4819.5 4981.9 5002.6 5028.0 4867.4 4899.7 4933.8 4939.9 4941.6 16:48:21 INFO - PROCESS | 23786 | 16:48:21 INFO - PROCESS | 23786 | [#5] yui.html Cycles:180 Average:16141.68 Median:3348.69 stddev:24117.53 (720.2%) stddev-sans-first:24156.95 16:48:21 INFO - PROCESS | 23786 | Values: 599.9 615.7 616.4 715.9 725.4 11370.2 12905.0 12995.6 13026.8 13048.6 12695.3 12928.9 12991.7 13020.8 13023.3 613.5 732.7 733.1 761.7 761.8 769.6 771.2 772.9 774.6 774.9 813.5 815.5 816.6 816.8 816.8 634.2 760.7 781.3 784.5 808.2 577.5 579.0 580.4 580.4 580.5 11606.2 11635.5 11640.2 11722.4 11773.5 11335.6 11434.6 11717.4 11844.3 12192.9 8942.0 9403.7 11007.8 11095.2 11272.2 3897.4 3916.1 3926.2 3927.0 3989.0 51325.7 51367.7 51539.7 51664.5 52049.0 9235.7 9279.4 9283.2 9306.1 9312.9 16565.1 16567.1 16596.0 16626.6 16658.1 5828.8 5916.5 5981.6 6048.0 6083.8 3345.9 3349.2 3357.5 3413.3 3490.8 2686.5 2791.5 2800.0 2800.9 2801.3 482.5 484.9 488.2 492.2 496.8 443.2 453.8 457.1 481.9 520.3 6601.5 6782.9 6861.3 7110.3 7181.7 450.6 464.4 469.4 508.7 522.0 3287.3 3378.3 3387.3 3507.6 3515.3 54977.5 56387.4 57842.7 104098.5 104696.5 84544.0 85143.0 90244.0 91311.5 91346.0 61765.7 77275.0 77408.0 77530.6 78134.6 6503.0 6636.9 6685.2 6762.1 6933.3 43654.8 43949.1 44807.9 45231.0 46509.0 57843.7 60292.4 65723.0 66369.3 69265.7 8460.7 8583.9 8646.1 8922.0 9050.8 8851.6 8872.2 9057.2 9102.4 9153.6 9061.1 9156.5 9195.5 9240.0 9286.4 8464.9 8480.6 8511.4 8525.7 8629.8 8245.1 8262.8 8281.5 8284.6 8290.0 7175.6 7215.7 7307.9 7338.8 7445.0 6726.8 7180.4 7206.9 7270.3 7474.9 16:48:21 INFO - PROCESS | 23786 | -------- Summary: end -------- 16:48:21 INFO - PROCESS | 23786 | 16:48:22 INFO - TEST-INFO | 23786: exit 0 16:48:22 INFO - TEST-OK | dromaeo_css | took 1122122ms 16:48:22 INFO - TEST-START | kraken 16:48:22 INFO - operating with platform_type : linux_ 16:48:22 INFO - Initialising browser for kraken test... 16:48:22 INFO - TEST-INFO | started process 24089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUR_Cg/profile http://localhost:47876/getInfo.html) 16:48:27 INFO - PROCESS | 24089 | __metrics Screen width/height:1600/1200 16:48:27 INFO - PROCESS | 24089 | colorDepth:24 16:48:27 INFO - PROCESS | 24089 | Browser inner width/height: 1024/697 16:48:27 INFO - PROCESS | 24089 | __metrics 16:48:28 INFO - PROCESS | 24089 | 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" 16:48:28 INFO - PROCESS | 24089 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:48:28 INFO - PROCESS | 24089 | console.error: PushService: 16:48:28 INFO - PROCESS | 24089 | stateChangeProcessEnqueue: Error transitioning state 16:48:28 INFO - PROCESS | 24089 | UnknownError 16:48:29 INFO - TEST-INFO | 24089: exit 0 16:48:29 INFO - Browser initialized. 16:48:29 INFO - Running cycle 1/1 for kraken test... 16:48:29 INFO - TEST-INFO | started process 24171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUR_Cg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:41 INFO - PROCESS | 24171 | RSS: Main: 181731328 16:48:41 INFO - PROCESS | 24171 | 16:48:44 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-beat-detection) 16:48:45 INFO - PROCESS | 24171 | RSS: Main: 238931968 16:48:45 INFO - PROCESS | 24171 | 16:48:48 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-dft) 16:48:48 INFO - PROCESS | 24171 | RSS: Main: 225746944 16:48:48 INFO - PROCESS | 24171 | 16:48:52 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-fft) 16:48:52 INFO - PROCESS | 24171 | RSS: Main: 303132672 16:48:52 INFO - PROCESS | 24171 | 16:48:54 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47876/tests/kraken/driver.html?testName=audio-oscillator) 16:48:55 INFO - PROCESS | 24171 | RSS: Main: 213024768 16:48:55 INFO - PROCESS | 24171 | 16:48:57 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:48:58 INFO - PROCESS | 24171 | RSS: Main: 214757376 16:48:58 INFO - PROCESS | 24171 | 16:49:01 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-darkroom) 16:49:02 INFO - PROCESS | 24171 | RSS: Main: 253239296 16:49:02 INFO - PROCESS | 24171 | 16:49:05 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47876/tests/kraken/driver.html?testName=imaging-desaturate) 16:49:06 INFO - PROCESS | 24171 | RSS: Main: 247693312 16:49:06 INFO - PROCESS | 24171 | 16:49:09 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47876/tests/kraken/driver.html?testName=json-parse-financial) 16:49:09 INFO - PROCESS | 24171 | RSS: Main: 250605568 16:49:09 INFO - PROCESS | 24171 | 16:49:11 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47876/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:49:12 INFO - PROCESS | 24171 | RSS: Main: 214274048 16:49:12 INFO - PROCESS | 24171 | 16:49:13 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:49:14 INFO - PROCESS | 24171 | RSS: Main: 221872128 16:49:14 INFO - PROCESS | 24171 | 16:49:16 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:49:17 INFO - PROCESS | 24171 | RSS: Main: 222253056 16:49:17 INFO - PROCESS | 24171 | 16:49:20 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:49:20 INFO - PROCESS | 24171 | RSS: Main: 223350784 16:49:20 INFO - PROCESS | 24171 | 16:49:23 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:49:24 INFO - PROCESS | 24171 | RSS: Main: 221073408 16:49:24 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | Cycle 1(1): loaded http://localhost:47876/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47876/tests/kraken/driver.html?testName=ai-astar) 16:49:26 INFO - PROCESS | 24171 | RSS: Main: 273022976 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | __start_tp_report 16:49:26 INFO - PROCESS | 24171 | _x_x_mozilla_page_load 16:49:26 INFO - PROCESS | 24171 | _x_x_mozilla_page_load_details 16:49:26 INFO - PROCESS | 24171 | |i|pagename|runs| 16:49:26 INFO - PROCESS | 24171 | |0;ai-astar;116;117;131;115;116;116;113;115;113;115 16:49:26 INFO - PROCESS | 24171 | |1;audio-beat-detection;154;123;148;184;130;156;158;126;192;128 16:49:26 INFO - PROCESS | 24171 | |2;audio-dft;163;163;164;163;163;162;162;162;162;162 16:49:26 INFO - PROCESS | 24171 | |3;audio-fft;77;76;77;166;77;76;75;78;160;78 16:49:26 INFO - PROCESS | 24171 | |4;audio-oscillator;84;85;158;85;83;85;141;84;85;137 16:49:26 INFO - PROCESS | 24171 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;119;118;116 16:49:26 INFO - PROCESS | 24171 | |6;imaging-darkroom;148;148;148;146;147;147;146;147;148;147 16:49:26 INFO - PROCESS | 24171 | |7;imaging-desaturate;94;96;95;95;96;96;96;96;95;95 16:49:26 INFO - PROCESS | 24171 | |8;json-parse-financial;63;64;64;64;66;65;67;64;64;64 16:49:26 INFO - PROCESS | 24171 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;66;66;65 16:49:26 INFO - PROCESS | 24171 | |10;stanford-crypto-aes;92;85;85;81;82;81;82;83;81;82 16:49:26 INFO - PROCESS | 24171 | |11;stanford-crypto-ccm;134;131;145;132;141;132;133;133;177;131 16:49:26 INFO - PROCESS | 24171 | |12;stanford-crypto-pbkdf2;175;179;172;173;175;173;178;174;169;171 16:49:26 INFO - PROCESS | 24171 | |13;stanford-crypto-sha256-iterative;73;70;73;70;69;71;69;70;71;69 16:49:26 INFO - PROCESS | 24171 | __end_tp_report 16:49:26 INFO - PROCESS | 24171 | __start_cc_report 16:49:26 INFO - PROCESS | 24171 | _x_x_mozilla_cycle_collect,2009 16:49:26 INFO - PROCESS | 24171 | __end_cc_report 16:49:26 INFO - PROCESS | 24171 | __startTimestamp1472341766499__endTimestamp 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | ------- Summary: start ------- 16:49:26 INFO - PROCESS | 24171 | Number of tests: 14 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#0] ai-astar Cycles:10 Average:116.70 Median:116.00 stddev:5.19 (4.5%) stddev-sans-first:5.49 16:49:26 INFO - PROCESS | 24171 | Values: 116.0 117.0 131.0 115.0 116.0 116.0 113.0 115.0 113.0 115.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:155.00 stddev:24.10 (15.6%) stddev-sans-first:25.52 16:49:26 INFO - PROCESS | 24171 | Values: 154.0 123.0 148.0 184.0 130.0 156.0 158.0 126.0 192.0 128.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 16:49:26 INFO - PROCESS | 24171 | Values: 163.0 163.0 164.0 163.0 163.0 162.0 162.0 162.0 162.0 162.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#3] audio-fft Cycles:10 Average:94.00 Median:77.00 stddev:36.41 (47.3%) stddev-sans-first:38.09 16:49:26 INFO - PROCESS | 24171 | Values: 77.0 76.0 77.0 166.0 77.0 76.0 75.0 78.0 160.0 78.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:84.50 stddev:29.89 (35.4%) stddev-sans-first:30.93 16:49:26 INFO - PROCESS | 24171 | Values: 84.0 85.0 158.0 85.0 83.0 85.0 141.0 84.0 85.0 137.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 16:49:26 INFO - PROCESS | 24171 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 119.0 118.0 116.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 16:49:26 INFO - PROCESS | 24171 | Values: 148.0 148.0 148.0 146.0 147.0 147.0 146.0 147.0 148.0 147.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.53 16:49:26 INFO - PROCESS | 24171 | Values: 94.0 96.0 95.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:1.12 16:49:26 INFO - PROCESS | 24171 | Values: 63.0 64.0 64.0 64.0 66.0 65.0 67.0 64.0 64.0 64.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 16:49:26 INFO - PROCESS | 24171 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 66.0 65.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:82.50 stddev:3.37 (4.1%) stddev-sans-first:1.59 16:49:26 INFO - PROCESS | 24171 | Values: 92.0 85.0 85.0 81.0 82.0 81.0 82.0 83.0 81.0 82.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:133.50 stddev:14.17 (10.6%) stddev-sans-first:14.92 16:49:26 INFO - PROCESS | 24171 | Values: 134.0 131.0 145.0 132.0 141.0 132.0 133.0 133.0 177.0 131.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.50 stddev:3.03 (1.7%) stddev-sans-first:3.19 16:49:26 INFO - PROCESS | 24171 | Values: 175.0 179.0 172.0 173.0 175.0 173.0 178.0 174.0 169.0 171.0 16:49:26 INFO - PROCESS | 24171 | 16:49:26 INFO - PROCESS | 24171 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:1.51 (2.1%) stddev-sans-first:1.30 16:49:26 INFO - PROCESS | 24171 | Values: 73.0 70.0 73.0 70.0 69.0 71.0 69.0 70.0 71.0 69.0 16:49:26 INFO - PROCESS | 24171 | -------- Summary: end -------- 16:49:26 INFO - PROCESS | 24171 | 16:49:27 INFO - TEST-INFO | 24171: exit 0 16:49:27 INFO - TEST-OK | kraken | took 64981ms 16:49:27 INFO - SUITE-END | took 1187s 16:49:28 INFO - Completed test suite (00:19:47) 16:49:28 INFO - javascript benchmark 16:49:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2592.248248008077, 2620.6069089636558, 2628.8422694638334, 2666.5600175970953, 2687.0863906271866, 4679.064187162573, 4725.976370118149, 4727.55088266615, 4774.665773395864, 4861.440934292553, 4742.596879265258, 4770.570648641621, 4783.449903261126, 4792.592629626486, 4802.207635740107, 4380.145871555048, 4404.185225733234, 4475.30632751924, 4484.932726009096, 4512.278035514319, 4434.911301773963, 4436.778161091948, 4442.62237709795, 4454.376387305763, 4467.41923549938, 4394.802233899466, 4537.205988951937, 4538.00163963929, 4551.522090180533, 4565.497795242521, 4255.8084886180195, 4358.564143585648, 4388.385626012361, 4416.602505774464, 4436.64506839452, 4272.6795490338345, 4302.290122129845, 4357.41174941382, 4373.562643735633, 4384.188925048876, 4746.5490778376, 4748.810047598092, 4764.142454358214, 4822.927656085161, 4856.198727210006, 5133.281340612317, 5161.81933632321, 5173.58611311098, 5176.8964620707375, 5242.8689282767855, 5029.245613158019, 5031.496850314976, 5074.782052307457, 5075.213341932006, 5095.159298715707, 4663.813447462064, 4707.788149533313, 4714.599259062949, 4714.787834547454, 4787.16224660683, 5079.568236699848, 5187.507186817246, 5197.948020519822, 5200.375954885438, 5247.527722504993, 4987.725675087832, 5041.546260836469, 5053.9241911371355, 5061.519155680205, 5127.46161653021, 5133.922991155136, 5134.306868572769, 5137.2037334213255, 5149.0, 5192.844214673566, 4948.529889660476, 5106.234064890296, 5110.97444512775, 5112.105381558213, 5119.692818430832, 4949.183384741477, 4993.625478089158, 5000.099982003201, 5058.317127187856, 5063.367079115111, 4339.5660433956355, 4343.5656434356315, 4344.45694288214, 4395.077033822869, 4395.626371758436, 3756.7370284079852, 3784.4890939723336, 3820.1786615877163, 3820.7707537547835, 3824.7131465140224, 4292.806823692878, 4353.10761293934, 4365.694401391936, 4370.978145109254, 4413.977930110329, 5148.150555158357, 5148.330717006766, 5151.175811870083, 5154.948450515447, 5200.271961925334, 4413.646908247332, 4418.447694038246, 4419.248727716296, 4454.57681520255, 4480.327950807405, 4533.229351010336, 4589.609883159902, 4617.422822147231, 4618.1918164321105, 4630.976845115752, 4796.304535842353, 4814.037192561572, 4815.3499277597075, 4871.658983871095, 4879.146149423907, 5115.667481613683, 5118.718470484159, 5125.051865404912, 5137.383513978197, 5145.382554093533, 4726.62187025044, 4788.0, 4819.566239038503, 4844.612431005582, 4849.684770489906, 5076.111680455831, 5080.695158290514, 5081.034603425337, 5081.161608334583, 5152.072626927189, 5088.847334579968, 5091.719955402488, 5094.949050509447, 5101.6173786966865, 5150.304708864255, 4961.677490963076, 4990.775415106256, 5016.799328026838, 5024.673396229234, 5044.394672639307, 5026.396832380138, 5034.647574669738, 5034.874128146826, 5039.0, 5066.72133032672, 4944.456109827845, 4952.1828898232825, 4958.677685950402, 4970.279309500174, 5015.523525265094, 4860.92708609364, 4912.533309335608, 4989.575886049582, 4991.80032798684, 5027.0, 4870.683405578626, 4888.266759986031, 4893.363862697826, 4914.852554423373, 4943.555080042814], "value": 4697.625720245395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [533.0671325180933, 536.7477285675731, 550.1472717288202, 558.9776408943643, 572.2446370790557, 25868.74131258687, 28882.42235155298, 37396.06509837259, 37836.43245351322, 37946.430803537965, 37116.44325335122, 37422.0, 37551.248975020484, 37589.436158457574, 37694.62305376946, 7364.926350736504, 7500.474966752329, 7500.549967001997, 7508.8122796929965, 7516.0, 7557.47097703161, 7633.084029916417, 7647.732329368473, 7648.196939321375, 7652.464327497078, 7681.923180768176, 7727.072751269828, 7727.61361931904, 7729.111152217511, 7747.109082455533, 7645.350145237661, 7668.233176682343, 7689.807754806118, 7704.3451306639, 7706.0, 7540.6229688515905, 7585.81035474112, 7598.582077985709, 7603.7338693145475, 7605.619719014083, 36018.09954751126, 36332.0, 36362.27275454476, 36400.27199456022, 36412.0896977575, 2762.958555621667, 2856.957145642796, 2862.155664079081, 3015.9547606785914, 3247.3667634811222, 27507.17478475649, 27544.586831197346, 27636.861815690994, 27889.58165627517, 28374.574381384296, 3223.4358987177384, 3247.626522949867, 3296.307775367176, 3315.5689760331, 3332.500124981248, 241634.0, 241809.0, 242461.0, 242466.0, 243075.0, 47586.76206619014, 47823.282650760266, 47854.0, 47884.760576196895, 47911.28133078007, 31633.0, 32594.511082333785, 32652.183695407806, 33875.83062084674, 33924.15189620279, 14608.488702895347, 14807.70384592302, 14818.777718334233, 14835.184064876536, 14843.554693359216, 11173.776524469466, 11226.326420414802, 11227.27022743519, 11231.887681123248, 11246.775064498665, 16965.830341696426, 17139.571510712332, 17162.656746865243, 17212.655746885244, 17277.65444691099, 6806.659667016629, 6875.518713690094, 6901.171859376806, 6949.131358580177, 6966.0, 753.2279413601103, 867.1285358214953, 878.8462019146624, 896.4666023715879, 940.191435365585, 25821.225363239133, 26734.732652673225, 26785.464290714077, 27222.319442014108, 27406.5889011665, 862.3313887627461, 886.6990209776313, 896.5606852642159, 916.702071826659, 949.9097585729345, 13393.73212535744, 13905.582832515041, 14254.3585538651, 14257.714845703027, 14539.491117810825, 359558.0, 364486.0, 364956.0, 365468.0, 365671.0, 45696.3145552817, 46263.0, 46308.3053754194, 46478.0, 46505.53494465012, 1036.9170466362673, 1085.9674209773718, 1086.9293495922739, 1113.782812351616, 1153.371412580146, 24356.0, 27333.86333068322, 27484.312892177855, 27820.44359112766, 27824.304392390353, 37646.0, 38163.80918095392, 38281.234375312895, 38292.0, 38331.0, 290568.0, 291869.0, 292290.0, 292947.0, 293502.0, 21118.0, 21168.259110931045, 23466.413339665964, 24081.75918240795, 24284.87857560701, 38736.22527549489, 39160.80419597884, 40076.398854017796, 40340.1931961365, 41098.38352424776, 33634.0, 34441.0, 34487.82756086203, 34593.0, 34865.0, 34390.82804585961, 34523.82738086294, 34827.30345393129, 34995.825020874734, 35460.0, 33407.331853363285, 33546.496802547495, 33958.15104622305, 34161.658383415845, 34186.829065855505, 28883.711162888943, 31103.222419439695, 31139.0, 31238.531422029144, 31419.0, 23928.0, 24084.27747167588, 24251.300944278435, 24417.38956526101, 24462.531017369725], "value": 16437.197305044134, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8975842665829, 360.1338780233538, 360.7745159275452, 365.53029357275886, 389.0545973284918, 12615.495380184793, 14645.926770366146, 16470.258838352274, 16765.245563949622, 17472.737908931376, 13876.236806975612, 14595.854041459583, 14701.1914344711, 14807.259637018133, 14942.701145977075, 4633.559811817872, 4804.399450068724, 5170.224466330043, 5195.246689230059, 5195.584353251749, 3475.1138459692743, 3614.060344310485, 5108.872278193056, 5181.559567436772, 5182.896342073156, 3680.0431887709256, 3688.409854423293, 4015.915702760268, 5999.910001349961, 6007.609505382136, 6050.757969681207, 6058.515318774532, 6064.666443345593, 6065.727042283063, 6066.605670631439, 5194.71429071401, 5345.812896548602, 5378.650387724785, 5379.623426360117, 5380.21986811914, 12699.301538415384, 12768.170068945488, 12790.296533690644, 19358.41924742246, 20029.29897453582, 1684.713598688226, 1875.981240187608, 1902.6194761047846, 2333.4516388648653, 2335.673005779175, 9304.720858374192, 9673.70978870635, 9811.803763924752, 11117.444127793578, 12567.748645027048, 1680.420255012019, 1703.4463799265288, 1712.6489069740674, 1781.5278951077976, 1796.7843858736906, 46067.0, 56167.71916140393, 63130.0, 70028.6498567509, 70106.9483957736, 9644.0, 9841.311108222499, 9936.751581210528, 9958.601655933826, 10069.496525173712, 14032.438702451787, 14056.789148162785, 14059.929700351433, 14070.577882663536, 14084.0, 6984.580925144508, 7013.473989450709, 7205.531640443354, 7234.855302894018, 7244.239354867663, 6453.386928241809, 6522.478201743849, 6558.836029099215, 6669.599824010575, 6789.796306110825, 4294.506131794821, 4320.827166913288, 4400.251957167289, 4437.866863994085, 4457.687961842705, 1760.5475482726802, 1809.7013992691323, 1841.0392931528147, 1847.464235371754, 1849.2048419179612, 718.4001358865302, 783.6826085435408, 806.8345989072226, 865.2774932931073, 947.2942657720042, 15988.36046558148, 16559.17204139788, 16698.499045028424, 16874.74687879683, 17519.38682146144, 806.1132753970703, 810.3719617296524, 838.3460900497622, 842.4860834890711, 889.0131953531575, 9073.301251971849, 9679.0, 9706.563204655808, 9768.827740671164, 9846.261530385107, 371882.0, 372367.0, 374014.0, 375971.0, 392744.0, 61384.0, 64767.0, 77695.61152194203, 78061.21938780653, 78961.60519197368, 884.7964968057254, 892.2326798952765, 912.8813254276902, 914.0356923445696, 916.6929078758691, 15806.68386632284, 15911.124888131264, 16268.0, 16495.505134845975, 16697.248623811716, 36584.45123323099, 37201.0, 37347.0, 37718.62281377261, 38615.2276954465, 45267.54732452765, 47290.76354618205, 50563.0, 51540.74229628828, 52104.47895521148, 7261.273872612696, 7535.171131175457, 7657.57883316423, 7802.921970780447, 7845.5684937329, 10006.649767258112, 11506.712332191762, 11989.0, 12246.693832653898, 12266.386680665753, 10084.243681723754, 10220.744481388025, 10309.22680798958, 10774.245802794043, 10885.074768644754, 4410.250257456304, 6495.610263384212, 8957.417767845069, 9497.192738617296, 9926.702198934043, 10320.535575898952, 10572.788544228919, 10607.628732994308, 10726.892731072589, 10977.341359518454, 7514.849703006019, 7528.0, 7563.319301262913, 7811.609419529114, 7834.255745704149, 9157.404768690014, 9607.951960240154, 10059.446730429896, 10261.02520260574, 10297.53661085268], "value": 7941.755183226806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1284.3963337231498, 1358.178302127213, 1358.8369395672514, 1605.462170172992, 1660.1201363277466, 6786.762463313785, 7216.458765592575, 7372.225916278794, 7928.048634163908, 7941.404394670401, 7277.417806575474, 7472.626368681557, 7473.738419155331, 7485.812854678636, 7487.550746955187, 2145.9463513412134, 2170.848040637156, 2171.055590817999, 2171.446281198292, 2188.3106821351303, 1886.7169924511365, 1969.9015049247553, 2036.684313931343, 2101.485136141647, 2153.1064608187585, 2174.70641463402, 2199.516106456577, 2201.0315461197024, 2201.680756290337, 2205.3604454708116, 2120.904559294828, 2138.8075073243403, 2156.3423155937435, 2160.5138843760187, 2162.1243396424475, 2142.3572928121503, 2158.0612433591436, 2158.136745301876, 2158.719366482363, 2167.1223154622403, 7610.505317154367, 7636.656350464243, 7673.155952845183, 7727.613619319011, 7760.340371068466, 4483.282674772021, 4595.770211489412, 4606.585407313358, 4611.0, 4623.907521849578, 2779.63864697588, 2911.083008852205, 2940.0444855422074, 2950.5279155335043, 2972.583838262645, 844.3582877013514, 891.5943245823134, 900.2258058070055, 923.4505469245788, 924.4607728132651, 9826.754331141707, 9838.262130340181, 9911.851322230172, 9945.0, 9961.80076398468, 3734.1598140418187, 3995.4606128172904, 4244.363345498138, 4261.062566235423, 4262.381954616563, 8697.0, 8708.085651006553, 8713.0, 8723.302135829119, 8884.200421962054, 4477.485089214782, 4477.776111194427, 4477.9924516984065, 4482.170798402306, 4484.775761211927, 4027.1140349123148, 4053.1691003344245, 4068.8575899843363, 4069.7558146511305, 4077.041895154636, 3401.5407919930985, 3460.0830779843363, 3476.3047390521997, 3494.2312691207894, 3534.8055856927604, 988.2933702402817, 1062.2298833345762, 1063.994680026595, 1072.6835583502886, 1078.5470102556944, 674.5581644023173, 718.7556230881421, 781.968721251155, 796.2992566541407, 804.6700852650386, 4925.13810083234, 5001.624878134155, 5068.847934561969, 5098.9490105098475, 5331.786728530893, 834.2241715204917, 835.2023817254508, 848.253536887535, 863.568215892054, 869.4739682492128, 3267.330197309546, 3331.1006028372203, 3336.132605522582, 3441.4149594568985, 3539.0267676388685, 8754.0, 9193.95403022994, 9231.35380523357, 9277.350585458953, 9308.581113849757, 8969.775755606162, 9132.589033493508, 9151.90848091524, 9172.541372931326, 9187.724368268962, 6840.828979275558, 6904.171499420001, 6955.0, 6957.304269573002, 6991.720331186797, 4876.268559716071, 4963.950360496493, 4992.550670439678, 4994.875128121826, 5159.17453207485, 8145.185481451807, 8379.413441059067, 8418.95790521068, 8491.108433614381, 8514.233718965323, 8478.32173426112, 8678.002029766658, 8701.8694719578, 8851.60167792438, 8852.070532593985, 6226.875462490815, 6299.30707622152, 6605.57063790852, 6738.056672066013, 6749.122614060141, 7573.659185336784, 7633.389328853567, 7634.50375725576, 7637.350825179699, 7642.159362470013, 6772.25505194438, 6842.144731908512, 6846.349596788297, 6863.965680171567, 7039.718411263492, 6613.603183808987, 6629.303923088007, 6645.767398141042, 6649.235337936006, 6675.732970681119, 5605.747741351731, 6107.6640784757265, 6142.109394137914, 6150.292716337678, 6162.969185154225, 4363.912721745483, 4367.366731823804, 4391.231534481389, 4420.093880754502, 4421.867343979686, 4316.417283666665, 4333.674974376998, 4418.889527761831, 4465.821367145408, 4555.293929440942], "value": 4003.57013028396, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.90647446054504, 298.9446952313822, 304.81863291341654, 310.25383951596405, 311.11332701799887, 4862.61099112071, 4898.730569818658, 4898.730569818658, 4916.443449406306, 4957.529034741703, 4807.6153907687385, 4809.110314591794, 4835.806567737295, 4860.562549370556, 4866.46468888422, 3652.6164752700984, 3756.192418629994, 3756.6431189037135, 3770.415585584225, 3778.886633401002, 3629.6751685634686, 3761.1725420407465, 3799.2591444668165, 3806.9428958565645, 3817.5991520890325, 3740.2706472237924, 3758.32350176968, 3762.400979583666, 3773.245350929811, 3775.263823554408, 3514.5782506099176, 3668.156324045458, 3747.756395834262, 3753.530808648919, 3771.4531392948006, 3200.2319443333663, 3207.182168547029, 3214.9517757233425, 3215.887443939451, 3234.822084785336, 4641.398717442477, 4662.836800711959, 4671.743054132022, 4683.648726345504, 4704.29435584665, 4220.36694495825, 4222.5221172589345, 4232.746035237865, 4233.089885674564, 4277.679174061957, 4778.4982576829625, 5005.774740136702, 5019.598432125421, 5045.974770126126, 5095.859738909667, 3594.676479116892, 3600.3519366514015, 3600.4959305697225, 3600.6039335673054, 3611.6207798181076, 5248.766539863129, 5278.392984806758, 5295.0, 5308.283381743492, 5314.468553144693, 3608.6030536640947, 3687.2441149564274, 3699.1861790406606, 3714.7399682022, 3725.9441108383394, 3724.478572999782, 3726.496922915426, 3739.718771549353, 3741.063265336752, 3774.8867533974026, 4259.1268789897995, 4264.189803937242, 4269.295566231599, 4277.508086570084, 4280.957190428118, 4907.950920490821, 5039.7228152451235, 5060.645754797129, 5077.521897500224, 5088.491150884956, 1284.5953524639708, 1289.4262053386153, 1293.4373547506864, 1298.5519995601503, 1301.3493253373313, 801.4389927051087, 822.8808820004789, 834.2616784146074, 835.7116794705817, 838.6980686952692, 4323.286657701444, 4335.723745033883, 4459.420275364182, 4500.482444518857, 4516.796744146455, 5162.638615296968, 5181.844544663666, 5193.922091168635, 5208.947910520922, 5224.249876291485, 4467.486239082482, 4475.530069342737, 4482.574155455227, 4485.102979404067, 4510.391097201836, 2610.955617752876, 2736.835789852615, 2750.6974232834373, 2752.6146339512484, 2753.408017276295, 4874.683145595525, 4877.292792545061, 4879.0, 4903.41159060915, 4913.434954980152, 5044.672096313801, 5276.234945932895, 5291.259223708684, 5297.655652382583, 5300.178472336794, 4861.440934292531, 4871.926921096116, 4882.6826256293225, 4886.853394398174, 4899.0, 5159.380874294959, 5164.664296820694, 5171.560417364566, 5199.636025478331, 5205.5835533158015, 4938.246992095204, 5073.568746656428, 5085.982803439253, 5134.922976155435, 5136.152534831711, 4896.755162241945, 4904.215325548038, 4909.7545122743, 4917.754112294299, 4928.260760885896, 3611.963880361163, 3636.7272454565486, 3642.417213245868, 3669.321175582526, 3673.118451571657, 5003.799848006039, 5175.663581867167, 5181.409295352324, 5189.351331083614, 5206.817761378334, 4981.42713587942, 4986.650934434555, 5026.220935754964, 5037.672551284155, 5040.605712286634, 4901.90196196067, 4974.577160941216, 4979.302897594267, 4982.701037937735, 4992.72540010303, 4708.976455117702, 4908.288298196813, 4931.334269873664, 4937.654364194472, 4951.72765497901, 4774.832880849153, 4819.542143496362, 4981.850544483671, 5002.624803139706, 5027.9748601258225, 4867.3915760529935, 4899.730514821719, 4933.753312334441, 4939.925901111558, 4941.604671626334], "value": 3790.586943982998, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.9280086389634, 615.6983078291637, 616.4359610955976, 715.8854583266675, 725.3689290317425, 11370.204085714004, 12905.032122590796, 12995.610131696041, 13026.804597931026, 13048.608541743739, 12695.301758403284, 12928.935355323234, 12991.675208119777, 13020.804687929665, 13023.28371939543, 613.524518498163, 732.6666366803091, 733.0653416893464, 761.7181642792175, 761.7562380038362, 769.5536588778496, 771.2095102519934, 772.8802035684478, 774.624307211005, 774.9263819937097, 813.5484805932705, 815.5351449673689, 816.5917041479261, 816.7672213419177, 816.848882956652, 634.2484156274807, 760.6919197724931, 781.3085419403811, 784.4900814470583, 808.1918081918081, 577.4600748300353, 579.0474669169193, 580.3818932836516, 580.41668123536, 580.5007693383686, 11606.187566870323, 11635.476403561775, 11640.243384180001, 11722.35527046012, 11773.470193841298, 11335.603253886075, 11434.599789007345, 11717.414129293586, 11844.289342639384, 12192.939035304855, 8942.0, 9403.717888463358, 11007.844176361526, 11095.223334366598, 11272.210945233837, 3897.4348719435525, 3916.099297161669, 3926.175503144343, 3927.0, 3988.960110398888, 51325.74337128291, 51367.74316128396, 51539.71150721225, 51664.48335516634, 52049.0, 9235.722928312027, 9279.350445468888, 9283.164515193665, 9306.115918987685, 9312.8603070954, 16565.08892010951, 16567.088810115318, 16596.0, 16626.58433539171, 16658.08380539058, 5828.766849326064, 5916.497097746654, 5981.581289309794, 6048.032314829607, 6083.847903802441, 3345.9498107528407, 3349.179451034512, 3357.496375543688, 3413.3173365327034, 3490.7905525668034, 2686.462707458516, 2791.497530444499, 2799.9860000699864, 2800.915972520828, 2801.2856721536286, 482.47410322748374, 484.8739327774804, 488.1749842765715, 492.1682356816968, 496.8310774336743, 443.1911761036122, 453.80259587079723, 457.1291689331828, 481.8988611023794, 520.2664243416764, 6601.470624644046, 6782.898256526156, 6861.313868613199, 7110.253423390573, 7181.712731490682, 450.63048300393365, 464.42643335480653, 469.3522938345062, 508.69732509156995, 521.9947800521946, 3287.3260981498734, 3378.3412234614507, 3387.2548039431285, 3507.596626387947, 3515.261795023023, 54977.45022549803, 56387.43612563822, 57842.7107864458, 104098.4795076035, 104696.47651761844, 84544.0, 85143.0, 90244.0, 91311.54344228236, 91346.0, 61765.691171543855, 77275.0, 77408.0, 77530.61234693791, 78134.60932695415, 6502.967485162544, 6636.867262654623, 6685.231198412245, 6762.087118239171, 6933.341332573397, 43654.78172609117, 43949.12101757883, 44807.863449558216, 45231.0, 46509.0, 57843.71078144582, 60292.397076028676, 65723.0, 66369.33630663824, 69265.65367173131, 8460.703875364332, 8583.914160858312, 8646.135386461303, 8922.0, 9050.773730656787, 8851.645934162561, 8872.201501864864, 9057.230135438562, 9102.362834601514, 9153.633854646007, 9061.13919177677, 9156.542172891463, 9195.540222988957, 9239.953800231226, 9286.442813431217, 8464.873026904725, 8480.618372173143, 8511.446755960842, 8525.701600443954, 8629.827403452022, 8245.134260902758, 8262.793430164054, 8281.461704989157, 8284.627191776264, 8289.95855020721, 7175.605341706257, 7215.7474488394755, 7307.890381644386, 7338.77983660491, 7444.962775186306, 6726.831829204309, 7180.353768160681, 7206.927930720835, 7270.345668889825, 7474.925250747423], "value": 5826.292098132445, "unit": "score"}], "name": "dromaeo_css", "value": 6152.279673076975, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 131.0, 115.0, 116.0, 116.0, 113.0, 115.0, 113.0, 115.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 148.0, 184.0, 130.0, 156.0, 158.0, 126.0, 192.0, 128.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 163.0, 163.0, 162.0, 162.0, 162.0, 162.0, 162.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 166.0, 77.0, 76.0, 75.0, 78.0, 160.0, 78.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 158.0, 85.0, 83.0, 85.0, 141.0, 84.0, 85.0, 137.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 118.0, 116.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 66.0, 65.0, 67.0, 64.0, 64.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 85.0, 81.0, 82.0, 81.0, 82.0, 83.0, 81.0, 82.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 145.0, 132.0, 141.0, 132.0, 133.0, 133.0, 177.0, 131.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 172.0, 173.0, 175.0, 173.0, 178.0, 174.0, 169.0, 171.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 73.0, 70.0, 69.0, 71.0, 69.0, 70.0, 71.0, 69.0], "value": 70.5, "unit": "score"}], "name": "kraken", "value": 1582.3000000000004, "alertThreshold": 2.0}]} 16:49:28 INFO - Return code: 0 16:49:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:49:28 INFO - # TBPL SUCCESS # 16:49:28 INFO - Running post-action listener: _resource_record_post_action 16:49:28 INFO - [mozharness: 2016-08-27 23:49:28.281405Z] Finished run-tests step (success) 16:49:28 INFO - Running post-run listener: _resource_record_post_run 16:49:28 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405209088; Read time: 8; Write time: 324052 16:49:28 INFO - TinderboxPrint: CPU usage
13.0% 16:49:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:49:28 INFO - TinderboxPrint: I/O write bytes / time
405,209,088 / 324,052 16:49:28 INFO - TinderboxPrint: CPU idle
8,354.2 (86.9%) 16:49:28 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 16:49:28 INFO - TinderboxPrint: Swap in / out
0 / 0 16:49:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114491392; Read time: 0; Write time: 114764 16:49:28 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290717696; Read time: 0; Write time: 209288 16:49:28 INFO - Running post-run listener: _upload_blobber_files 16:49:28 INFO - Blob upload gear active. 16:49:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:49:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:49:29 INFO - Traceback (most recent call last): 16:49:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 16:49:29 INFO - main() 16:49:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 16:49:29 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 16:49:29 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 16:49:29 INFO - return set(response.json().get('whitelist', [])) 16:49:29 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 16:49:29 INFO - return json.loads(self.text or self.content, **kwargs) 16:49:29 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 16:49:29 INFO - return _default_decoder.decode(s) 16:49:29 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 16:49:29 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 16:49:29 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 16:49:29 INFO - raise ValueError("No JSON object could be decoded") 16:49:29 INFO - ValueError: No JSON object could be decoded 16:49:29 ERROR - Return code: 1 16:49:29 INFO - Setting buildbot property blobber_files to {} 16:49:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:49:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:49:29 INFO - Contents: 16:49:29 INFO - blobber_files:{} 16:49:29 INFO - Running post-run listener: copy_logs_to_upload_dir 16:49:29 INFO - Copying logs to upload dir... 16:49:29 INFO - mkdir: /builds/slave/test/build/upload/logs 16:49:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.435595 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-27 16:49:28.367607) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 16:49:28.371544) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/XlLcmA-xQDeP_YJIWK61Jw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-27 16:49:28.424426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:49:28.424895) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1472340278.451706-1005400625 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-27 16:49:28.475801) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 16:49:28.476332) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-27 16:49:28.476638) ========= ========= Total master_lag: 0.17 =========