builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1467782667.39 results: success (0) buildid: 20160705205623 builduid: c4a51a39c70c4e73aafe0e9496136fe5 revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.388757) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.389174) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.389446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.405690) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.405990) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 22:24:27-- 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% 40.4M=0s 2016-07-05 22:24:27 (40.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082611 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.502572) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.502875) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020332 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.555779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:27.556135) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cec1ab33c0d6bdc2638e0e76566a5009f033d949 --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 cec1ab33c0d6bdc2638e0e76566a5009f033d949 --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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 22:24:27,993 truncating revision to first 12 chars 2016-07-05 22:24:27,993 Setting DEBUG logging. 2016-07-05 22:24:27,993 attempt 1/10 2016-07-05 22:24:27,993 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cec1ab33c0d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 22:24:28,296 unpacking tar archive at: fx-team-cec1ab33c0d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:28.211571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:28.211890) ========= script_repo_revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:28.212300) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:28.212568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 22:24:28.221490) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-05 22:24:28.221758) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:24:28 INFO - MultiFileLogger online at 20160705 22:24:28 in /builds/slave/test 22:24:28 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 22:24:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:24:28 INFO - {'append_to_log': False, 22:24:28 INFO - 'base_work_dir': '/builds/slave/test', 22:24:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:24:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:24:28 INFO - 'branch': 'Fx-Team-Non-PGO', 22:24:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:24:28 INFO - 'config_files': ('talos/linux_config.py',), 22:24:28 INFO - 'default_actions': ('clobber', 22:24:28 INFO - 'read-buildbot-config', 22:24:28 INFO - 'download-and-extract', 22:24:28 INFO - 'populate-webroot', 22:24:28 INFO - 'create-virtualenv', 22:24:28 INFO - 'install', 22:24:28 INFO - 'run-tests'), 22:24:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:24:28 INFO - 'download_minidump_stackwalk': True, 22:24:28 INFO - 'download_symbols': 'ondemand', 22:24:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:24:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:24:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:24:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:24:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:24:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:24:28 INFO - 'installer_path': 'installer.exe', 22:24:28 INFO - 'log_level': 'info', 22:24:28 INFO - 'log_name': 'talos', 22:24:28 INFO - 'log_to_console': True, 22:24:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:24:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:24:28 INFO - 'opt_config_files': (), 22:24:28 INFO - 'pip_index': False, 22:24:28 INFO - 'sps_profile': False, 22:24:28 INFO - 'sps_profile_interval': 0, 22:24:28 INFO - 'suite': 'dromaeojs', 22:24:28 INFO - 'system_bits': '32', 22:24:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:24:28 INFO - 'title': 'talos-linux64-ix-051', 22:24:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:24:28 INFO - 'use_talos_json': True, 22:24:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:24:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:24:28 INFO - 'work_dir': 'build'} 22:24:28 INFO - ##### 22:24:28 INFO - ##### Running clobber step. 22:24:28 INFO - ##### 22:24:28 INFO - Running pre-action listener: _resource_record_pre_action 22:24:28 INFO - Running main action method: clobber 22:24:28 INFO - rmtree: /builds/slave/test/build 22:24:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:24:29 INFO - Running post-action listener: _resource_record_post_action 22:24:29 INFO - ##### 22:24:29 INFO - ##### Finished clobber step (success) 22:24:29 INFO - ##### 22:24:29 INFO - ##### 22:24:29 INFO - ##### Running read-buildbot-config step. 22:24:29 INFO - ##### 22:24:29 INFO - Running pre-action listener: _resource_record_pre_action 22:24:29 INFO - Running main action method: read_buildbot_config 22:24:29 INFO - Using buildbot properties: 22:24:29 INFO - { 22:24:29 INFO - "project": "", 22:24:29 INFO - "product": "firefox", 22:24:29 INFO - "script_repo_revision": "production", 22:24:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:24:29 INFO - "repository": "", 22:24:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:24:29 INFO - "buildid": "20160705205623", 22:24:29 INFO - "pgo_build": "False", 22:24:29 INFO - "basedir": "/builds/slave/test", 22:24:29 INFO - "buildnumber": 3133, 22:24:29 INFO - "slavename": "talos-linux64-ix-051", 22:24:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:24:29 INFO - "platform": "ubuntu64_hw", 22:24:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:24:29 INFO - "branch": "fx-team", 22:24:29 INFO - "repo_path": "integration/fx-team", 22:24:29 INFO - "revision": "cec1ab33c0d6bdc2638e0e76566a5009f033d949", 22:24:29 INFO - "stage_platform": "linux64", 22:24:29 INFO - "builduid": "c4a51a39c70c4e73aafe0e9496136fe5", 22:24:29 INFO - "slavebuilddir": "test" 22:24:29 INFO - } 22:24:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:24:29 INFO - Running post-action listener: _resource_record_post_action 22:24:29 INFO - ##### 22:24:29 INFO - ##### Finished read-buildbot-config step (success) 22:24:29 INFO - ##### 22:24:29 INFO - ##### 22:24:29 INFO - ##### Running download-and-extract step. 22:24:29 INFO - ##### 22:24:29 INFO - Running pre-action listener: _resource_record_pre_action 22:24:29 INFO - Running main action method: download_and_extract 22:24:29 INFO - mkdir: /builds/slave/test/build/tests 22:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:29 INFO - https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:24:29 INFO - Downloaded 1361 bytes. 22:24:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:24:29 INFO - Using the following test package requirements: 22:24:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:24:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:24:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:24:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'jsshell-linux-x86_64.zip'], 22:24:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:24:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:24:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:24:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:24:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:24:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:24:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:24:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:24:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:29 INFO - https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:24:30 INFO - Downloaded 22730934 bytes. 22:24:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:24:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:24:32 INFO - Return code: 0 22:24:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:24:32 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:32 INFO - https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:24:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:24:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:24:33 INFO - Downloaded 22730934 bytes. 22:24:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:24:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 22:24:34 INFO - Return code: 0 22:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:34 INFO - https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:24:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:24:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:24:35 INFO - Downloaded 14403333 bytes. 22:24:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 22:24:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 22:24:36 INFO - Return code: 0 22:24:36 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:36 INFO - https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:24:37 INFO - Downloaded 56470904 bytes. 22:24:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:24:37 INFO - mkdir: /builds/slave/test/properties 22:24:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:24:37 INFO - Writing to file /builds/slave/test/properties/build_url 22:24:37 INFO - Contents: 22:24:37 INFO - build_url:https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:24:38 INFO - Running post-action listener: _resource_record_post_action 22:24:38 INFO - Running post-action listener: set_extra_try_arguments 22:24:38 INFO - ##### 22:24:38 INFO - ##### Finished download-and-extract step (success) 22:24:38 INFO - ##### 22:24:38 INFO - ##### 22:24:38 INFO - ##### Running populate-webroot step. 22:24:38 INFO - ##### 22:24:38 INFO - Running pre-action listener: _resource_record_pre_action 22:24:38 INFO - Running main action method: populate_webroot 22:24:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:24:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:24:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:24:38 INFO - '--tppagecycles', 22:24:38 INFO - '7'], 22:24:38 INFO - 'tests': ['tsvgm']}}, 22:24:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:24:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:24:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:24:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:24:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:24:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['damp', 'tps']}, 22:24:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'tests': ['damp', 'tps']}, 22:24:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['dromaeo_dom']}, 22:24:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:24:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['basic_compositor_video']}, 22:24:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:24:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'other-e10s': {'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['a11yr', 22:24:38 INFO - 'ts_paint', 22:24:38 INFO - 'tpaint', 22:24:38 INFO - 'sessionrestore', 22:24:38 INFO - 'sessionrestore_no_auto_restore', 22:24:38 INFO - 'tabpaint']}, 22:24:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['tsvgx', 22:24:38 INFO - 'tsvgr_opacity', 22:24:38 INFO - 'tart', 22:24:38 INFO - 'tscrollx', 22:24:38 INFO - 'cart']}, 22:24:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:24:38 INFO - 'tsvgr_opacity', 22:24:38 INFO - 'tart', 22:24:38 INFO - 'tscrollx', 22:24:38 INFO - 'cart']}, 22:24:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'talos_options': ['--disable-e10s'], 22:24:38 INFO - 'tests': ['tp5o']}, 22:24:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'tests': ['tp5o']}, 22:24:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'talos_options': ['--disable-e10s', 22:24:38 INFO - '--xperf_path', 22:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:38 INFO - 'tests': ['tp5n']}, 22:24:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:24:38 INFO - 'talos_options': ['--xperf_path', 22:24:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:24:38 INFO - 'tests': ['tp5n']}}, 22:24:38 INFO - 'talos.zip': {'path': '', 22:24:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:24:38 INFO - Running post-action listener: _resource_record_post_action 22:24:38 INFO - ##### 22:24:38 INFO - ##### Finished populate-webroot step (success) 22:24:38 INFO - ##### 22:24:38 INFO - ##### 22:24:38 INFO - ##### Running create-virtualenv step. 22:24:38 INFO - ##### 22:24:38 INFO - Running pre-action listener: _resource_record_pre_action 22:24:38 INFO - Running main action method: create_virtualenv 22:24:38 INFO - Creating virtualenv /builds/slave/test/build/venv 22:24:38 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 22:24:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:24:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:24:38 INFO - Using real prefix '/usr' 22:24:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:24:38 INFO - Installing distribute.............................................................................................................................................................................................done. 22:24:40 INFO - Installing pip.................done. 22:24:40 INFO - Return code: 0 22:24:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:40 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:40 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 22:24:40 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 22:24:40 INFO - Using env: {'DISPLAY': ':0', 22:24:40 INFO - 'HOME': '/home/cltbld', 22:24:40 INFO - 'LANG': 'en_US.UTF-8', 22:24:40 INFO - 'LANGUAGE': 'en_US:en', 22:24:40 INFO - 'LOGNAME': 'cltbld', 22:24:40 INFO - 'MAIL': '/var/mail/cltbld', 22:24:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:40 INFO - 'MOZ_NO_REMOTE': '1', 22:24:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:40 INFO - 'NO_EM_RESTART': '1', 22:24:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:40 INFO - 'PWD': '/builds/slave/test', 22:24:40 INFO - 'SHELL': '/bin/bash', 22:24:40 INFO - 'SHLVL': '1', 22:24:40 INFO - 'TERM': 'linux', 22:24:40 INFO - 'TMOUT': '86400', 22:24:40 INFO - 'USER': 'cltbld', 22:24:40 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:40 INFO - '_': '/tools/buildbot/bin/python'} 22:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:41 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 22:24:41 INFO - Cleaning up... 22:24:41 INFO - Return code: 0 22:24:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:24:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:24:41 INFO - Using env: {'DISPLAY': ':0', 22:24:41 INFO - 'HOME': '/home/cltbld', 22:24:41 INFO - 'LANG': 'en_US.UTF-8', 22:24:41 INFO - 'LANGUAGE': 'en_US:en', 22:24:41 INFO - 'LOGNAME': 'cltbld', 22:24:41 INFO - 'MAIL': '/var/mail/cltbld', 22:24:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:41 INFO - 'MOZ_NO_REMOTE': '1', 22:24:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:41 INFO - 'NO_EM_RESTART': '1', 22:24:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:41 INFO - 'PWD': '/builds/slave/test', 22:24:41 INFO - 'SHELL': '/bin/bash', 22:24:41 INFO - 'SHLVL': '1', 22:24:41 INFO - 'TERM': 'linux', 22:24:41 INFO - 'TMOUT': '86400', 22:24:41 INFO - 'USER': 'cltbld', 22:24:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:41 INFO - '_': '/tools/buildbot/bin/python'} 22:24:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:41 INFO - Downloading/unpacking psutil>=3.1.1 22:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:43 INFO - Installing collected packages: psutil 22:24:43 INFO - Running setup.py install for psutil 22:24:43 INFO - building 'psutil._psutil_linux' extension 22:24:43 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 22:24:43 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 22:24:43 INFO - building 'psutil._psutil_posix' extension 22:24:43 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 22:24:43 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 22:24:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:24:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:24:43 INFO - Successfully installed psutil 22:24:43 INFO - Cleaning up... 22:24:43 INFO - Return code: 0 22:24:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:24:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:43 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:43 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 22:24:43 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 22:24:43 INFO - Using env: {'DISPLAY': ':0', 22:24:43 INFO - 'HOME': '/home/cltbld', 22:24:43 INFO - 'LANG': 'en_US.UTF-8', 22:24:43 INFO - 'LANGUAGE': 'en_US:en', 22:24:43 INFO - 'LOGNAME': 'cltbld', 22:24:43 INFO - 'MAIL': '/var/mail/cltbld', 22:24:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:43 INFO - 'MOZ_NO_REMOTE': '1', 22:24:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:43 INFO - 'NO_EM_RESTART': '1', 22:24:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:43 INFO - 'PWD': '/builds/slave/test', 22:24:43 INFO - 'SHELL': '/bin/bash', 22:24:43 INFO - 'SHLVL': '1', 22:24:43 INFO - 'TERM': 'linux', 22:24:43 INFO - 'TMOUT': '86400', 22:24:43 INFO - 'USER': 'cltbld', 22:24:43 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:43 INFO - '_': '/tools/buildbot/bin/python'} 22:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:24:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:24:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:24:46 INFO - Installing collected packages: mozsystemmonitor 22:24:46 INFO - Running setup.py install for mozsystemmonitor 22:24:46 INFO - Successfully installed mozsystemmonitor 22:24:46 INFO - Cleaning up... 22:24:46 INFO - Return code: 0 22:24:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:46 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:46 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 22:24:46 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 22:24:46 INFO - Using env: {'DISPLAY': ':0', 22:24:46 INFO - 'HOME': '/home/cltbld', 22:24:46 INFO - 'LANG': 'en_US.UTF-8', 22:24:46 INFO - 'LANGUAGE': 'en_US:en', 22:24:46 INFO - 'LOGNAME': 'cltbld', 22:24:46 INFO - 'MAIL': '/var/mail/cltbld', 22:24:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:46 INFO - 'MOZ_NO_REMOTE': '1', 22:24:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:46 INFO - 'NO_EM_RESTART': '1', 22:24:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:46 INFO - 'PWD': '/builds/slave/test', 22:24:46 INFO - 'SHELL': '/bin/bash', 22:24:46 INFO - 'SHLVL': '1', 22:24:46 INFO - 'TERM': 'linux', 22:24:46 INFO - 'TMOUT': '86400', 22:24:46 INFO - 'USER': 'cltbld', 22:24:46 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:46 INFO - '_': '/tools/buildbot/bin/python'} 22:24:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:46 INFO - Downloading/unpacking jsonschema==2.5.1 22:24:46 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 22:24:46 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 22:24:46 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 22:24:46 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 22:24:46 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 22:24:46 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 22:24:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:24:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 INFO - Downloading functools32-3.2.3-2.tar.gz 22:24:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:24:48 INFO - warning: no files found matching '*.txt' 22:24:48 INFO - no previously-included directories found matching 'build' 22:24:48 INFO - no previously-included directories found matching 'dist' 22:24:48 INFO - no previously-included directories found matching '.git*' 22:24:48 INFO - Installing collected packages: jsonschema, functools32 22:24:48 INFO - Running setup.py install for functools32 22:24:48 INFO - warning: no files found matching '*.txt' 22:24:48 INFO - no previously-included directories found matching 'build' 22:24:48 INFO - no previously-included directories found matching 'dist' 22:24:48 INFO - no previously-included directories found matching '.git*' 22:24:48 INFO - Successfully installed jsonschema functools32 22:24:48 INFO - Cleaning up... 22:24:48 INFO - Return code: 0 22:24:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:48 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:48 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 22:24:48 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 22:24:48 INFO - Using env: {'DISPLAY': ':0', 22:24:48 INFO - 'HOME': '/home/cltbld', 22:24:48 INFO - 'LANG': 'en_US.UTF-8', 22:24:48 INFO - 'LANGUAGE': 'en_US:en', 22:24:48 INFO - 'LOGNAME': 'cltbld', 22:24:48 INFO - 'MAIL': '/var/mail/cltbld', 22:24:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:48 INFO - 'MOZ_NO_REMOTE': '1', 22:24:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:48 INFO - 'NO_EM_RESTART': '1', 22:24:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:48 INFO - 'PWD': '/builds/slave/test', 22:24:48 INFO - 'SHELL': '/bin/bash', 22:24:48 INFO - 'SHLVL': '1', 22:24:48 INFO - 'TERM': 'linux', 22:24:48 INFO - 'TMOUT': '86400', 22:24:48 INFO - 'USER': 'cltbld', 22:24:48 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:48 INFO - '_': '/tools/buildbot/bin/python'} 22:24:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:48 INFO - Downloading/unpacking blobuploader==1.2.4 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:48 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 22:24:50 INFO - Downloading blobuploader-1.2.4.tar.gz 22:24:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:24:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:24:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:24:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:24:51 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 22:24:51 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 22:24:51 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 22:24:51 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 22:24:51 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 22:24:51 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 22:24:51 INFO - Downloading docopt-0.6.1.tar.gz 22:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:24:51 INFO - Installing collected packages: blobuploader, requests, docopt 22:24:51 INFO - Running setup.py install for blobuploader 22:24:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:24:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:24:51 INFO - Running setup.py install for requests 22:24:52 INFO - Running setup.py install for docopt 22:24:52 INFO - Successfully installed blobuploader requests docopt 22:24:52 INFO - Cleaning up... 22:24:52 INFO - Return code: 0 22:24:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:52 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:52 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 22:24:52 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 22:24:52 INFO - Using env: {'DISPLAY': ':0', 22:24:52 INFO - 'HOME': '/home/cltbld', 22:24:52 INFO - 'LANG': 'en_US.UTF-8', 22:24:52 INFO - 'LANGUAGE': 'en_US:en', 22:24:52 INFO - 'LOGNAME': 'cltbld', 22:24:52 INFO - 'MAIL': '/var/mail/cltbld', 22:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:52 INFO - 'MOZ_NO_REMOTE': '1', 22:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:52 INFO - 'NO_EM_RESTART': '1', 22:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:52 INFO - 'PWD': '/builds/slave/test', 22:24:52 INFO - 'SHELL': '/bin/bash', 22:24:52 INFO - 'SHLVL': '1', 22:24:52 INFO - 'TERM': 'linux', 22:24:52 INFO - 'TMOUT': '86400', 22:24:52 INFO - 'USER': 'cltbld', 22:24:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:52 INFO - '_': '/tools/buildbot/bin/python'} 22:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:52 INFO - Running setup.py (path:/tmp/pip-Hz0e_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:52 INFO - Running setup.py (path:/tmp/pip-eYqyXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:52 INFO - Running setup.py (path:/tmp/pip-gJwA3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:52 INFO - Running setup.py (path:/tmp/pip-W64bh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:52 INFO - Running setup.py (path:/tmp/pip-EgOzC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:52 INFO - Running setup.py (path:/tmp/pip-f1AiqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:52 INFO - Running setup.py (path:/tmp/pip-z46cFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:52 INFO - Running setup.py (path:/tmp/pip-JaS0rL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:52 INFO - Running setup.py (path:/tmp/pip-B96Wuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:53 INFO - Running setup.py (path:/tmp/pip-XcQV4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:53 INFO - Running setup.py (path:/tmp/pip-IvSym_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:53 INFO - Running setup.py (path:/tmp/pip-pD1DEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:53 INFO - Running setup.py (path:/tmp/pip-h8WHNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:53 INFO - Running setup.py (path:/tmp/pip-h7RyuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:53 INFO - Running setup.py (path:/tmp/pip-sotgXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:53 INFO - Running setup.py (path:/tmp/pip-UGPSxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:53 INFO - Running setup.py (path:/tmp/pip-xt53oY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:24:53 INFO - Running setup.py install for manifestparser 22:24:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:24:53 INFO - Running setup.py install for mozcrash 22:24:53 INFO - Running setup.py install for mozdebug 22:24:53 INFO - Running setup.py install for mozdevice 22:24:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozfile 22:24:54 INFO - Running setup.py install for mozhttpd 22:24:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozinfo 22:24:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozInstall 22:24:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozleak 22:24:54 INFO - Running setup.py install for mozlog 22:24:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for moznetwork 22:24:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozprocess 22:24:54 INFO - Running setup.py install for mozprofile 22:24:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:24:54 INFO - Running setup.py install for mozrunner 22:24:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:24:55 INFO - Running setup.py install for mozscreenshot 22:24:55 INFO - Running setup.py install for moztest 22:24:55 INFO - Running setup.py install for mozversion 22:24:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:24:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:24:55 INFO - Cleaning up... 22:24:55 INFO - Return code: 0 22:24:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:55 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:55 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 22:24:55 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 22:24:55 INFO - Using env: {'DISPLAY': ':0', 22:24:55 INFO - 'HOME': '/home/cltbld', 22:24:55 INFO - 'LANG': 'en_US.UTF-8', 22:24:55 INFO - 'LANGUAGE': 'en_US:en', 22:24:55 INFO - 'LOGNAME': 'cltbld', 22:24:55 INFO - 'MAIL': '/var/mail/cltbld', 22:24:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:55 INFO - 'MOZ_NO_REMOTE': '1', 22:24:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:55 INFO - 'NO_EM_RESTART': '1', 22:24:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:55 INFO - 'PWD': '/builds/slave/test', 22:24:55 INFO - 'SHELL': '/bin/bash', 22:24:55 INFO - 'SHLVL': '1', 22:24:55 INFO - 'TERM': 'linux', 22:24:55 INFO - 'TMOUT': '86400', 22:24:55 INFO - 'USER': 'cltbld', 22:24:55 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:55 INFO - '_': '/tools/buildbot/bin/python'} 22:24:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:24:55 INFO - Running setup.py (path:/tmp/pip-N3xpcC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:24:55 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)) 22:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:24:55 INFO - Running setup.py (path:/tmp/pip-xVzCNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:24:55 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)) 22:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:24:55 INFO - Running setup.py (path:/tmp/pip-VgAXFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:24:55 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)) 22:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:24:55 INFO - Running setup.py (path:/tmp/pip-QSBs9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:24:55 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)) 22:24:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:24:55 INFO - Running setup.py (path:/tmp/pip-t9dNLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:24:56 INFO - Running setup.py (path:/tmp/pip-SNSdXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:24:56 INFO - Running setup.py (path:/tmp/pip-0yvnCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:24:56 INFO - Running setup.py (path:/tmp/pip-HrAAWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:24:56 INFO - Running setup.py (path:/tmp/pip-7n_0D8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:24:56 INFO - Running setup.py (path:/tmp/pip-i0BPR1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:24:56 INFO - Running setup.py (path:/tmp/pip-dvJmnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:24:56 INFO - Running setup.py (path:/tmp/pip-MGniwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:24:56 INFO - Running setup.py (path:/tmp/pip-HBWq3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:24:56 INFO - Running setup.py (path:/tmp/pip-tYKcD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:24:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:56 INFO - Running setup.py (path:/tmp/pip-Khm33l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:24:56 INFO - Running setup.py (path:/tmp/pip-XWHlgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:24:56 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)) 22:24:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:24:56 INFO - Running setup.py (path:/tmp/pip-NsTPWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:24:56 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)) 22:24:56 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)) 22:24:56 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)) 22:24:56 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)) 22:24:56 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)) 22:24:56 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)) 22:24:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:24:56 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 22:24:56 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 22:24:56 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 22:24:56 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 22:24:56 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 22:24:56 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 22:24:58 INFO - Downloading blessings-1.6.tar.gz 22:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:24:58 INFO - Installing collected packages: blessings 22:24:58 INFO - Running setup.py install for blessings 22:24:58 INFO - Successfully installed blessings 22:24:58 INFO - Cleaning up... 22:24:59 INFO - Return code: 0 22:24:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:59 INFO - Reading from file tmpfile_stdout 22:24:59 INFO - Current package versions: 22:24:59 INFO - argparse == 1.2.1 22:24:59 INFO - blessings == 1.6 22:24:59 INFO - blobuploader == 1.2.4 22:24:59 INFO - docopt == 0.6.1 22:24:59 INFO - functools32 == 3.2.3-2 22:24:59 INFO - jsonschema == 2.5.1 22:24:59 INFO - manifestparser == 1.1 22:24:59 INFO - mozInstall == 1.12 22:24:59 INFO - mozcrash == 0.17 22:24:59 INFO - mozdebug == 0.1 22:24:59 INFO - mozdevice == 0.48 22:24:59 INFO - mozfile == 1.2 22:24:59 INFO - mozhttpd == 0.7 22:24:59 INFO - mozinfo == 0.9 22:24:59 INFO - mozleak == 0.1 22:24:59 INFO - mozlog == 3.2 22:24:59 INFO - moznetwork == 0.27 22:24:59 INFO - mozprocess == 0.22 22:24:59 INFO - mozprofile == 0.28 22:24:59 INFO - mozrunner == 6.11 22:24:59 INFO - mozscreenshot == 0.1 22:24:59 INFO - mozsystemmonitor == 0.3 22:24:59 INFO - moztest == 0.7 22:24:59 INFO - mozversion == 1.4 22:24:59 INFO - psutil == 3.1.1 22:24:59 INFO - requests == 1.2.3 22:24:59 INFO - wsgiref == 0.1.2 22:24:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:59 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:59 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 22:24:59 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 22:24:59 INFO - Using env: {'DISPLAY': ':0', 22:24:59 INFO - 'HOME': '/home/cltbld', 22:24:59 INFO - 'LANG': 'en_US.UTF-8', 22:24:59 INFO - 'LANGUAGE': 'en_US:en', 22:24:59 INFO - 'LOGNAME': 'cltbld', 22:24:59 INFO - 'MAIL': '/var/mail/cltbld', 22:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:59 INFO - 'MOZ_NO_REMOTE': '1', 22:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:59 INFO - 'NO_EM_RESTART': '1', 22:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:59 INFO - 'PWD': '/builds/slave/test', 22:24:59 INFO - 'SHELL': '/bin/bash', 22:24:59 INFO - 'SHLVL': '1', 22:24:59 INFO - 'TERM': 'linux', 22:24:59 INFO - 'TMOUT': '86400', 22:24:59 INFO - 'USER': 'cltbld', 22:24:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:59 INFO - '_': '/tools/buildbot/bin/python'} 22:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 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)) 22:24:59 INFO - Cleaning up... 22:24:59 INFO - Return code: 0 22:24:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:24:59 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 0x2291030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2552180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', '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 22:24:59 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 22:24:59 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 22:24:59 INFO - Using env: {'DISPLAY': ':0', 22:24:59 INFO - 'HOME': '/home/cltbld', 22:24:59 INFO - 'LANG': 'en_US.UTF-8', 22:24:59 INFO - 'LANGUAGE': 'en_US:en', 22:24:59 INFO - 'LOGNAME': 'cltbld', 22:24:59 INFO - 'MAIL': '/var/mail/cltbld', 22:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:24:59 INFO - 'MOZ_NO_REMOTE': '1', 22:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:24:59 INFO - 'NO_EM_RESTART': '1', 22:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:24:59 INFO - 'PWD': '/builds/slave/test', 22:24:59 INFO - 'SHELL': '/bin/bash', 22:24:59 INFO - 'SHLVL': '1', 22:24:59 INFO - 'TERM': 'linux', 22:24:59 INFO - 'TMOUT': '86400', 22:24:59 INFO - 'USER': 'cltbld', 22:24:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:24:59 INFO - '_': '/tools/buildbot/bin/python'} 22:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:24:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:24:59 INFO - Cleaning up... 22:24:59 INFO - Return code: 0 22:24:59 INFO - Running post-action listener: _resource_record_post_action 22:24:59 INFO - Running post-action listener: _start_resource_monitoring 22:24:59 INFO - Starting resource monitoring. 22:24:59 INFO - ##### 22:24:59 INFO - ##### Finished create-virtualenv step (success) 22:24:59 INFO - ##### 22:24:59 INFO - ##### 22:24:59 INFO - ##### Running install step. 22:24:59 INFO - ##### 22:24:59 INFO - Running pre-action listener: _resource_record_pre_action 22:24:59 INFO - Running main action method: install 22:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:24:59 INFO - Reading from file tmpfile_stdout 22:24:59 INFO - Detecting whether we're running mozinstall >=1.0... 22:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:24:59 INFO - Reading from file tmpfile_stdout 22:24:59 INFO - Output received: 22:24:59 INFO - Usage: mozinstall [options] installer 22:24:59 INFO - Options: 22:24:59 INFO - -h, --help show this help message and exit 22:24:59 INFO - -d DEST, --destination=DEST 22:24:59 INFO - Directory to install application into. [default: 22:24:59 INFO - "/builds/slave/test"] 22:24:59 INFO - --app=APP Application being installed. [default: firefox] 22:24:59 INFO - mkdir: /builds/slave/test/build/application 22:24:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:25:16 INFO - Reading from file tmpfile_stdout 22:25:16 INFO - Output received: 22:25:16 INFO - /builds/slave/test/build/application/firefox/firefox 22:25:16 INFO - Running post-action listener: _resource_record_post_action 22:25:16 INFO - ##### 22:25:16 INFO - ##### Finished install step (success) 22:25:16 INFO - ##### 22:25:16 INFO - ##### 22:25:16 INFO - ##### Running run-tests step. 22:25:16 INFO - ##### 22:25:16 INFO - Running pre-action listener: _resource_record_pre_action 22:25:16 INFO - Running main action method: run_tests 22:25:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:25:16 INFO - Python 2.7.3 22:25:16 INFO - Return code: 0 22:25:16 INFO - grabbing minidump binary from tooltool 22:25: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:25:16 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 0x25503b0>, '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 0x25512b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2551740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:25:16 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 22:25:16 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 22:25:16 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 22:25:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:25:16 INFO - Return code: 0 22:25:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:25:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:25:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:25:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:25:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:25:16 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/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:25:16 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/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 22:25:16 INFO - Using env: {'DISPLAY': ':0', 22:25:16 INFO - 'HOME': '/home/cltbld', 22:25:16 INFO - 'LANG': 'en_US.UTF-8', 22:25:16 INFO - 'LANGUAGE': 'en_US:en', 22:25:16 INFO - 'LOGNAME': 'cltbld', 22:25:16 INFO - 'MAIL': '/var/mail/cltbld', 22:25:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:25:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:25:16 INFO - 'MOZ_NO_REMOTE': '1', 22:25:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:25:16 INFO - 'NO_EM_RESTART': '1', 22:25:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:25:16 INFO - 'PWD': '/builds/slave/test', 22:25:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:25:16 INFO - 'SHELL': '/bin/bash', 22:25:16 INFO - 'SHLVL': '1', 22:25:16 INFO - 'TERM': 'linux', 22:25:16 INFO - 'TMOUT': '86400', 22:25:16 INFO - 'USER': 'cltbld', 22:25:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930', 22:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:25:16 INFO - '_': '/tools/buildbot/bin/python'} 22:25:16 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/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 22:25:16 INFO - mozversion application_buildid: 20160705205623 22:25:16 INFO - mozversion application_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 22:25:16 INFO - mozversion application_display_name: Nightly 22:25:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:25:16 INFO - mozversion application_name: Firefox 22:25:16 INFO - mozversion application_remotingname: firefox 22:25:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:25:16 INFO - mozversion application_vendor: Mozilla 22:25:16 INFO - mozversion application_version: 50.0a1 22:25:16 INFO - mozversion platform_buildid: 20160705205623 22:25:16 INFO - mozversion platform_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 22:25:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:25:16 INFO - mozversion platform_version: 50.0a1 22:25:16 INFO - using testdate: 1467782716 22:25:16 INFO - actual date: 1467782716 22:25:16 INFO - starting webserver on 'localhost:32904' 22:25:16 INFO - SUITE-START | Running 2 tests 22:25:16 INFO - TEST-START | dromaeo_css 22:25:16 INFO - operating with platform_type : linux_ 22:25:16 INFO - Initialising browser for dromaeo_css test... 22:25:16 INFO - TEST-INFO | started process 22100 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFWyLa/profile http://localhost:32904/getInfo.html) 22:25:20 INFO - PROCESS | 22100 | __metrics Screen width/height:1600/1200 22:25:20 INFO - PROCESS | 22100 | colorDepth:24 22:25:20 INFO - PROCESS | 22100 | Browser inner width/height: 1024/697 22:25:20 INFO - PROCESS | 22100 | __metrics 22:25:21 INFO - PROCESS | 22100 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:25:22 INFO - TEST-INFO | 22100: exit 0 22:25:22 INFO - Browser initialized. 22:25:22 INFO - Running cycle 1/1 for dromaeo_css test... 22:25:22 INFO - TEST-INFO | started process 22182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBFWyLa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:25:34 INFO - PROCESS | 22182 | RSS: Main: 159084544 22:25:34 INFO - PROCESS | 22182 | 22:26:25 INFO - PROCESS | 22182 | 1467782785284 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] 22:28:37 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32904/tests/dromaeo/cssquery-ext.html) 22:28:39 INFO - PROCESS | 22182 | RSS: Main: 233201664 22:28:39 INFO - PROCESS | 22182 | 22:31:41 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-ext.html (next: http://localhost:32904/tests/dromaeo/cssquery-jquery.html) 22:31:42 INFO - PROCESS | 22182 | RSS: Main: 255090688 22:31:42 INFO - PROCESS | 22182 | 22:34:44 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32904/tests/dromaeo/cssquery-mootools.html) 22:34:45 INFO - PROCESS | 22182 | RSS: Main: 241831936 22:34:45 INFO - PROCESS | 22182 | 22:37:47 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32904/tests/dromaeo/cssquery-prototype.html) 22:37:47 INFO - PROCESS | 22182 | RSS: Main: 240611328 22:37:47 INFO - PROCESS | 22182 | 22:40:51 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32904/tests/dromaeo/cssquery-yui.html) 22:40:51 INFO - PROCESS | 22182 | RSS: Main: 218615808 22:40:51 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | Cycle 1(1): loaded http://localhost:32904/tests/dromaeo/cssquery-yui.html (next: http://localhost:32904/tests/dromaeo/cssquery-dojo.html) 22:43:54 INFO - PROCESS | 22182 | RSS: Main: 301068288 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | __start_tp_report 22:43:54 INFO - PROCESS | 22182 | _x_x_mozilla_page_load 22:43:54 INFO - PROCESS | 22182 | _x_x_mozilla_page_load_details 22:43:54 INFO - PROCESS | 22182 | |i|pagename|runs| 22:43:54 INFO - PROCESS | 22182 | |0;dojo.html;2574.227731680496;2598.909038183664;2628.8685565721717;2643.955637523178;2644.259607309954;4522.891891486591;4679;4679.461861885884;4711.246200607903;4714.339992401062;4680.5085466026;4714;4730.148573256813;4762.904741905159;4765.166095933215;4166.562510936354;4308.504521979981;4381.452318460192;4409.911801763963;4553.908921821561;4457.375967364572;4492.97753511232;4504.662150338721;4519.322101684757;4541.636669066484;4244.384564238199;4281.8073186706515;4312.029793296515;4335.588119128678;4364.148990946766;4255.446791917062;4270.850520231808;4314.395984562164;4315.633171180453;4321.546237645065;4310.3103503439615;4314.525402205755;4321.611055005064;4333.025069359401;4355.4337936068105;4583.197940360457;4649.1863923813535;4713.080949214905;4717.315989181584;4724.102420540121;5055.74721263939;5095.286659867622;5099.4390617032095;5110.6422550421485;5124.000819840133;4887.462379138292;4999.8250061248045;5033.295338652591;5123.052235336475;5140.665856719339;4729.645276604234;4764.785584648699;4786.282057691375;4793.856184314406;4802.447718512346;5204.9590081983;5209.218617207373;5212.947870521322;5219.2953951216095;5261.105612045962;4837.201861692782;4909.386326709161;4910;4913.950860491421;4924.03981223658;4976.850694479172;5029.974850125726;5062.392512898476;5066.189409694432;5073.315102461194;4979.3526841510375;5004.249362595567;5012.172991456368;5024.648274620815;5066.290719299301;4853.635977301717;4918.409790825124;5005.89988200234;5024.070546948826;5038.521340472649;4160.022394737234;4211.705180637326;4221.02916329246;4225.640820530228;4249.128928569636;3691.1141326081547;3694.316551437939;3696.74122811406;3732.3841566141828;3734.2158146788934;4280.400743895857;4378.2994720845145;4380.496242932104;4421.712588681726;4425;4893.290472881412;4989.750512474435;5011.649184557046;5012.473690262543;5037.773300201499;4318.050028993616;4345.521992580813;4346.348047792856;4348.108637729258;4388.802503887333;4337.002489427449;4470.150671372428;4470.932936005963;4472.038511719996;4508.684392092588;4672.088942656217;4743.075100355398;4760.714357138583;4760.97619511914;4767.73777442244;4975.477574854588;4976.2286845539;5008.599312054954;5010.799568017384;5058.898822023612;4656.953430465652;4715.717056976592;4716.882077947941;4735.83424580138;4776.116418462596;4954.1330267202375;4958.231474121517;5007.39911210657;5010.098182327216;5059.46875578059;5053.418856831365;5064.442911279682;5066.569341606005;5067.543921047123;5125.743712814419;4792.257200133985;4834.685745426536;4892.290617860319;4898.706077635354;4948.035133149001;4894.412670479565;4918.631102667243;4920.803167873245;4924.03981223658;4952.529509696573;4849;4849.854504364875;4850.83022094225;4886.706797592155;4899.485554016777;4776.426828780569;4820.68665536739;4883.536064073907;4895.804167833389;4986.426560945538;4804.447488538863;4817.710937343771;4819.180739274402;4827.08285425782;4867.659263851497 22:43:54 INFO - PROCESS | 22182 | |1;ext.html;564.0523919814711;572.436150391864;582.7261187241998;586.2935163128429;587.8089620873217;27850.303742406424;28497.430051398984;30489.23776905576;30542.389152216998;30574.388512229798;30454.543181852234;41904.79047604765;43109.35335969955;43160.13679726404;47016.294755578696;7836.882446763318;7931.206879312052;7931.682732690685;7932.127465978738;7936.5238085714755;7854.6465409056445;7908.920910790905;7951.522908625501;7956;7956.443048986574;7959.2836644701965;8011.158828323029;8016.358691304711;8017.95991020047;8022.638981245858;7944.563049032301;7992.360611151123;8003.839923201504;8004.199580042007;8007.439479236397;7917.129115797257;7926.80182995424;7967.760967170994;7991.24083212094;7996.560189189592;39748.60251397478;40202;40230.195396092204;40247;40371;2841.5322240473215;2961.4077184563175;3012.819230846156;3022.516397376431;3155.321605854729;30276;30704.2323941901;30722;31092.378152436824;31148.377032459222;3207.935841283161;3208.4385232584204;3214.4856822908223;3253.1053960160907;3266.4610339293986;289276;294542;295366;381719;381944;56784.716076419354;57195;57388.71305643445;57465.425345746844;57532.424675753544;33758.83120584382;34543.82728086394;34575.82712086423;36117;36210;15157.621059473602;15219.847801522064;15224.46714364992;15230.619234519005;15234.390624375123;10675.306105103144;10718.839217411745;10723.410212438392;10726.785464290671;10729.731756706145;18130.728039079426;18588.44234672962;18626.627467450577;18684.626307473773;18692.906535467508;6814.1482314710665;6814.863702725917;6974.616396098263;7049;7154.749583764543;819.7499762572472;857.9485230886166;979.7795496013482;1034.2398337222135;1062.6387028410377;28343.29141771472;28423.857880710464;28447.43105137927;29147;29185.27036824054;981.5043403081398;1012.5797793915442;1028.187731691955;1030.5208078243652;1066.7973085113804;15042.699146017238;15130.848691513163;15353.539393818204;15571.143587102819;15662.138582378078;388953;389641;390863;392323;394189;50428;50995.23507147396;51075.74462127666;51120;51137.48862511327;1055.1769619696495;1157.583270022791;1187.8337032815414;1188.9405529723479;1204.2413279633774;27158.321041974108;29274.70725292805;30194.24514387158;30641.693583064774;30697;43808.56191438045;44046.559534405525;44493;44499.33251001173;44651.55348446474;346667;351522;352274;352948;353226;38637.61362386453;39943.60056399399;40655.59344406518;40768.388474172316;40799;43594.346084808116;43633.56366436295;43892.341614876445;44235.55764442314;44252.336214957446;35482.71109246715;37043.62956370509;37245.06887327838;37410;37696.246075078896;37390.85926124707;37584.812075939444;37797.433038505;37894;37939.81030094832;35162.47256291209;36181.27637447289;36677.44983825298;36925.26149477049;36967.630323696416;31724.682753172172;33528.1617959553;33552.664473354955;33826.66173338235;34038.3192336147;25041.74958250394;25332.873335633205;25565.744342556336;25737.742622573536;25899.352516187246 22:43:54 INFO - PROCESS | 22182 | |2;jquery.html;348.3468496568933;375.1502846053688;377.1495278147778;380.42175892643183;387.31058715486427;13161.473541058358;16513.83486165138;16904.239309231067;17733.113344332764;18582.535436614093;17450.3019879205;17540.473785786446;17632.647347053084;17798.288068477246;17934.5516362091;4872.853814385574;5162.8193013244545;5168.664036837594;5169.224616307546;5207.583393328525;3751.1934933989187;5091.465396133408;5766.654000759947;6045.999999999978;6068.908966365486;6120.571559990803;6124.112003759452;6130.632162070267;6144.109104179891;6151.600145990518;5116.155834287338;5437.510624043815;5444.891102177954;5500.257465242181;5508.944910550883;3415.129142068781;5094.184930411154;5317.707526086064;5420.756065977041;5426;12535.498580056787;12861.935690321488;13707.246101464416;21131.154753809984;21388.786112138834;1949.171602069115;2058.7220725202055;2332.6734257204007;2353.5292941411785;2367.112332875172;8990.325725570608;9102.544872756336;9166.26669866409;9386.26354124489;9545.522723863849;1721.122227663888;1726.8273172682757;1743.5902562897709;1758.2417582417556;1819.9181036853374;68279.31720682779;68760.31239687589;69709.65145174242;70592;70598.99999999949;9341.766455838659;9788.363756355815;10102.949485252673;10421.06210441064;10947.890521094847;12060.336681482428;13078.411471483807;13088.149270297401;13467.730645387037;13617.387217575233;6300.401461861115;7526.548407095592;7582.582957937256;7591.278828511283;7718.768436946901;7194.388476979515;7277.053982982178;7341.119065712149;7397.741079062207;7485.288897554832;4243.342281946241;4347.174036932973;4349.630281426114;4470.8435204767675;4532.9546704533195;1785.8928464292185;1866.524036370744;1880.4828672115277;1917.5685470769245;1923.0577017261721;810.040102478553;851.8764779106995;859.5401460218753;868.9913100869037;874.61079819481;17289.740653890203;17539.73690394645;18009.099545022695;18181.81818181828;18290;829.8340331933516;836.7531578184451;857.7941294089499;885.6103314541581;896.9282457403392;9723.805523889625;9940.652077177409;9992.400455972665;9996;10036.749081272881;309754.4512277469;351356;361734;362380;367582;75871.62064189644;78001.60999195081;78623.60688196523;78963.60518197372;81269.59365203136;874.6151693254948;882.6601758323092;886.3972498700946;898.4968417686117;899.8110396816611;15519.146446945526;15768;15768.211589420713;15897.205139742735;16111.919440402722;24859.378515537257;34428.48357274593;37135.628643713215;37482.62517374791;37922;49379.753101234266;49593;49686;50151;50291.497085028685;7847.136814950465;7901.446898717035;7903.723369682033;7912.4856884302335;8000.5599692017495;11157.44212789341;11856.110791690486;11955.282683039046;12086.214396064228;12212.084093693185;9625.0374962506;9972.950135249277;10089.19286457067;10297.330673506198;10540.262181647211;9617.134457898543;10185.236107291834;10700.30448020876;10710.946445267724;10747.355158690503;10475.371477711362;10479.266451348332;10510.264281500222;10652.414117223318;10749.838752418564;7717.151113377637;7807.141214466517;7932.0878099017045;7974.800629984296;8112.22933821286;10289.53697083648;10648.574057037631;10697.572097116028;10702.304350217211;10901.236913415985 22:43:54 INFO - PROCESS | 22182 | |3;mootools.html;1392.436063394325;1398.7062716829466;1518.8101487314086;1699.1589163364122;1733.4052671542179;7590.772276831697;7999.560024198681;8078.63646135923;8078.71724489643;8096.878546821795;6818.829529261771;7033.753818616349;7036.824079398018;7230.891536626955;7961.7213397531095;1961.1174971262917;2112.4718820294925;2241.540484200735;2242.4281808138985;2267.1384873748034;2191.923282685106;2218.8557743746687;2236.642137258039;2238.1271304191378;2242.3048854854965;1899.2877670873422;2216.26863135165;2238.787315205053;2239.395363251921;2240.003198576634;2166.6749987501844;2262.298687406901;2264.4452109233343;2277.0664027748544;2281.8744969026698;2200.2849074050996;2208.580369729746;2219.655953327237;2238.8544744591713;2244.079927229844;8077.273045425881;8131.064927533291;8133.349332053422;8147.307478864303;8148.674053037871;4558.703684260512;4715.858524244278;4716.52834716529;4724.574788269072;4726.558399688094;2748.189284161177;2810.1990932584117;2860.2134413036374;2935.4129174165037;2942.529195328737;828.7928017995501;849.4011721736161;853.2320911179926;859.7549698335944;860.2300940658076;10672.466376681135;10679.893201067967;10682.839757403644;10699.518521666465;10731.409772462512;3949.763014219156;4346.500152482442;4347.260965635849;4356.825726970949;4362.6509879210225;9184.89781226257;9197.310201734897;9213.95393023044;9235.030321816113;9284.860727089099;4798.616110711135;4799.064182484382;4801.735904525284;4806.591439727592;4810.542998415145;4274.380214868826;4348.7390756554705;4358.302671572533;4367.27939889921;4373.278409062469;3366.208940898887;3495.94756078659;3496.9825150874085;3515.8066306352885;3661.1945372018113;1167.8832116788253;1204.4579939027474;1205.1142410328403;1209.5826939705787;1219.7194645231468;666.2937286476254;767.8848172774128;783.7256960064046;793.4723408932995;800.5396896784372;4949.282354058641;5055.443901170868;5115.309433226541;5140.922886156711;5146.588272938156;803.863343231652;806.4999700185922;838.1325328285195;838.5848507607452;844.9281811046008;3394.711449526818;3412.146963259185;3420.6579342066093;3438.5014172944784;3486.0761898097026;9610.51947402627;9981.351212171186;10061.245406594535;10090.646827361006;10091.596336146618;9939.304248702521;9940.25448091396;9944.1547468466;9948.552315145836;9954.552045157985;7477.476576639583;7480.8877866832045;7528.585927774025;7645.311921927053;7650.31147196755;5034.647574669738;5066.41736200327;5075.974620126875;5076.441591424867;5086.3896332440345;9000.144986226298;9124.361294709306;9272.675456358995;9350.579223935076;9430.245580353418;9170.312226582899;9486.715398538056;9509.286803489904;9552;9557.283203759607;6834.8633027340165;6886.965565172142;6912.758053468105;6935;6959.860802784017;6369.808905732835;7009.2990700929495;7381.741639042608;7457.030586023782;7465.888011679721;6606.6036037837885;6713.261541230559;6819.727210911508;6922.411595014481;6948.791536253921;6409.4231519163495;6460.192475940507;6524.6411447368955;6564.540482166202;6608.537402381787;5756.424357564378;5887.4406931343165;5887.470127688529;5892.410758924073;5892.852678682896;4158.2307273154565;4230.471191101113;4282.100758840678;4350.543192964819;4378;4336.3278691802825;4348.63036641889;4349.652027837828;4361.2367835628;4373.322135069069 22:43:54 INFO - PROCESS | 22182 | |4;prototype.html;297.36215817072383;300.09072510293805;306.0985398002882;306.3199696673385;306.60754234579747;4753.738544380058;4777.402824646919;4806.279058141281;4807.591354734847;4809.4950030246755;4751.002289519205;4757.9286310705365;4758.167320718869;4762.309465127554;4763.523647635244;3599.58827585517;3708;3711.870084547041;3747.775133491986;3784.526934133233;3736.607656196101;3769.1707824278615;3778.6410291022307;3780.4329350597354;3791.995121292846;3720.795356255405;3736.9813150934206;3764.1392541668256;3764.604716504755;3765.8493660253557;3546.592141903688;3648.1791596890753;3733.701303895682;3777.924441511182;3779.5464544254864;3322.601287845474;3322.7674062815613;3330.2506935939464;3336.6996970272794;3354.496825476174;4627.316156629147;4643.88390290242;4645.117427688762;4654.4647365553055;4676.812927482896;4200.348945913388;4264.48826140862;4288.44250247469;4294.527601963781;4306.784660766981;4908.901821963541;4912.852614421573;4915.778789954461;4933.1860243059855;4941.555260026615;3633.2733453309443;3636.1091532574424;3640.7087433005295;3655.597884232732;3668.6514781095752;4978.427480839714;5180.8963820723375;5187.870303242411;5203.869903252449;5238.764255608507;3620.8913732588067;3642.6357364263363;3646.762960407565;3655.4281658886935;3661.0115268877253;3691.390920498088;3709.8330575124182;3710.777353358807;3715.777053376806;3718.5165928429133;4218.49378074633;4219.6580897602125;4220.577942205755;4222.838719352141;4226.640735537452;4728.763561821896;4990;4990.201567749143;5016.398032236082;5036.748162591929;1262.8760403241122;1270.5807083662369;1278.3161008860216;1283.6341642631805;1283.666246775845;824.2540500846743;824.8061705499202;825.5583262954291;862.8610234490537;882.2589025218847;4397.890052748643;4404.669649776216;4426.826890873921;4440.7335559866515;4442.777861106932;5111.207762796773;5119.820806271837;5137.614678899097;5149.6910185389;5153.665011774223;4232.407462955189;4409.911801763947;4417.977910110429;4421.159979603865;4423.380726698265;2732.153032559913;2740.9725902740715;2746.40952195279;2771.5011297966157;2773.278947473631;4905.681130726492;4905.877353066202;4906.509349065065;4918.1393256180745;4951.316552372211;5045.747712614355;5282.550983166474;5289.153735402394;5314.256004159421;5328.254044433782;4918.8770280743265;4930.556249937451;4951.653384263067;4954.5788607968725;4959.876003099951;5196.792128314976;5197.740112994411;5235.240890070842;5240.449752775904;5246.108161612611;4870.4155501340065;5084.440711521655;5089.567386772166;5124.41069277023;5140.408852981955;4927.310176575211;4946.752662366795;4955.794671371205;4965.747435429799;4966.776495057803;3699.8890033299044;3705.98147009274;3710.944335834911;3716.8141592919706;3717.5353080864893;5080.415752188545;5173.534381905646;5178.922316165336;5199.610029247897;5202.791888324576;4963.255511673278;4963.627727920492;4963.6525443218625;4973.303737476828;4978.950210497848;4983.476734942778;5030.270610761492;5042.697438153723;5047.192449208109;5049.374325350724;4670.579647831712;4870.512948705243;4900.485449027943;4955.306257124078;4966.485222007323;4752.667313288037;4823.252395878644;4996.675216110941;5027.7737501813235;5034.295198672262;4909.754512274443;4937.061958227925;4949.30709700635;4954.777035033504;4955.6531042826655 22:43:54 INFO - PROCESS | 22182 | |5;yui.html;656.3633275722549;688.2188715807557;695.3706895259791;703.1386551474441;764.6903004283267;11907.523699052039;12194.69513262169;12279.938600306987;12322.691932701688;12339.629811105659;12023.218490798114;13265;14047.157170569773;14089.154650720964;14110.57668269951;624.7844493649684;779.6024027745862;793.6031984007996;798.6765360029198;800.7437619961614;755.9508631938934;797.6091715059608;799.7680672604938;801.0227522422636;801.2228138705475;825.22428916818;831.3764676492631;832.4797001873828;832.50881979632;833.0711256948489;643.1478291264094;669.1067424987648;828.7886588919847;828.958552072397;831.0193971114084;491.62636396338684;491.9963274919161;570.5150621971333;595.9553033522503;598.2043881637412;12257.632271031795;12260.386980650932;12278.447469863877;12401;12434.253944763343;11446.885531144666;11652.592159274385;11777.175597708163;12173.2696038238;12235.082368822284;11183.83224251637;11247.887521124765;11334.376609286486;11394.943025284903;11471.311721296748;4065.9390109148385;4096.242195193899;4148.460700108997;4153.397757325171;4285.228658841407;53750.19374709383;55857;64216.35783642151;65335.3466465334;66304;10108.595656173818;10173;10318.742031449274;10346.844797328045;10499.002594753487;18212.908935455238;18404.35584754527;18488.815111848708;18518.629627407645;18557;6932.0988271524375;7009.824754381181;7143.357097861218;7331.303526165006;7334.413246940232;3829.9808500957315;3840.4047372657283;3924.4701965234326;3935.4490371348033;3984.143409167043;2758.813710104634;2857.5999360089604;2862.341661417844;2863.0838131797623;2868.0535423310257;509.5617768718899;512.1881817319515;517.3145582103728;522.1619301021881;529.0424331959166;503.57447956476716;552.2544564837517;578.774278031568;589.381149792716;589.6432658241788;7845.568493732785;7884.72403465876;7900.84198316042;8952.955235223912;9247.26021918245;442.83615062427106;483.3209340876075;487.8560824556764;543.4701166362764;558.7457706743422;3659.597444281127;3791.962080379216;3953.802309884494;3956.584558621303;4124.52567954689;55127.724361378736;55131.44868551263;93514.53242733743;94991.52504237434;98698.50650746844;65009.34990650127;78201;80211.59894200608;80811;84154.99999999878;45158.32262516065;66864.33135668679;69467.65266173737;71274.64362678258;72387.27612723806;7283.672234749343;7406.851862962602;7441.400098978529;7514.924850751641;7576.24237576238;41028.589714102476;41267.7936610315;41865.79067104767;42027.7898610505;43131.13737725165;35691.82154089213;52425.47574524206;59784.402155979624;60069;60129.69935150296;9762.853557196506;9800.962922519426;9862.605495780088;9957.103860652576;9966.252531060054;10697.290907103881;10884.07485363753;10920.180986426209;11002.724931876446;11134.721631959266;9534.141927226583;9786.363886347364;9871;10007.849882251627;10110.949445252727;9721.319507634398;9767;10036.899631003596;10350.223733219887;10359.533820978224;9979.45113018791;10212.285140040125;10352.171826254033;10400.219983501116;10748.731281718019;8863.911360886308;9104.772380690536;9133.132352426508;9141.222996045411;9425.575849086945;8652.956735216536;8916.73249802507;8948.552572371225;9035.774105647411;9155.587998539948 22:43:54 INFO - PROCESS | 22182 | __end_tp_report 22:43:54 INFO - PROCESS | 22182 | __start_cc_report 22:43:54 INFO - PROCESS | 22182 | _x_x_mozilla_cycle_collect,1020 22:43:54 INFO - PROCESS | 22182 | __end_cc_report 22:43:54 INFO - PROCESS | 22182 | __startTimestamp1467783834794__endTimestamp 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | ------- Summary: start ------- 22:43:54 INFO - PROCESS | 22182 | Number of tests: 6 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#0] dojo.html Cycles:165 Average:4652.58 Median:4776.43 stddev:490.48 (10.3%) stddev-sans-first:464.09 22:43:54 INFO - PROCESS | 22182 | Values: 2574.2 2598.9 2628.9 2644.0 2644.3 4522.9 4679.0 4679.5 4711.2 4714.3 4680.5 4714.0 4730.1 4762.9 4765.2 4166.6 4308.5 4381.5 4409.9 4553.9 4457.4 4493.0 4504.7 4519.3 4541.6 4244.4 4281.8 4312.0 4335.6 4364.1 4255.4 4270.9 4314.4 4315.6 4321.5 4310.3 4314.5 4321.6 4333.0 4355.4 4583.2 4649.2 4713.1 4717.3 4724.1 5055.7 5095.3 5099.4 5110.6 5124.0 4887.5 4999.8 5033.3 5123.1 5140.7 4729.6 4764.8 4786.3 4793.9 4802.4 5205.0 5209.2 5212.9 5219.3 5261.1 4837.2 4909.4 4910.0 4914.0 4924.0 4976.9 5030.0 5062.4 5066.2 5073.3 4979.4 5004.2 5012.2 5024.6 5066.3 4853.6 4918.4 5005.9 5024.1 5038.5 4160.0 4211.7 4221.0 4225.6 4249.1 3691.1 3694.3 3696.7 3732.4 3734.2 4280.4 4378.3 4380.5 4421.7 4425.0 4893.3 4989.8 5011.6 5012.5 5037.8 4318.1 4345.5 4346.3 4348.1 4388.8 4337.0 4470.2 4470.9 4472.0 4508.7 4672.1 4743.1 4760.7 4761.0 4767.7 4975.5 4976.2 5008.6 5010.8 5058.9 4657.0 4715.7 4716.9 4735.8 4776.1 4954.1 4958.2 5007.4 5010.1 5059.5 5053.4 5064.4 5066.6 5067.5 5125.7 4792.3 4834.7 4892.3 4898.7 4948.0 4894.4 4918.6 4920.8 4924.0 4952.5 4849.0 4849.9 4850.8 4886.7 4899.5 4776.4 4820.7 4883.5 4895.8 4986.4 4804.4 4817.7 4819.2 4827.1 4867.7 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#1] ext.html Cycles:180 Average:50810.03 Median:37005.63 stddev:94551.58 (255.5%) stddev-sans-first:94741.56 22:43:54 INFO - PROCESS | 22182 | Values: 564.1 572.4 582.7 586.3 587.8 27850.3 28497.4 30489.2 30542.4 30574.4 30454.5 41904.8 43109.4 43160.1 47016.3 7836.9 7931.2 7931.7 7932.1 7936.5 7854.6 7908.9 7951.5 7956.0 7956.4 7959.3 8011.2 8016.4 8018.0 8022.6 7944.6 7992.4 8003.8 8004.2 8007.4 7917.1 7926.8 7967.8 7991.2 7996.6 39748.6 40202.0 40230.2 40247.0 40371.0 2841.5 2961.4 3012.8 3022.5 3155.3 30276.0 30704.2 30722.0 31092.4 31148.4 3207.9 3208.4 3214.5 3253.1 3266.5 289276.0 294542.0 295366.0 381719.0 381944.0 56784.7 57195.0 57388.7 57465.4 57532.4 33758.8 34543.8 34575.8 36117.0 36210.0 15157.6 15219.8 15224.5 15230.6 15234.4 10675.3 10718.8 10723.4 10726.8 10729.7 18130.7 18588.4 18626.6 18684.6 18692.9 6814.1 6814.9 6974.6 7049.0 7154.7 819.7 857.9 979.8 1034.2 1062.6 28343.3 28423.9 28447.4 29147.0 29185.3 981.5 1012.6 1028.2 1030.5 1066.8 15042.7 15130.8 15353.5 15571.1 15662.1 388953.0 389641.0 390863.0 392323.0 394189.0 50428.0 50995.2 51075.7 51120.0 51137.5 1055.2 1157.6 1187.8 1188.9 1204.2 27158.3 29274.7 30194.2 30641.7 30697.0 43808.6 44046.6 44493.0 44499.3 44651.6 346667.0 351522.0 352274.0 352948.0 353226.0 38637.6 39943.6 40655.6 40768.4 40799.0 43594.3 43633.6 43892.3 44235.6 44252.3 35482.7 37043.6 37245.1 37410.0 37696.2 37390.9 37584.8 37797.4 37894.0 37939.8 35162.5 36181.3 36677.4 36925.3 36967.6 31724.7 33528.2 33552.7 33826.7 34038.3 25041.7 25332.9 25565.7 25737.7 25899.4 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#2] jquery.html Cycles:180 Average:23158.46 Median:4410.24 stddev:58286.43 (1321.6%) stddev-sans-first:58424.77 22:43:54 INFO - PROCESS | 22182 | Values: 348.3 375.2 377.1 380.4 387.3 13161.5 16513.8 16904.2 17733.1 18582.5 17450.3 17540.5 17632.6 17798.3 17934.6 4872.9 5162.8 5168.7 5169.2 5207.6 3751.2 5091.5 5766.7 6046.0 6068.9 6120.6 6124.1 6130.6 6144.1 6151.6 5116.2 5437.5 5444.9 5500.3 5508.9 3415.1 5094.2 5317.7 5420.8 5426.0 12535.5 12861.9 13707.2 21131.2 21388.8 1949.2 2058.7 2332.7 2353.5 2367.1 8990.3 9102.5 9166.3 9386.3 9545.5 1721.1 1726.8 1743.6 1758.2 1819.9 68279.3 68760.3 69709.7 70592.0 70599.0 9341.8 9788.4 10102.9 10421.1 10947.9 12060.3 13078.4 13088.1 13467.7 13617.4 6300.4 7526.5 7582.6 7591.3 7718.8 7194.4 7277.1 7341.1 7397.7 7485.3 4243.3 4347.2 4349.6 4470.8 4533.0 1785.9 1866.5 1880.5 1917.6 1923.1 810.0 851.9 859.5 869.0 874.6 17289.7 17539.7 18009.1 18181.8 18290.0 829.8 836.8 857.8 885.6 896.9 9723.8 9940.7 9992.4 9996.0 10036.7 309754.5 351356.0 361734.0 362380.0 367582.0 75871.6 78001.6 78623.6 78963.6 81269.6 874.6 882.7 886.4 898.5 899.8 15519.1 15768.0 15768.2 15897.2 16111.9 24859.4 34428.5 37135.6 37482.6 37922.0 49379.8 49593.0 49686.0 50151.0 50291.5 7847.1 7901.4 7903.7 7912.5 8000.6 11157.4 11856.1 11955.3 12086.2 12212.1 9625.0 9973.0 10089.2 10297.3 10540.3 9617.1 10185.2 10700.3 10710.9 10747.4 10475.4 10479.3 10510.3 10652.4 10749.8 7717.2 7807.1 7932.1 7974.8 8112.2 10289.5 10648.6 10697.6 10702.3 10901.2 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#3] mootools.html Cycles:180 Average:5153.29 Median:5060.93 stddev:2946.15 (58.2%) stddev-sans-first:2940.86 22:43:54 INFO - PROCESS | 22182 | Values: 1392.4 1398.7 1518.8 1699.2 1733.4 7590.8 7999.6 8078.6 8078.7 8096.9 6818.8 7033.8 7036.8 7230.9 7961.7 1961.1 2112.5 2241.5 2242.4 2267.1 2191.9 2218.9 2236.6 2238.1 2242.3 1899.3 2216.3 2238.8 2239.4 2240.0 2166.7 2262.3 2264.4 2277.1 2281.9 2200.3 2208.6 2219.7 2238.9 2244.1 8077.3 8131.1 8133.3 8147.3 8148.7 4558.7 4715.9 4716.5 4724.6 4726.6 2748.2 2810.2 2860.2 2935.4 2942.5 828.8 849.4 853.2 859.8 860.2 10672.5 10679.9 10682.8 10699.5 10731.4 3949.8 4346.5 4347.3 4356.8 4362.7 9184.9 9197.3 9214.0 9235.0 9284.9 4798.6 4799.1 4801.7 4806.6 4810.5 4274.4 4348.7 4358.3 4367.3 4373.3 3366.2 3495.9 3497.0 3515.8 3661.2 1167.9 1204.5 1205.1 1209.6 1219.7 666.3 767.9 783.7 793.5 800.5 4949.3 5055.4 5115.3 5140.9 5146.6 803.9 806.5 838.1 838.6 844.9 3394.7 3412.1 3420.7 3438.5 3486.1 9610.5 9981.4 10061.2 10090.6 10091.6 9939.3 9940.3 9944.2 9948.6 9954.6 7477.5 7480.9 7528.6 7645.3 7650.3 5034.6 5066.4 5076.0 5076.4 5086.4 9000.1 9124.4 9272.7 9350.6 9430.2 9170.3 9486.7 9509.3 9552.0 9557.3 6834.9 6887.0 6912.8 6935.0 6959.9 6369.8 7009.3 7381.7 7457.0 7465.9 6606.6 6713.3 6819.7 6922.4 6948.8 6409.4 6460.2 6524.6 6564.5 6608.5 5756.4 5887.4 5887.5 5892.4 5892.9 4158.2 4230.5 4282.1 4350.5 4378.0 4336.3 4348.6 4349.7 4361.2 4373.3 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#4] prototype.html Cycles:180 Average:4168.61 Median:4758.05 stddev:1204.97 (25.3%) stddev-sans-first:1172.80 22:43:54 INFO - PROCESS | 22182 | Values: 297.4 300.1 306.1 306.3 306.6 4753.7 4777.4 4806.3 4807.6 4809.5 4751.0 4757.9 4758.2 4762.3 4763.5 3599.6 3708.0 3711.9 3747.8 3784.5 3736.6 3769.2 3778.6 3780.4 3792.0 3720.8 3737.0 3764.1 3764.6 3765.8 3546.6 3648.2 3733.7 3777.9 3779.5 3322.6 3322.8 3330.3 3336.7 3354.5 4627.3 4643.9 4645.1 4654.5 4676.8 4200.3 4264.5 4288.4 4294.5 4306.8 4908.9 4912.9 4915.8 4933.2 4941.6 3633.3 3636.1 3640.7 3655.6 3668.7 4978.4 5180.9 5187.9 5203.9 5238.8 3620.9 3642.6 3646.8 3655.4 3661.0 3691.4 3709.8 3710.8 3715.8 3718.5 4218.5 4219.7 4220.6 4222.8 4226.6 4728.8 4990.0 4990.2 5016.4 5036.7 1262.9 1270.6 1278.3 1283.6 1283.7 824.3 824.8 825.6 862.9 882.3 4397.9 4404.7 4426.8 4440.7 4442.8 5111.2 5119.8 5137.6 5149.7 5153.7 4232.4 4409.9 4418.0 4421.2 4423.4 2732.2 2741.0 2746.4 2771.5 2773.3 4905.7 4905.9 4906.5 4918.1 4951.3 5045.7 5282.6 5289.2 5314.3 5328.3 4918.9 4930.6 4951.7 4954.6 4959.9 5196.8 5197.7 5235.2 5240.4 5246.1 4870.4 5084.4 5089.6 5124.4 5140.4 4927.3 4946.8 4955.8 4965.7 4966.8 3699.9 3706.0 3710.9 3716.8 3717.5 5080.4 5173.5 5178.9 5199.6 5202.8 4963.3 4963.6 4963.7 4973.3 4979.0 4983.5 5030.3 5042.7 5047.2 5049.4 4670.6 4870.5 4900.5 4955.3 4966.5 4752.7 4823.3 4996.7 5027.8 5034.3 4909.8 4937.1 4949.3 4954.8 4955.7 22:43:54 INFO - PROCESS | 22182 | 22:43:54 INFO - PROCESS | 22182 | [#5] yui.html Cycles:180 Average:16155.00 Median:55129.59 stddev:22627.09 (41.0%) stddev-sans-first:22660.64 22:43:54 INFO - PROCESS | 22182 | Values: 656.4 688.2 695.4 703.1 764.7 11907.5 12194.7 12279.9 12322.7 12339.6 12023.2 13265.0 14047.2 14089.2 14110.6 624.8 779.6 793.6 798.7 800.7 756.0 797.6 799.8 801.0 801.2 825.2 831.4 832.5 832.5 833.1 643.1 669.1 828.8 829.0 831.0 491.6 492.0 570.5 596.0 598.2 12257.6 12260.4 12278.4 12401.0 12434.3 11446.9 11652.6 11777.2 12173.3 12235.1 11183.8 11247.9 11334.4 11394.9 11471.3 4065.9 4096.2 4148.5 4153.4 4285.2 53750.2 55857.0 64216.4 65335.3 66304.0 10108.6 10173.0 10318.7 10346.8 10499.0 18212.9 18404.4 18488.8 18518.6 18557.0 6932.1 7009.8 7143.4 7331.3 7334.4 3830.0 3840.4 3924.5 3935.4 3984.1 2758.8 2857.6 2862.3 2863.1 2868.1 509.6 512.2 517.3 522.2 529.0 503.6 552.3 578.8 589.4 589.6 7845.6 7884.7 7900.8 8953.0 9247.3 442.8 483.3 487.9 543.5 558.7 3659.6 3792.0 3953.8 3956.6 4124.5 55127.7 55131.4 93514.5 94991.5 98698.5 65009.3 78201.0 80211.6 80811.0 84155.0 45158.3 66864.3 69467.7 71274.6 72387.3 7283.7 7406.9 7441.4 7514.9 7576.2 41028.6 41267.8 41865.8 42027.8 43131.1 35691.8 52425.5 59784.4 60069.0 60129.7 9762.9 9801.0 9862.6 9957.1 9966.3 10697.3 10884.1 10920.2 11002.7 11134.7 9534.1 9786.4 9871.0 10007.8 10110.9 9721.3 9767.0 10036.9 10350.2 10359.5 9979.5 10212.3 10352.2 10400.2 10748.7 8863.9 9104.8 9133.1 9141.2 9425.6 8653.0 8916.7 8948.6 9035.8 9155.6 22:43:54 INFO - PROCESS | 22182 | -------- Summary: end -------- 22:43:54 INFO - PROCESS | 22182 | 22:43:55 INFO - TEST-INFO | 22182: exit 0 22:43:55 INFO - TEST-OK | dromaeo_css | took 1118992ms 22:43:55 INFO - TEST-START | kraken 22:43:55 INFO - operating with platform_type : linux_ 22:43:55 INFO - Initialising browser for kraken test... 22:43:55 INFO - TEST-INFO | started process 22374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwCR4D/profile http://localhost:32904/getInfo.html) 22:43:59 INFO - PROCESS | 22374 | __metrics Screen width/height:1600/1200 22:43:59 INFO - PROCESS | 22374 | colorDepth:24 22:43:59 INFO - PROCESS | 22374 | Browser inner width/height: 1024/697 22:43:59 INFO - PROCESS | 22374 | __metrics 22:44:00 INFO - PROCESS | 22374 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:44:01 INFO - TEST-INFO | 22374: exit 0 22:44:01 INFO - Browser initialized. 22:44:01 INFO - Running cycle 1/1 for kraken test... 22:44:01 INFO - TEST-INFO | started process 22456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiwCR4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:13 INFO - PROCESS | 22456 | RSS: Main: 158760960 22:44:13 INFO - PROCESS | 22456 | 22:44:16 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-beat-detection) 22:44:16 INFO - PROCESS | 22456 | RSS: Main: 217436160 22:44:16 INFO - PROCESS | 22456 | 22:44:19 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-dft) 22:44:20 INFO - PROCESS | 22456 | RSS: Main: 205115392 22:44:20 INFO - PROCESS | 22456 | 22:44:23 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-fft) 22:44:24 INFO - PROCESS | 22456 | RSS: Main: 271638528 22:44:24 INFO - PROCESS | 22456 | 22:44:26 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32904/tests/kraken/driver.html?testName=audio-oscillator) 22:44:26 INFO - PROCESS | 22456 | RSS: Main: 181714944 22:44:26 INFO - PROCESS | 22456 | 22:44:29 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:44:29 INFO - PROCESS | 22456 | RSS: Main: 186232832 22:44:29 INFO - PROCESS | 22456 | 22:44:32 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-darkroom) 22:44:33 INFO - PROCESS | 22456 | RSS: Main: 221736960 22:44:33 INFO - PROCESS | 22456 | 22:44:37 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32904/tests/kraken/driver.html?testName=imaging-desaturate) 22:44:37 INFO - PROCESS | 22456 | RSS: Main: 217694208 22:44:37 INFO - PROCESS | 22456 | 22:44:40 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32904/tests/kraken/driver.html?testName=json-parse-financial) 22:44:41 INFO - PROCESS | 22456 | RSS: Main: 220332032 22:44:41 INFO - PROCESS | 22456 | 22:44:42 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:44:43 INFO - PROCESS | 22456 | RSS: Main: 206139392 22:44:43 INFO - PROCESS | 22456 | 22:44:45 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:44:46 INFO - PROCESS | 22456 | RSS: Main: 211939328 22:44:46 INFO - PROCESS | 22456 | 22:44:48 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:44:48 INFO - PROCESS | 22456 | RSS: Main: 210903040 22:44:48 INFO - PROCESS | 22456 | 22:44:51 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:44:52 INFO - PROCESS | 22456 | RSS: Main: 224636928 22:44:52 INFO - PROCESS | 22456 | 22:44:55 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:44:55 INFO - PROCESS | 22456 | RSS: Main: 224387072 22:44:55 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | Cycle 1(1): loaded http://localhost:32904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32904/tests/kraken/driver.html?testName=ai-astar) 22:44:57 INFO - PROCESS | 22456 | RSS: Main: 267202560 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | __start_tp_report 22:44:57 INFO - PROCESS | 22456 | _x_x_mozilla_page_load 22:44:57 INFO - PROCESS | 22456 | _x_x_mozilla_page_load_details 22:44:57 INFO - PROCESS | 22456 | |i|pagename|runs| 22:44:57 INFO - PROCESS | 22456 | |0;ai-astar;102;114;111;112;112;113;111;112;112;112 22:44:57 INFO - PROCESS | 22456 | |1;audio-beat-detection;159;125;126;177;122;123;144;124;182;127 22:44:57 INFO - PROCESS | 22456 | |2;audio-dft;161;160;161;161;162;161;161;160;161;159 22:44:57 INFO - PROCESS | 22456 | |3;audio-fft;76;79;76;128;75;77;76;76;97;75 22:44:57 INFO - PROCESS | 22456 | |4;audio-oscillator;85;85;115;85;86;85;119;85;86;125 22:44:57 INFO - PROCESS | 22456 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;118 22:44:57 INFO - PROCESS | 22456 | |6;imaging-darkroom;148;147;148;146;147;146;147;146;146;147 22:44:57 INFO - PROCESS | 22456 | |7;imaging-desaturate;96;95;95;97;95;94;96;95;95;95 22:44:57 INFO - PROCESS | 22456 | |8;json-parse-financial;65;63;63;63;62;63;62;63;63;62 22:44:57 INFO - PROCESS | 22456 | |9;json-stringify-tinderbox;63;65;64;64;65;64;65;65;65;65 22:44:57 INFO - PROCESS | 22456 | |10;stanford-crypto-aes;78;78;78;79;78;78;81;81;78;78 22:44:57 INFO - PROCESS | 22456 | |11;stanford-crypto-ccm;131;133;129;128;127;130;126;144;223;139 22:44:57 INFO - PROCESS | 22456 | |12;stanford-crypto-pbkdf2;165;166;165;164;164;166;165;166;167;169 22:44:57 INFO - PROCESS | 22456 | |13;stanford-crypto-sha256-iterative;67;67;68;68;66;67;66;66;69;65 22:44:57 INFO - PROCESS | 22456 | __end_tp_report 22:44:57 INFO - PROCESS | 22456 | __start_cc_report 22:44:57 INFO - PROCESS | 22456 | _x_x_mozilla_cycle_collect,1886 22:44:57 INFO - PROCESS | 22456 | __end_cc_report 22:44:57 INFO - PROCESS | 22456 | __startTimestamp1467783897710__endTimestamp 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | ------- Summary: start ------- 22:44:57 INFO - PROCESS | 22456 | Number of tests: 14 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.31 (3.0%) stddev-sans-first:0.93 22:44:57 INFO - PROCESS | 22456 | Values: 102.0 114.0 111.0 112.0 112.0 113.0 111.0 112.0 112.0 112.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:135.50 stddev:23.48 (17.3%) stddev-sans-first:23.97 22:44:57 INFO - PROCESS | 22456 | Values: 159.0 125.0 126.0 177.0 122.0 123.0 144.0 124.0 182.0 127.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 22:44:57 INFO - PROCESS | 22456 | Values: 161.0 160.0 161.0 161.0 162.0 161.0 161.0 160.0 161.0 159.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.00 stddev:16.98 (22.3%) stddev-sans-first:17.79 22:44:57 INFO - PROCESS | 22456 | Values: 76.0 79.0 76.0 128.0 75.0 77.0 76.0 76.0 97.0 75.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:85.00 stddev:16.78 (19.7%) stddev-sans-first:17.35 22:44:57 INFO - PROCESS | 22456 | Values: 85.0 85.0 115.0 85.0 86.0 85.0 119.0 85.0 86.0 125.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 22:44:57 INFO - PROCESS | 22456 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 22:44:57 INFO - PROCESS | 22456 | Values: 148.0 147.0 148.0 146.0 147.0 146.0 147.0 146.0 146.0 147.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 22:44:57 INFO - PROCESS | 22456 | Values: 96.0 95.0 95.0 97.0 95.0 94.0 96.0 95.0 95.0 95.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.88 (1.4%) stddev-sans-first:0.50 22:44:57 INFO - PROCESS | 22456 | Values: 65.0 63.0 63.0 63.0 62.0 63.0 62.0 63.0 63.0 62.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.71 (1.1%) stddev-sans-first:0.50 22:44:57 INFO - PROCESS | 22456 | Values: 63.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 65.0 65.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:1.25 (1.6%) stddev-sans-first:1.30 22:44:57 INFO - PROCESS | 22456 | Values: 78.0 78.0 78.0 79.0 78.0 78.0 81.0 81.0 78.0 78.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:132.00 stddev:29.36 (22.2%) stddev-sans-first:30.91 22:44:57 INFO - PROCESS | 22456 | Values: 131.0 133.0 129.0 128.0 127.0 130.0 126.0 144.0 223.0 139.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:166.00 stddev:1.49 (0.9%) stddev-sans-first:1.56 22:44:57 INFO - PROCESS | 22456 | Values: 165.0 166.0 165.0 164.0 164.0 166.0 165.0 166.0 167.0 169.0 22:44:57 INFO - PROCESS | 22456 | 22:44:57 INFO - PROCESS | 22456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 22:44:57 INFO - PROCESS | 22456 | Values: 67.0 67.0 68.0 68.0 66.0 67.0 66.0 66.0 69.0 65.0 22:44:57 INFO - PROCESS | 22456 | -------- Summary: end -------- 22:44:57 INFO - PROCESS | 22456 | 22:44:58 INFO - TEST-INFO | 22456: exit 0 22:44:58 INFO - TEST-OK | kraken | took 63162ms 22:44:58 INFO - SUITE-END | took 1182s 22:44:58 INFO - Completed test suite (00:19:42) 22:44:58 INFO - javascript benchmark 22:44:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2574.227731680496, 2598.909038183664, 2628.8685565721717, 2643.955637523178, 2644.259607309954, 4522.891891486591, 4679.0, 4679.461861885884, 4711.246200607903, 4714.339992401062, 4680.5085466026, 4714.0, 4730.148573256813, 4762.904741905159, 4765.166095933215, 4166.562510936354, 4308.504521979981, 4381.452318460192, 4409.911801763963, 4553.908921821561, 4457.375967364572, 4492.97753511232, 4504.662150338721, 4519.322101684757, 4541.636669066484, 4244.384564238199, 4281.8073186706515, 4312.029793296515, 4335.588119128678, 4364.148990946766, 4255.446791917062, 4270.850520231808, 4314.395984562164, 4315.633171180453, 4321.546237645065, 4310.3103503439615, 4314.525402205755, 4321.611055005064, 4333.025069359401, 4355.4337936068105, 4583.197940360457, 4649.1863923813535, 4713.080949214905, 4717.315989181584, 4724.102420540121, 5055.74721263939, 5095.286659867622, 5099.4390617032095, 5110.6422550421485, 5124.000819840133, 4887.462379138292, 4999.8250061248045, 5033.295338652591, 5123.052235336475, 5140.665856719339, 4729.645276604234, 4764.785584648699, 4786.282057691375, 4793.856184314406, 4802.447718512346, 5204.9590081983, 5209.218617207373, 5212.947870521322, 5219.2953951216095, 5261.105612045962, 4837.201861692782, 4909.386326709161, 4910.0, 4913.950860491421, 4924.03981223658, 4976.850694479172, 5029.974850125726, 5062.392512898476, 5066.189409694432, 5073.315102461194, 4979.3526841510375, 5004.249362595567, 5012.172991456368, 5024.648274620815, 5066.290719299301, 4853.635977301717, 4918.409790825124, 5005.89988200234, 5024.070546948826, 5038.521340472649, 4160.022394737234, 4211.705180637326, 4221.02916329246, 4225.640820530228, 4249.128928569636, 3691.1141326081547, 3694.316551437939, 3696.74122811406, 3732.3841566141828, 3734.2158146788934, 4280.400743895857, 4378.2994720845145, 4380.496242932104, 4421.712588681726, 4425.0, 4893.290472881412, 4989.750512474435, 5011.649184557046, 5012.473690262543, 5037.773300201499, 4318.050028993616, 4345.521992580813, 4346.348047792856, 4348.108637729258, 4388.802503887333, 4337.002489427449, 4470.150671372428, 4470.932936005963, 4472.038511719996, 4508.684392092588, 4672.088942656217, 4743.075100355398, 4760.714357138583, 4760.97619511914, 4767.73777442244, 4975.477574854588, 4976.2286845539, 5008.599312054954, 5010.799568017384, 5058.898822023612, 4656.953430465652, 4715.717056976592, 4716.882077947941, 4735.83424580138, 4776.116418462596, 4954.1330267202375, 4958.231474121517, 5007.39911210657, 5010.098182327216, 5059.46875578059, 5053.418856831365, 5064.442911279682, 5066.569341606005, 5067.543921047123, 5125.743712814419, 4792.257200133985, 4834.685745426536, 4892.290617860319, 4898.706077635354, 4948.035133149001, 4894.412670479565, 4918.631102667243, 4920.803167873245, 4924.03981223658, 4952.529509696573, 4849.0, 4849.854504364875, 4850.83022094225, 4886.706797592155, 4899.485554016777, 4776.426828780569, 4820.68665536739, 4883.536064073907, 4895.804167833389, 4986.426560945538, 4804.447488538863, 4817.710937343771, 4819.180739274402, 4827.08285425782, 4867.659263851497], "value": 4621.02124181046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.0523919814711, 572.436150391864, 582.7261187241998, 586.2935163128429, 587.8089620873217, 27850.303742406424, 28497.430051398984, 30489.23776905576, 30542.389152216998, 30574.388512229798, 30454.543181852234, 41904.79047604765, 43109.35335969955, 43160.13679726404, 47016.294755578696, 7836.882446763318, 7931.206879312052, 7931.682732690685, 7932.127465978738, 7936.5238085714755, 7854.6465409056445, 7908.920910790905, 7951.522908625501, 7956.0, 7956.443048986574, 7959.2836644701965, 8011.158828323029, 8016.358691304711, 8017.95991020047, 8022.638981245858, 7944.563049032301, 7992.360611151123, 8003.839923201504, 8004.199580042007, 8007.439479236397, 7917.129115797257, 7926.80182995424, 7967.760967170994, 7991.24083212094, 7996.560189189592, 39748.60251397478, 40202.0, 40230.195396092204, 40247.0, 40371.0, 2841.5322240473215, 2961.4077184563175, 3012.819230846156, 3022.516397376431, 3155.321605854729, 30276.0, 30704.2323941901, 30722.0, 31092.378152436824, 31148.377032459222, 3207.935841283161, 3208.4385232584204, 3214.4856822908223, 3253.1053960160907, 3266.4610339293986, 289276.0, 294542.0, 295366.0, 381719.0, 381944.0, 56784.716076419354, 57195.0, 57388.71305643445, 57465.425345746844, 57532.424675753544, 33758.83120584382, 34543.82728086394, 34575.82712086423, 36117.0, 36210.0, 15157.621059473602, 15219.847801522064, 15224.46714364992, 15230.619234519005, 15234.390624375123, 10675.306105103144, 10718.839217411745, 10723.410212438392, 10726.785464290671, 10729.731756706145, 18130.728039079426, 18588.44234672962, 18626.627467450577, 18684.626307473773, 18692.906535467508, 6814.1482314710665, 6814.863702725917, 6974.616396098263, 7049.0, 7154.749583764543, 819.7499762572472, 857.9485230886166, 979.7795496013482, 1034.2398337222135, 1062.6387028410377, 28343.29141771472, 28423.857880710464, 28447.43105137927, 29147.0, 29185.27036824054, 981.5043403081398, 1012.5797793915442, 1028.187731691955, 1030.5208078243652, 1066.7973085113804, 15042.699146017238, 15130.848691513163, 15353.539393818204, 15571.143587102819, 15662.138582378078, 388953.0, 389641.0, 390863.0, 392323.0, 394189.0, 50428.0, 50995.23507147396, 51075.74462127666, 51120.0, 51137.48862511327, 1055.1769619696495, 1157.583270022791, 1187.8337032815414, 1188.9405529723479, 1204.2413279633774, 27158.321041974108, 29274.70725292805, 30194.24514387158, 30641.693583064774, 30697.0, 43808.56191438045, 44046.559534405525, 44493.0, 44499.33251001173, 44651.55348446474, 346667.0, 351522.0, 352274.0, 352948.0, 353226.0, 38637.61362386453, 39943.60056399399, 40655.59344406518, 40768.388474172316, 40799.0, 43594.346084808116, 43633.56366436295, 43892.341614876445, 44235.55764442314, 44252.336214957446, 35482.71109246715, 37043.62956370509, 37245.06887327838, 37410.0, 37696.246075078896, 37390.85926124707, 37584.812075939444, 37797.433038505, 37894.0, 37939.81030094832, 35162.47256291209, 36181.27637447289, 36677.44983825298, 36925.26149477049, 36967.630323696416, 31724.682753172172, 33528.1617959553, 33552.664473354955, 33826.66173338235, 34038.3192336147, 25041.74958250394, 25332.873335633205, 25565.744342556336, 25737.742622573536, 25899.352516187246], "value": 17914.87044049151, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.3468496568933, 375.1502846053688, 377.1495278147778, 380.42175892643183, 387.31058715486427, 13161.473541058358, 16513.83486165138, 16904.239309231067, 17733.113344332764, 18582.535436614093, 17450.3019879205, 17540.473785786446, 17632.647347053084, 17798.288068477246, 17934.5516362091, 4872.853814385574, 5162.8193013244545, 5168.664036837594, 5169.224616307546, 5207.583393328525, 3751.1934933989187, 5091.465396133408, 5766.654000759947, 6045.999999999978, 6068.908966365486, 6120.571559990803, 6124.112003759452, 6130.632162070267, 6144.109104179891, 6151.600145990518, 5116.155834287338, 5437.510624043815, 5444.891102177954, 5500.257465242181, 5508.944910550883, 3415.129142068781, 5094.184930411154, 5317.707526086064, 5420.756065977041, 5426.0, 12535.498580056787, 12861.935690321488, 13707.246101464416, 21131.154753809984, 21388.786112138834, 1949.171602069115, 2058.7220725202055, 2332.6734257204007, 2353.5292941411785, 2367.112332875172, 8990.325725570608, 9102.544872756336, 9166.26669866409, 9386.26354124489, 9545.522723863849, 1721.122227663888, 1726.8273172682757, 1743.5902562897709, 1758.2417582417556, 1819.9181036853374, 68279.31720682779, 68760.31239687589, 69709.65145174242, 70592.0, 70598.99999999949, 9341.766455838659, 9788.363756355815, 10102.949485252673, 10421.06210441064, 10947.890521094847, 12060.336681482428, 13078.411471483807, 13088.149270297401, 13467.730645387037, 13617.387217575233, 6300.401461861115, 7526.548407095592, 7582.582957937256, 7591.278828511283, 7718.768436946901, 7194.388476979515, 7277.053982982178, 7341.119065712149, 7397.741079062207, 7485.288897554832, 4243.342281946241, 4347.174036932973, 4349.630281426114, 4470.8435204767675, 4532.9546704533195, 1785.8928464292185, 1866.524036370744, 1880.4828672115277, 1917.5685470769245, 1923.0577017261721, 810.040102478553, 851.8764779106995, 859.5401460218753, 868.9913100869037, 874.61079819481, 17289.740653890203, 17539.73690394645, 18009.099545022695, 18181.81818181828, 18290.0, 829.8340331933516, 836.7531578184451, 857.7941294089499, 885.6103314541581, 896.9282457403392, 9723.805523889625, 9940.652077177409, 9992.400455972665, 9996.0, 10036.749081272881, 309754.4512277469, 351356.0, 361734.0, 362380.0, 367582.0, 75871.62064189644, 78001.60999195081, 78623.60688196523, 78963.60518197372, 81269.59365203136, 874.6151693254948, 882.6601758323092, 886.3972498700946, 898.4968417686117, 899.8110396816611, 15519.146446945526, 15768.0, 15768.211589420713, 15897.205139742735, 16111.919440402722, 24859.378515537257, 34428.48357274593, 37135.628643713215, 37482.62517374791, 37922.0, 49379.753101234266, 49593.0, 49686.0, 50151.0, 50291.497085028685, 7847.136814950465, 7901.446898717035, 7903.723369682033, 7912.4856884302335, 8000.5599692017495, 11157.44212789341, 11856.110791690486, 11955.282683039046, 12086.214396064228, 12212.084093693185, 9625.0374962506, 9972.950135249277, 10089.19286457067, 10297.330673506198, 10540.262181647211, 9617.134457898543, 10185.236107291834, 10700.30448020876, 10710.946445267724, 10747.355158690503, 10475.371477711362, 10479.266451348332, 10510.264281500222, 10652.414117223318, 10749.838752418564, 7717.151113377637, 7807.141214466517, 7932.0878099017045, 7974.800629984296, 8112.22933821286, 10289.53697083648, 10648.574057037631, 10697.572097116028, 10702.304350217211, 10901.236913415985], "value": 8227.566572201255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1392.436063394325, 1398.7062716829466, 1518.8101487314086, 1699.1589163364122, 1733.4052671542179, 7590.772276831697, 7999.560024198681, 8078.63646135923, 8078.71724489643, 8096.878546821795, 6818.829529261771, 7033.753818616349, 7036.824079398018, 7230.891536626955, 7961.7213397531095, 1961.1174971262917, 2112.4718820294925, 2241.540484200735, 2242.4281808138985, 2267.1384873748034, 2191.923282685106, 2218.8557743746687, 2236.642137258039, 2238.1271304191378, 2242.3048854854965, 1899.2877670873422, 2216.26863135165, 2238.787315205053, 2239.395363251921, 2240.003198576634, 2166.6749987501844, 2262.298687406901, 2264.4452109233343, 2277.0664027748544, 2281.8744969026698, 2200.2849074050996, 2208.580369729746, 2219.655953327237, 2238.8544744591713, 2244.079927229844, 8077.273045425881, 8131.064927533291, 8133.349332053422, 8147.307478864303, 8148.674053037871, 4558.703684260512, 4715.858524244278, 4716.52834716529, 4724.574788269072, 4726.558399688094, 2748.189284161177, 2810.1990932584117, 2860.2134413036374, 2935.4129174165037, 2942.529195328737, 828.7928017995501, 849.4011721736161, 853.2320911179926, 859.7549698335944, 860.2300940658076, 10672.466376681135, 10679.893201067967, 10682.839757403644, 10699.518521666465, 10731.409772462512, 3949.763014219156, 4346.500152482442, 4347.260965635849, 4356.825726970949, 4362.6509879210225, 9184.89781226257, 9197.310201734897, 9213.95393023044, 9235.030321816113, 9284.860727089099, 4798.616110711135, 4799.064182484382, 4801.735904525284, 4806.591439727592, 4810.542998415145, 4274.380214868826, 4348.7390756554705, 4358.302671572533, 4367.27939889921, 4373.278409062469, 3366.208940898887, 3495.94756078659, 3496.9825150874085, 3515.8066306352885, 3661.1945372018113, 1167.8832116788253, 1204.4579939027474, 1205.1142410328403, 1209.5826939705787, 1219.7194645231468, 666.2937286476254, 767.8848172774128, 783.7256960064046, 793.4723408932995, 800.5396896784372, 4949.282354058641, 5055.443901170868, 5115.309433226541, 5140.922886156711, 5146.588272938156, 803.863343231652, 806.4999700185922, 838.1325328285195, 838.5848507607452, 844.9281811046008, 3394.711449526818, 3412.146963259185, 3420.6579342066093, 3438.5014172944784, 3486.0761898097026, 9610.51947402627, 9981.351212171186, 10061.245406594535, 10090.646827361006, 10091.596336146618, 9939.304248702521, 9940.25448091396, 9944.1547468466, 9948.552315145836, 9954.552045157985, 7477.476576639583, 7480.8877866832045, 7528.585927774025, 7645.311921927053, 7650.31147196755, 5034.647574669738, 5066.41736200327, 5075.974620126875, 5076.441591424867, 5086.3896332440345, 9000.144986226298, 9124.361294709306, 9272.675456358995, 9350.579223935076, 9430.245580353418, 9170.312226582899, 9486.715398538056, 9509.286803489904, 9552.0, 9557.283203759607, 6834.8633027340165, 6886.965565172142, 6912.758053468105, 6935.0, 6959.860802784017, 6369.808905732835, 7009.2990700929495, 7381.741639042608, 7457.030586023782, 7465.888011679721, 6606.6036037837885, 6713.261541230559, 6819.727210911508, 6922.411595014481, 6948.791536253921, 6409.4231519163495, 6460.192475940507, 6524.6411447368955, 6564.540482166202, 6608.537402381787, 5756.424357564378, 5887.4406931343165, 5887.470127688529, 5892.410758924073, 5892.852678682896, 4158.2307273154565, 4230.471191101113, 4282.100758840678, 4350.543192964819, 4378.0, 4336.3278691802825, 4348.63036641889, 4349.652027837828, 4361.2367835628, 4373.322135069069], "value": 4121.825763865114, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.36215817072383, 300.09072510293805, 306.0985398002882, 306.3199696673385, 306.60754234579747, 4753.738544380058, 4777.402824646919, 4806.279058141281, 4807.591354734847, 4809.4950030246755, 4751.002289519205, 4757.9286310705365, 4758.167320718869, 4762.309465127554, 4763.523647635244, 3599.58827585517, 3708.0, 3711.870084547041, 3747.775133491986, 3784.526934133233, 3736.607656196101, 3769.1707824278615, 3778.6410291022307, 3780.4329350597354, 3791.995121292846, 3720.795356255405, 3736.9813150934206, 3764.1392541668256, 3764.604716504755, 3765.8493660253557, 3546.592141903688, 3648.1791596890753, 3733.701303895682, 3777.924441511182, 3779.5464544254864, 3322.601287845474, 3322.7674062815613, 3330.2506935939464, 3336.6996970272794, 3354.496825476174, 4627.316156629147, 4643.88390290242, 4645.117427688762, 4654.4647365553055, 4676.812927482896, 4200.348945913388, 4264.48826140862, 4288.44250247469, 4294.527601963781, 4306.784660766981, 4908.901821963541, 4912.852614421573, 4915.778789954461, 4933.1860243059855, 4941.555260026615, 3633.2733453309443, 3636.1091532574424, 3640.7087433005295, 3655.597884232732, 3668.6514781095752, 4978.427480839714, 5180.8963820723375, 5187.870303242411, 5203.869903252449, 5238.764255608507, 3620.8913732588067, 3642.6357364263363, 3646.762960407565, 3655.4281658886935, 3661.0115268877253, 3691.390920498088, 3709.8330575124182, 3710.777353358807, 3715.777053376806, 3718.5165928429133, 4218.49378074633, 4219.6580897602125, 4220.577942205755, 4222.838719352141, 4226.640735537452, 4728.763561821896, 4990.0, 4990.201567749143, 5016.398032236082, 5036.748162591929, 1262.8760403241122, 1270.5807083662369, 1278.3161008860216, 1283.6341642631805, 1283.666246775845, 824.2540500846743, 824.8061705499202, 825.5583262954291, 862.8610234490537, 882.2589025218847, 4397.890052748643, 4404.669649776216, 4426.826890873921, 4440.7335559866515, 4442.777861106932, 5111.207762796773, 5119.820806271837, 5137.614678899097, 5149.6910185389, 5153.665011774223, 4232.407462955189, 4409.911801763947, 4417.977910110429, 4421.159979603865, 4423.380726698265, 2732.153032559913, 2740.9725902740715, 2746.40952195279, 2771.5011297966157, 2773.278947473631, 4905.681130726492, 4905.877353066202, 4906.509349065065, 4918.1393256180745, 4951.316552372211, 5045.747712614355, 5282.550983166474, 5289.153735402394, 5314.256004159421, 5328.254044433782, 4918.8770280743265, 4930.556249937451, 4951.653384263067, 4954.5788607968725, 4959.876003099951, 5196.792128314976, 5197.740112994411, 5235.240890070842, 5240.449752775904, 5246.108161612611, 4870.4155501340065, 5084.440711521655, 5089.567386772166, 5124.41069277023, 5140.408852981955, 4927.310176575211, 4946.752662366795, 4955.794671371205, 4965.747435429799, 4966.776495057803, 3699.8890033299044, 3705.98147009274, 3710.944335834911, 3716.8141592919706, 3717.5353080864893, 5080.415752188545, 5173.534381905646, 5178.922316165336, 5199.610029247897, 5202.791888324576, 4963.255511673278, 4963.627727920492, 4963.6525443218625, 4973.303737476828, 4978.950210497848, 4983.476734942778, 5030.270610761492, 5042.697438153723, 5047.192449208109, 5049.374325350724, 4670.579647831712, 4870.512948705243, 4900.485449027943, 4955.306257124078, 4966.485222007323, 4752.667313288037, 4823.252395878644, 4996.675216110941, 5027.7737501813235, 5034.295198672262, 4909.754512274443, 4937.061958227925, 4949.30709700635, 4954.777035033504, 4955.6531042826655], "value": 3786.178343601801, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.3633275722549, 688.2188715807557, 695.3706895259791, 703.1386551474441, 764.6903004283267, 11907.523699052039, 12194.69513262169, 12279.938600306987, 12322.691932701688, 12339.629811105659, 12023.218490798114, 13265.0, 14047.157170569773, 14089.154650720964, 14110.57668269951, 624.7844493649684, 779.6024027745862, 793.6031984007996, 798.6765360029198, 800.7437619961614, 755.9508631938934, 797.6091715059608, 799.7680672604938, 801.0227522422636, 801.2228138705475, 825.22428916818, 831.3764676492631, 832.4797001873828, 832.50881979632, 833.0711256948489, 643.1478291264094, 669.1067424987648, 828.7886588919847, 828.958552072397, 831.0193971114084, 491.62636396338684, 491.9963274919161, 570.5150621971333, 595.9553033522503, 598.2043881637412, 12257.632271031795, 12260.386980650932, 12278.447469863877, 12401.0, 12434.253944763343, 11446.885531144666, 11652.592159274385, 11777.175597708163, 12173.2696038238, 12235.082368822284, 11183.83224251637, 11247.887521124765, 11334.376609286486, 11394.943025284903, 11471.311721296748, 4065.9390109148385, 4096.242195193899, 4148.460700108997, 4153.397757325171, 4285.228658841407, 53750.19374709383, 55857.0, 64216.35783642151, 65335.3466465334, 66304.0, 10108.595656173818, 10173.0, 10318.742031449274, 10346.844797328045, 10499.002594753487, 18212.908935455238, 18404.35584754527, 18488.815111848708, 18518.629627407645, 18557.0, 6932.0988271524375, 7009.824754381181, 7143.357097861218, 7331.303526165006, 7334.413246940232, 3829.9808500957315, 3840.4047372657283, 3924.4701965234326, 3935.4490371348033, 3984.143409167043, 2758.813710104634, 2857.5999360089604, 2862.341661417844, 2863.0838131797623, 2868.0535423310257, 509.5617768718899, 512.1881817319515, 517.3145582103728, 522.1619301021881, 529.0424331959166, 503.57447956476716, 552.2544564837517, 578.774278031568, 589.381149792716, 589.6432658241788, 7845.568493732785, 7884.72403465876, 7900.84198316042, 8952.955235223912, 9247.26021918245, 442.83615062427106, 483.3209340876075, 487.8560824556764, 543.4701166362764, 558.7457706743422, 3659.597444281127, 3791.962080379216, 3953.802309884494, 3956.584558621303, 4124.52567954689, 55127.724361378736, 55131.44868551263, 93514.53242733743, 94991.52504237434, 98698.50650746844, 65009.34990650127, 78201.0, 80211.59894200608, 80811.0, 84154.99999999878, 45158.32262516065, 66864.33135668679, 69467.65266173737, 71274.64362678258, 72387.27612723806, 7283.672234749343, 7406.851862962602, 7441.400098978529, 7514.924850751641, 7576.24237576238, 41028.589714102476, 41267.7936610315, 41865.79067104767, 42027.7898610505, 43131.13737725165, 35691.82154089213, 52425.47574524206, 59784.402155979624, 60069.0, 60129.69935150296, 9762.853557196506, 9800.962922519426, 9862.605495780088, 9957.103860652576, 9966.252531060054, 10697.290907103881, 10884.07485363753, 10920.180986426209, 11002.724931876446, 11134.721631959266, 9534.141927226583, 9786.363886347364, 9871.0, 10007.849882251627, 10110.949445252727, 9721.319507634398, 9767.0, 10036.899631003596, 10350.223733219887, 10359.533820978224, 9979.45113018791, 10212.285140040125, 10352.171826254033, 10400.219983501116, 10748.731281718019, 8863.911360886308, 9104.772380690536, 9133.132352426508, 9141.222996045411, 9425.575849086945, 8652.956735216536, 8916.73249802507, 8948.552572371225, 9035.774105647411, 9155.587998539948], "value": 6249.200846592661, "unit": "score"}], "name": "dromaeo_css", "value": 6364.020277105943, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 111.0, 112.0, 112.0, 113.0, 111.0, 112.0, 112.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 125.0, 126.0, 177.0, 122.0, 123.0, 144.0, 124.0, 182.0, 127.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 76.0, 128.0, 75.0, 77.0, 76.0, 76.0, 97.0, 75.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 115.0, 85.0, 86.0, 85.0, 119.0, 85.0, 86.0, 125.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 95.0, 94.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 78.0, 79.0, 78.0, 78.0, 81.0, 81.0, 78.0, 78.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 133.0, 129.0, 128.0, 127.0, 130.0, 126.0, 144.0, 223.0, 139.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 165.0, 164.0, 164.0, 166.0, 165.0, 166.0, 167.0, 169.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 68.0, 66.0, 67.0, 66.0, 66.0, 69.0, 65.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1530.6, "alertThreshold": 2.0}]} 22:44:58 INFO - Return code: 0 22:44:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:44:59 INFO - # TBPL SUCCESS # 22:44:59 INFO - Running post-action listener: _resource_record_post_action 22:44:59 INFO - ##### 22:44:59 INFO - ##### Finished run-tests step (success) 22:44:59 INFO - ##### 22:44:59 INFO - Running post-run listener: _resource_record_post_run 22:44:59 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 537952256; Read time: 44; Write time: 431660 22:44:59 INFO - TinderboxPrint: CPU usage
12.9% 22:44:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 22:44:59 INFO - TinderboxPrint: I/O write bytes / time
537,952,256 / 431,660 22:44:59 INFO - TinderboxPrint: CPU idle
8,330.8 (87.0%) 22:44:59 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 22:44:59 INFO - TinderboxPrint: Swap in / out
0 / 0 22:44:59 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254504960; Read time: 0; Write time: 239160 22:44:59 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282910720; Read time: 24; Write time: 192500 22:44:59 INFO - Running post-run listener: _upload_blobber_files 22:44:59 INFO - Blob upload gear active. 22:44:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:44:59 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 22:44:59 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'] 22:44:59 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 22:45:00 INFO - (blobuploader) - INFO - Open directory for files ... 22:45:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:45:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:01 INFO - (blobuploader) - INFO - Done attempting. 22:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:45:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:01 INFO - (blobuploader) - INFO - Done attempting. 22:45:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:45:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:45:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:45:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:45:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:45:05 INFO - (blobuploader) - INFO - Done attempting. 22:45:05 INFO - (blobuploader) - INFO - Iteration through files over. 22:45:05 INFO - Return code: 0 22:45:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:45:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:45:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e37bddfc183eefdc283c2f7493cddf845bba92487745cbc8c4247aeb7427df0dbdccccc3f47ffc1b85ed1464fccd8b9bf36b5e3bfe3cd611073c81e8b44fa6f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a3d2bae39e8489b06e3d556455639e653e72dbe8296146840eaa0f1578b76a823000815a06c04b651ff8d72334e7fd55a5e2290f215ddbb87c6b704c2d8703e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09713cb3c70ff5d11bbbb8f8f740a08e1f79328014653c250a1733603dbda102b47cbca2c0bb016c33f226cce95b7f24604cf98b762466244e5aaa0de9575e44"} 22:45:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:45:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:45:05 INFO - Contents: 22:45:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e37bddfc183eefdc283c2f7493cddf845bba92487745cbc8c4247aeb7427df0dbdccccc3f47ffc1b85ed1464fccd8b9bf36b5e3bfe3cd611073c81e8b44fa6f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a3d2bae39e8489b06e3d556455639e653e72dbe8296146840eaa0f1578b76a823000815a06c04b651ff8d72334e7fd55a5e2290f215ddbb87c6b704c2d8703e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09713cb3c70ff5d11bbbb8f8f740a08e1f79328014653c250a1733603dbda102b47cbca2c0bb016c33f226cce95b7f24604cf98b762466244e5aaa0de9575e44"} 22:45:05 INFO - Running post-run listener: copy_logs_to_upload_dir 22:45:05 INFO - Copying logs to upload dir... 22:45:05 INFO - mkdir: /builds/slave/test/build/upload/logs 22:45:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.937509 ========= master_lag: 0.93 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-05 22:45:06.085924) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:45:06.090463) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e37bddfc183eefdc283c2f7493cddf845bba92487745cbc8c4247aeb7427df0dbdccccc3f47ffc1b85ed1464fccd8b9bf36b5e3bfe3cd611073c81e8b44fa6f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a3d2bae39e8489b06e3d556455639e653e72dbe8296146840eaa0f1578b76a823000815a06c04b651ff8d72334e7fd55a5e2290f215ddbb87c6b704c2d8703e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09713cb3c70ff5d11bbbb8f8f740a08e1f79328014653c250a1733603dbda102b47cbca2c0bb016c33f226cce95b7f24604cf98b762466244e5aaa0de9575e44"} build_url:https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/Qr1eWnBGQWWRKYP_EI0s7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e37bddfc183eefdc283c2f7493cddf845bba92487745cbc8c4247aeb7427df0dbdccccc3f47ffc1b85ed1464fccd8b9bf36b5e3bfe3cd611073c81e8b44fa6f1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a3d2bae39e8489b06e3d556455639e653e72dbe8296146840eaa0f1578b76a823000815a06c04b651ff8d72334e7fd55a5e2290f215ddbb87c6b704c2d8703e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/09713cb3c70ff5d11bbbb8f8f740a08e1f79328014653c250a1733603dbda102b47cbca2c0bb016c33f226cce95b7f24604cf98b762466244e5aaa0de9575e44"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 22:45:06.121397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:45:06.121756) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467782666.958221-1887144930 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 22:45:06.170896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:45:06.174291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 22:45:06.174618) ========= ========= Total master_lag: 1.05 =========