builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1468401000.56 results: success (0) buildid: 20160713005508 builduid: b329ca4b58d54178a3c069fb726235ca revision: e0d821942d29279c0213303560505097872b6651 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.564033) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.564563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.564846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.580342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.580736) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 02:10:00-- 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% 63.9M=0s 2016-07-13 02:10:00 (63.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086778 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.682275) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.682650) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015828 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.732441) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:00.732816) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e0d821942d29279c0213303560505097872b6651 --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 e0d821942d29279c0213303560505097872b6651 --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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 02:10:00,874 truncating revision to first 12 chars 2016-07-13 02:10:00,874 Setting DEBUG logging. 2016-07-13 02:10:00,874 attempt 1/10 2016-07-13 02:10:00,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e0d821942d29?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 02:10:01,172 unpacking tar archive at: fx-team-e0d821942d29/testing/mozharness/ program finished with exit code 0 elapsedTime=0.635315 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:01.382024) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:01.382382) ========= script_repo_revision: e0d821942d29279c0213303560505097872b6651 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:01.382773) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:01.383041) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 02:10:01.392719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 02:10:01.393125) ========= /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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:10:01 INFO - MultiFileLogger online at 20160713 02:10:01 in /builds/slave/test 02:10:01 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 02:10:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:10:01 INFO - {'append_to_log': False, 02:10:01 INFO - 'base_work_dir': '/builds/slave/test', 02:10:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:10:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:10:01 INFO - 'branch': 'Fx-Team-Non-PGO', 02:10:01 INFO - 'buildbot_json_path': 'buildprops.json', 02:10:01 INFO - 'config_files': ('talos/linux_config.py',), 02:10:01 INFO - 'default_actions': ('clobber', 02:10:01 INFO - 'read-buildbot-config', 02:10:01 INFO - 'download-and-extract', 02:10:01 INFO - 'populate-webroot', 02:10:01 INFO - 'create-virtualenv', 02:10:01 INFO - 'install', 02:10:01 INFO - 'run-tests'), 02:10:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:10:01 INFO - 'download_minidump_stackwalk': True, 02:10:01 INFO - 'download_symbols': 'ondemand', 02:10:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:10:01 INFO - 'tooltool.py': '/tools/tooltool.py', 02:10:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:10:01 INFO - '/tools/misc-python/virtualenv.py')}, 02:10:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:10:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:10:01 INFO - 'installer_path': 'installer.exe', 02:10:01 INFO - 'log_level': 'info', 02:10:01 INFO - 'log_name': 'talos', 02:10:01 INFO - 'log_to_console': True, 02:10:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:10:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:10:01 INFO - 'opt_config_files': (), 02:10:01 INFO - 'pip_index': False, 02:10:01 INFO - 'sps_profile': False, 02:10:01 INFO - 'sps_profile_interval': 0, 02:10:01 INFO - 'suite': 'dromaeojs', 02:10:01 INFO - 'system_bits': '32', 02:10:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:10:01 INFO - 'title': 'talos-linux64-ix-011', 02:10:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:10:01 INFO - 'use_talos_json': True, 02:10:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:10:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:10:01 INFO - 'work_dir': 'build'} 02:10:01 INFO - ##### 02:10:01 INFO - ##### Running clobber step. 02:10:01 INFO - ##### 02:10:01 INFO - Running pre-action listener: _resource_record_pre_action 02:10:01 INFO - Running main action method: clobber 02:10:01 INFO - rmtree: /builds/slave/test/build 02:10:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:10:02 INFO - Running post-action listener: _resource_record_post_action 02:10:02 INFO - ##### 02:10:02 INFO - ##### Finished clobber step (success) 02:10:02 INFO - ##### 02:10:02 INFO - ##### 02:10:02 INFO - ##### Running read-buildbot-config step. 02:10:02 INFO - ##### 02:10:02 INFO - Running pre-action listener: _resource_record_pre_action 02:10:02 INFO - Running main action method: read_buildbot_config 02:10:02 INFO - Using buildbot properties: 02:10:02 INFO - { 02:10:02 INFO - "project": "", 02:10:02 INFO - "product": "firefox", 02:10:02 INFO - "script_repo_revision": "production", 02:10:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:10:02 INFO - "repository": "", 02:10:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 02:10:02 INFO - "buildid": "20160713005508", 02:10:02 INFO - "pgo_build": "False", 02:10:02 INFO - "basedir": "/builds/slave/test", 02:10:02 INFO - "buildnumber": 1801, 02:10:02 INFO - "slavename": "talos-linux64-ix-011", 02:10:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:10:02 INFO - "platform": "ubuntu64_hw", 02:10:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:10:02 INFO - "branch": "fx-team", 02:10:02 INFO - "repo_path": "integration/fx-team", 02:10:02 INFO - "revision": "e0d821942d29279c0213303560505097872b6651", 02:10:02 INFO - "stage_platform": "linux64", 02:10:02 INFO - "builduid": "b329ca4b58d54178a3c069fb726235ca", 02:10:02 INFO - "slavebuilddir": "test" 02:10:02 INFO - } 02:10:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:10:02 INFO - Running post-action listener: _resource_record_post_action 02:10:02 INFO - ##### 02:10:02 INFO - ##### Finished read-buildbot-config step (success) 02:10:02 INFO - ##### 02:10:02 INFO - ##### 02:10:02 INFO - ##### Running download-and-extract step. 02:10:02 INFO - ##### 02:10:02 INFO - Running pre-action listener: _resource_record_pre_action 02:10:02 INFO - Running main action method: download_and_extract 02:10:02 INFO - mkdir: /builds/slave/test/build/tests 02:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:02 INFO - https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:02 INFO - Downloaded 1361 bytes. 02:10:02 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:10:02 INFO - Using the following test package requirements: 02:10:02 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:02 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:10:02 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:10:02 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'jsshell-linux-x86_64.zip'], 02:10:02 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:10:02 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:10:02 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:10:02 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:10:02 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:10:02 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:10:02 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:10:02 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:02 INFO - https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:03 INFO - Downloaded 22750981 bytes. 02:10:03 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'] 02:10:03 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 02:10:05 INFO - Return code: 0 02:10:05 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 02:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:05 INFO - https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:10:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:10:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:06 INFO - Downloaded 22750981 bytes. 02:10:06 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'] 02:10:06 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 02:10:07 INFO - Return code: 0 02:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:07 INFO - https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:10:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:10:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:08 INFO - Downloaded 14403317 bytes. 02:10:08 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'] 02:10:08 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 02:10:08 INFO - Return code: 0 02:10:08 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')]} 02:10:08 INFO - https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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 02:10:10 INFO - Downloaded 57019813 bytes. 02:10:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:10 INFO - mkdir: /builds/slave/test/properties 02:10:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:10:10 INFO - Writing to file /builds/slave/test/properties/build_url 02:10:10 INFO - Contents: 02:10:10 INFO - build_url:https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:10:10 INFO - Running post-action listener: _resource_record_post_action 02:10:10 INFO - Running post-action listener: set_extra_try_arguments 02:10:10 INFO - ##### 02:10:10 INFO - ##### Finished download-and-extract step (success) 02:10:10 INFO - ##### 02:10:10 INFO - ##### 02:10:10 INFO - ##### Running populate-webroot step. 02:10:10 INFO - ##### 02:10:10 INFO - Running pre-action listener: _resource_record_pre_action 02:10:10 INFO - Running main action method: populate_webroot 02:10:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:10:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:10:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:10:10 INFO - '--tppagecycles', 02:10:10 INFO - '7'], 02:10:10 INFO - 'tests': ['tsvgm']}}, 02:10:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:10:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:10:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:10:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:10:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:10:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['damp', 'tps']}, 02:10:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['damp', 'tps']}, 02:10:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['dromaeo_dom']}, 02:10:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:10:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['basic_compositor_video']}, 02:10:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:10:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'other-e10s': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['a11yr', 02:10:10 INFO - 'ts_paint', 02:10:10 INFO - 'tpaint', 02:10:10 INFO - 'sessionrestore', 02:10:10 INFO - 'sessionrestore_no_auto_restore', 02:10:10 INFO - 'tabpaint']}, 02:10:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['tsvgx', 02:10:10 INFO - 'tsvgr_opacity', 02:10:10 INFO - 'tart', 02:10:10 INFO - 'tscrollx', 02:10:10 INFO - 'cart']}, 02:10:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:10:10 INFO - 'tsvgr_opacity', 02:10:10 INFO - 'tart', 02:10:10 INFO - 'tscrollx', 02:10:10 INFO - 'cart']}, 02:10:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--disable-e10s'], 02:10:10 INFO - 'tests': ['tp5o']}, 02:10:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'tests': ['tp5o']}, 02:10:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--disable-e10s', 02:10:10 INFO - '--xperf_path', 02:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:10 INFO - 'tests': ['tp5n']}, 02:10:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:10:10 INFO - 'talos_options': ['--xperf_path', 02:10:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:10:10 INFO - 'tests': ['tp5n']}}, 02:10:10 INFO - 'talos.zip': {'path': '', 02:10:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:10:10 INFO - Running post-action listener: _resource_record_post_action 02:10:10 INFO - ##### 02:10:10 INFO - ##### Finished populate-webroot step (success) 02:10:10 INFO - ##### 02:10:10 INFO - ##### 02:10:10 INFO - ##### Running create-virtualenv step. 02:10:10 INFO - ##### 02:10:10 INFO - Running pre-action listener: _resource_record_pre_action 02:10:10 INFO - Running main action method: create_virtualenv 02:10:10 INFO - Creating virtualenv /builds/slave/test/build/venv 02:10:10 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 02:10:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:10:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:10:10 INFO - Using real prefix '/usr' 02:10:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:10:11 INFO - Installing distribute.............................................................................................................................................................................................done. 02:10:13 INFO - Installing pip.................done. 02:10:13 INFO - Return code: 0 02:10:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:13 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 02:10:13 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 02:10:13 INFO - Using env: {'DISPLAY': ':0', 02:10:13 INFO - 'HOME': '/home/cltbld', 02:10:13 INFO - 'LANG': 'en_US.UTF-8', 02:10:13 INFO - 'LANGUAGE': 'en_US:en', 02:10:13 INFO - 'LOGNAME': 'cltbld', 02:10:13 INFO - 'MAIL': '/var/mail/cltbld', 02:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:13 INFO - 'MOZ_NO_REMOTE': '1', 02:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:13 INFO - 'NO_EM_RESTART': '1', 02:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:13 INFO - 'PWD': '/builds/slave/test', 02:10:13 INFO - 'SHELL': '/bin/bash', 02:10:13 INFO - 'SHLVL': '1', 02:10:13 INFO - 'TERM': 'linux', 02:10:13 INFO - 'TMOUT': '86400', 02:10:13 INFO - 'USER': 'cltbld', 02:10:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:13 INFO - '_': '/tools/buildbot/bin/python'} 02:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:13 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 02:10:13 INFO - Cleaning up... 02:10:13 INFO - Return code: 0 02:10:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:13 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:13 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 02:10:13 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 02:10:13 INFO - Using env: {'DISPLAY': ':0', 02:10:13 INFO - 'HOME': '/home/cltbld', 02:10:13 INFO - 'LANG': 'en_US.UTF-8', 02:10:13 INFO - 'LANGUAGE': 'en_US:en', 02:10:13 INFO - 'LOGNAME': 'cltbld', 02:10:13 INFO - 'MAIL': '/var/mail/cltbld', 02:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:13 INFO - 'MOZ_NO_REMOTE': '1', 02:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:13 INFO - 'NO_EM_RESTART': '1', 02:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:13 INFO - 'PWD': '/builds/slave/test', 02:10:13 INFO - 'SHELL': '/bin/bash', 02:10:13 INFO - 'SHLVL': '1', 02:10:13 INFO - 'TERM': 'linux', 02:10:13 INFO - 'TMOUT': '86400', 02:10:13 INFO - 'USER': 'cltbld', 02:10:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:13 INFO - '_': '/tools/buildbot/bin/python'} 02:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:13 INFO - Downloading/unpacking psutil>=3.1.1 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:10:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:15 INFO - Installing collected packages: psutil 02:10:15 INFO - Running setup.py install for psutil 02:10:15 INFO - building 'psutil._psutil_linux' extension 02:10:15 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 02:10:16 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 02:10:16 INFO - building 'psutil._psutil_posix' extension 02:10:16 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 02:10:16 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 02:10:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:10:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:10:16 INFO - Successfully installed psutil 02:10:16 INFO - Cleaning up... 02:10:16 INFO - Return code: 0 02:10:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:10:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:10:16 INFO - Using env: {'DISPLAY': ':0', 02:10:16 INFO - 'HOME': '/home/cltbld', 02:10:16 INFO - 'LANG': 'en_US.UTF-8', 02:10:16 INFO - 'LANGUAGE': 'en_US:en', 02:10:16 INFO - 'LOGNAME': 'cltbld', 02:10:16 INFO - 'MAIL': '/var/mail/cltbld', 02:10:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:16 INFO - 'MOZ_NO_REMOTE': '1', 02:10:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:16 INFO - 'NO_EM_RESTART': '1', 02:10:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:16 INFO - 'PWD': '/builds/slave/test', 02:10:16 INFO - 'SHELL': '/bin/bash', 02:10:16 INFO - 'SHLVL': '1', 02:10:16 INFO - 'TERM': 'linux', 02:10:16 INFO - 'TMOUT': '86400', 02:10:16 INFO - 'USER': 'cltbld', 02:10:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:16 INFO - '_': '/tools/buildbot/bin/python'} 02:10:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:16 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 02:10:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:10:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:10:18 INFO - Installing collected packages: mozsystemmonitor 02:10:18 INFO - Running setup.py install for mozsystemmonitor 02:10:18 INFO - Successfully installed mozsystemmonitor 02:10:18 INFO - Cleaning up... 02:10:18 INFO - Return code: 0 02:10:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:10:18 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')]} 02:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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')]} 02:10:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:18 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:18 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 02:10:18 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 02:10:18 INFO - Using env: {'DISPLAY': ':0', 02:10:18 INFO - 'HOME': '/home/cltbld', 02:10:18 INFO - 'LANG': 'en_US.UTF-8', 02:10:18 INFO - 'LANGUAGE': 'en_US:en', 02:10:18 INFO - 'LOGNAME': 'cltbld', 02:10:18 INFO - 'MAIL': '/var/mail/cltbld', 02:10:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:18 INFO - 'MOZ_NO_REMOTE': '1', 02:10:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:18 INFO - 'NO_EM_RESTART': '1', 02:10:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:18 INFO - 'PWD': '/builds/slave/test', 02:10:18 INFO - 'SHELL': '/bin/bash', 02:10:18 INFO - 'SHLVL': '1', 02:10:18 INFO - 'TERM': 'linux', 02:10:18 INFO - 'TMOUT': '86400', 02:10:18 INFO - 'USER': 'cltbld', 02:10:18 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:18 INFO - '_': '/tools/buildbot/bin/python'} 02:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:18 INFO - Downloading/unpacking jsonschema==2.5.1 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:18 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 02:10:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:10:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:20 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 02:10:21 INFO - Downloading functools32-3.2.3-2.tar.gz 02:10:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:10:21 INFO - warning: no files found matching '*.txt' 02:10:21 INFO - no previously-included directories found matching 'build' 02:10:21 INFO - no previously-included directories found matching 'dist' 02:10:21 INFO - no previously-included directories found matching '.git*' 02:10:21 INFO - Installing collected packages: jsonschema, functools32 02:10:21 INFO - Running setup.py install for functools32 02:10:21 INFO - warning: no files found matching '*.txt' 02:10:21 INFO - no previously-included directories found matching 'build' 02:10:21 INFO - no previously-included directories found matching 'dist' 02:10:21 INFO - no previously-included directories found matching '.git*' 02:10:21 INFO - Successfully installed jsonschema functools32 02:10:21 INFO - Cleaning up... 02:10:21 INFO - Return code: 0 02:10:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:10:21 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')]} 02:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:21 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')]} 02:10:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:21 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:21 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 02:10:21 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 02:10:21 INFO - Using env: {'DISPLAY': ':0', 02:10:21 INFO - 'HOME': '/home/cltbld', 02:10:21 INFO - 'LANG': 'en_US.UTF-8', 02:10:21 INFO - 'LANGUAGE': 'en_US:en', 02:10:21 INFO - 'LOGNAME': 'cltbld', 02:10:21 INFO - 'MAIL': '/var/mail/cltbld', 02:10:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:21 INFO - 'MOZ_NO_REMOTE': '1', 02:10:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:21 INFO - 'NO_EM_RESTART': '1', 02:10:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:21 INFO - 'PWD': '/builds/slave/test', 02:10:21 INFO - 'SHELL': '/bin/bash', 02:10:21 INFO - 'SHLVL': '1', 02:10:21 INFO - 'TERM': 'linux', 02:10:21 INFO - 'TMOUT': '86400', 02:10:21 INFO - 'USER': 'cltbld', 02:10:21 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:21 INFO - '_': '/tools/buildbot/bin/python'} 02:10:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:21 INFO - Downloading/unpacking blobuploader==1.2.4 02:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:10:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:10:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:10:23 INFO - Downloading blobuploader-1.2.4.tar.gz 02:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:10:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:10:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:23 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 02:10:24 INFO - Downloading docopt-0.6.1.tar.gz 02:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:10:24 INFO - Installing collected packages: blobuploader, requests, docopt 02:10:24 INFO - Running setup.py install for blobuploader 02:10:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:10:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:10:24 INFO - Running setup.py install for requests 02:10:24 INFO - Running setup.py install for docopt 02:10:24 INFO - Successfully installed blobuploader requests docopt 02:10:24 INFO - Cleaning up... 02:10:24 INFO - Return code: 0 02:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:24 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')]} 02:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 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')]} 02:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:24 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:24 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 02:10:24 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 02:10:24 INFO - Using env: {'DISPLAY': ':0', 02:10:24 INFO - 'HOME': '/home/cltbld', 02:10:24 INFO - 'LANG': 'en_US.UTF-8', 02:10:24 INFO - 'LANGUAGE': 'en_US:en', 02:10:24 INFO - 'LOGNAME': 'cltbld', 02:10:24 INFO - 'MAIL': '/var/mail/cltbld', 02:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:24 INFO - 'MOZ_NO_REMOTE': '1', 02:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:24 INFO - 'NO_EM_RESTART': '1', 02:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:24 INFO - 'PWD': '/builds/slave/test', 02:10:24 INFO - 'SHELL': '/bin/bash', 02:10:24 INFO - 'SHLVL': '1', 02:10:24 INFO - 'TERM': 'linux', 02:10:24 INFO - 'TMOUT': '86400', 02:10:24 INFO - 'USER': 'cltbld', 02:10:24 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:24 INFO - '_': '/tools/buildbot/bin/python'} 02:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:25 INFO - Running setup.py (path:/tmp/pip-hUz5d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:25 INFO - Running setup.py (path:/tmp/pip-N2qbqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:25 INFO - Running setup.py (path:/tmp/pip-NaSBe3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:25 INFO - Running setup.py (path:/tmp/pip-unXFEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:25 INFO - Running setup.py (path:/tmp/pip-B1LlSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:25 INFO - Running setup.py (path:/tmp/pip-fz4LZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:25 INFO - Running setup.py (path:/tmp/pip-EfrclQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:25 INFO - Running setup.py (path:/tmp/pip-tTr0wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:25 INFO - Running setup.py (path:/tmp/pip-1323fE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:25 INFO - Running setup.py (path:/tmp/pip-86cqmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:25 INFO - Running setup.py (path:/tmp/pip-m4SQmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:25 INFO - Running setup.py (path:/tmp/pip-Fz4SaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:25 INFO - Running setup.py (path:/tmp/pip-1r8sug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:25 INFO - Running setup.py (path:/tmp/pip-MofPJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Running setup.py (path:/tmp/pip-nEnPn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:26 INFO - Running setup.py (path:/tmp/pip-6jt8Gw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:26 INFO - Running setup.py (path:/tmp/pip-3KJ5W0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:10:26 INFO - Running setup.py install for manifestparser 02:10:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Running setup.py install for mozcrash 02:10:26 INFO - Running setup.py install for mozdebug 02:10:26 INFO - Running setup.py install for mozdevice 02:10:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Running setup.py install for mozfile 02:10:26 INFO - Running setup.py install for mozhttpd 02:10:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Running setup.py install for mozinfo 02:10:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:10:26 INFO - Running setup.py install for mozInstall 02:10:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozleak 02:10:27 INFO - Running setup.py install for mozlog 02:10:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for moznetwork 02:10:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozprocess 02:10:27 INFO - Running setup.py install for mozprofile 02:10:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozrunner 02:10:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:10:27 INFO - Running setup.py install for mozscreenshot 02:10:27 INFO - Running setup.py install for moztest 02:10:27 INFO - Running setup.py install for mozversion 02:10:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:10:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:10:28 INFO - Cleaning up... 02:10:28 INFO - Return code: 0 02:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:28 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')]} 02:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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')]} 02:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:28 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:28 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 02:10:28 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 02:10:28 INFO - Using env: {'DISPLAY': ':0', 02:10:28 INFO - 'HOME': '/home/cltbld', 02:10:28 INFO - 'LANG': 'en_US.UTF-8', 02:10:28 INFO - 'LANGUAGE': 'en_US:en', 02:10:28 INFO - 'LOGNAME': 'cltbld', 02:10:28 INFO - 'MAIL': '/var/mail/cltbld', 02:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:28 INFO - 'MOZ_NO_REMOTE': '1', 02:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:28 INFO - 'NO_EM_RESTART': '1', 02:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:28 INFO - 'PWD': '/builds/slave/test', 02:10:28 INFO - 'SHELL': '/bin/bash', 02:10:28 INFO - 'SHLVL': '1', 02:10:28 INFO - 'TERM': 'linux', 02:10:28 INFO - 'TMOUT': '86400', 02:10:28 INFO - 'USER': 'cltbld', 02:10:28 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:28 INFO - '_': '/tools/buildbot/bin/python'} 02:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:10:28 INFO - Running setup.py (path:/tmp/pip-ANZJLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:10:28 INFO - Running setup.py (path:/tmp/pip-1nXI0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:10:28 INFO - Running setup.py (path:/tmp/pip-49CDG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:10:28 INFO - Running setup.py (path:/tmp/pip-dnPwxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:10:28 INFO - Running setup.py (path:/tmp/pip-x_iCfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:10:28 INFO - Running setup.py (path:/tmp/pip-8lTovL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:10:28 INFO - Running setup.py (path:/tmp/pip-r4UkL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:10:28 INFO - Running setup.py (path:/tmp/pip-D5FEFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:10:28 INFO - Running setup.py (path:/tmp/pip-i2beyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:10:28 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)) 02:10:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:10:28 INFO - Running setup.py (path:/tmp/pip-ECAtgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:10:29 INFO - Running setup.py (path:/tmp/pip-NVg8bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:10:29 INFO - Running setup.py (path:/tmp/pip-lP878t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:10:29 INFO - Running setup.py (path:/tmp/pip-90lj5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:10:29 INFO - Running setup.py (path:/tmp/pip-WdP0nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:10:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:29 INFO - Running setup.py (path:/tmp/pip-6uimQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:10:29 INFO - Running setup.py (path:/tmp/pip-O_7Hm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:10:29 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)) 02:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:10:29 INFO - Running setup.py (path:/tmp/pip-gR1rUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:10:29 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)) 02:10:29 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)) 02:10:29 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)) 02:10:29 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)) 02:10:29 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)) 02:10:29 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)) 02:10:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:29 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 02:10:31 INFO - Downloading blessings-1.6.tar.gz 02:10:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:10:31 INFO - Installing collected packages: blessings 02:10:31 INFO - Running setup.py install for blessings 02:10:31 INFO - Successfully installed blessings 02:10:31 INFO - Cleaning up... 02:10:31 INFO - Return code: 0 02:10:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:10:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:31 INFO - Reading from file tmpfile_stdout 02:10:31 INFO - Current package versions: 02:10:31 INFO - argparse == 1.2.1 02:10:31 INFO - blessings == 1.6 02:10:31 INFO - blobuploader == 1.2.4 02:10:31 INFO - docopt == 0.6.1 02:10:31 INFO - functools32 == 3.2.3-2 02:10:31 INFO - jsonschema == 2.5.1 02:10:31 INFO - manifestparser == 1.1 02:10:31 INFO - mozInstall == 1.12 02:10:31 INFO - mozcrash == 0.17 02:10:31 INFO - mozdebug == 0.1 02:10:31 INFO - mozdevice == 0.48 02:10:31 INFO - mozfile == 1.2 02:10:31 INFO - mozhttpd == 0.7 02:10:31 INFO - mozinfo == 0.9 02:10:31 INFO - mozleak == 0.1 02:10:31 INFO - mozlog == 3.2 02:10:31 INFO - moznetwork == 0.27 02:10:31 INFO - mozprocess == 0.23 02:10:31 INFO - mozprofile == 0.28 02:10:31 INFO - mozrunner == 6.12 02:10:31 INFO - mozscreenshot == 0.1 02:10:31 INFO - mozsystemmonitor == 0.3 02:10:31 INFO - moztest == 0.7 02:10:31 INFO - mozversion == 1.4 02:10:31 INFO - psutil == 3.1.1 02:10:31 INFO - requests == 1.2.3 02:10:31 INFO - wsgiref == 0.1.2 02:10:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:10:31 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')]} 02:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:31 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')]} 02:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:31 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:31 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 02:10:31 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 02:10:31 INFO - Using env: {'DISPLAY': ':0', 02:10:31 INFO - 'HOME': '/home/cltbld', 02:10:31 INFO - 'LANG': 'en_US.UTF-8', 02:10:31 INFO - 'LANGUAGE': 'en_US:en', 02:10:31 INFO - 'LOGNAME': 'cltbld', 02:10:31 INFO - 'MAIL': '/var/mail/cltbld', 02:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:31 INFO - 'MOZ_NO_REMOTE': '1', 02:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:31 INFO - 'NO_EM_RESTART': '1', 02:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:31 INFO - 'PWD': '/builds/slave/test', 02:10:31 INFO - 'SHELL': '/bin/bash', 02:10:31 INFO - 'SHLVL': '1', 02:10:31 INFO - 'TERM': 'linux', 02:10:31 INFO - 'TMOUT': '86400', 02:10:31 INFO - 'USER': 'cltbld', 02:10:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:31 INFO - '_': '/tools/buildbot/bin/python'} 02:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 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)) 02:10:32 INFO - Cleaning up... 02:10:32 INFO - Return code: 0 02:10:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:10: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')]} 02:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10: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')]} 02:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:10:32 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 0xd3d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xea08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xffe180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, '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': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', '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 02:10:32 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 02:10:32 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 02:10:32 INFO - Using env: {'DISPLAY': ':0', 02:10:32 INFO - 'HOME': '/home/cltbld', 02:10:32 INFO - 'LANG': 'en_US.UTF-8', 02:10:32 INFO - 'LANGUAGE': 'en_US:en', 02:10:32 INFO - 'LOGNAME': 'cltbld', 02:10:32 INFO - 'MAIL': '/var/mail/cltbld', 02:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:32 INFO - 'MOZ_NO_REMOTE': '1', 02:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:32 INFO - 'NO_EM_RESTART': '1', 02:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:32 INFO - 'PWD': '/builds/slave/test', 02:10:32 INFO - 'SHELL': '/bin/bash', 02:10:32 INFO - 'SHLVL': '1', 02:10:32 INFO - 'TERM': 'linux', 02:10:32 INFO - 'TMOUT': '86400', 02:10:32 INFO - 'USER': 'cltbld', 02:10:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:32 INFO - '_': '/tools/buildbot/bin/python'} 02:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:10:32 INFO - Cleaning up... 02:10:32 INFO - Return code: 0 02:10:32 INFO - Running post-action listener: _resource_record_post_action 02:10:32 INFO - Running post-action listener: _start_resource_monitoring 02:10:32 INFO - Starting resource monitoring. 02:10:32 INFO - ##### 02:10:32 INFO - ##### Finished create-virtualenv step (success) 02:10:32 INFO - ##### 02:10:32 INFO - ##### 02:10:32 INFO - ##### Running install step. 02:10:32 INFO - ##### 02:10:32 INFO - Running pre-action listener: _resource_record_pre_action 02:10:32 INFO - Running main action method: install 02:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:10:32 INFO - Reading from file tmpfile_stdout 02:10:32 INFO - Detecting whether we're running mozinstall >=1.0... 02:10:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:10:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:10:32 INFO - Reading from file tmpfile_stdout 02:10:32 INFO - Output received: 02:10:32 INFO - Usage: mozinstall [options] installer 02:10:32 INFO - Options: 02:10:32 INFO - -h, --help show this help message and exit 02:10:32 INFO - -d DEST, --destination=DEST 02:10:32 INFO - Directory to install application into. [default: 02:10:32 INFO - "/builds/slave/test"] 02:10:32 INFO - --app=APP Application being installed. [default: firefox] 02:10:32 INFO - mkdir: /builds/slave/test/build/application 02:10:32 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'] 02:10:32 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 02:10:48 INFO - Reading from file tmpfile_stdout 02:10:48 INFO - Output received: 02:10:48 INFO - /builds/slave/test/build/application/firefox/firefox 02:10:48 INFO - Running post-action listener: _resource_record_post_action 02:10:48 INFO - ##### 02:10:48 INFO - ##### Finished install step (success) 02:10:48 INFO - ##### 02:10:48 INFO - ##### 02:10:48 INFO - ##### Running run-tests step. 02:10:48 INFO - ##### 02:10:48 INFO - Running pre-action listener: _resource_record_pre_action 02:10:48 INFO - Running main action method: run_tests 02:10:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:10:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:10:49 INFO - Python 2.7.3 02:10:49 INFO - Return code: 0 02:10:49 INFO - grabbing minidump binary from tooltool 02:10:49 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')]} 02:10:49 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 0xffc3b0>, '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 0xffd2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xffd740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:10:49 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 02:10:49 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 02:10:49 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 02:10:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:10:49 INFO - Return code: 0 02:10:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:10:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:10:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:10:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:10:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:10:49 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/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 02:10:49 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/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 02:10:49 INFO - Using env: {'DISPLAY': ':0', 02:10:49 INFO - 'HOME': '/home/cltbld', 02:10:49 INFO - 'LANG': 'en_US.UTF-8', 02:10:49 INFO - 'LANGUAGE': 'en_US:en', 02:10:49 INFO - 'LOGNAME': 'cltbld', 02:10:49 INFO - 'MAIL': '/var/mail/cltbld', 02:10:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:10:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:10:49 INFO - 'MOZ_NO_REMOTE': '1', 02:10:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:10:49 INFO - 'NO_EM_RESTART': '1', 02:10:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:10:49 INFO - 'PWD': '/builds/slave/test', 02:10:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:10:49 INFO - 'SHELL': '/bin/bash', 02:10:49 INFO - 'SHLVL': '1', 02:10:49 INFO - 'TERM': 'linux', 02:10:49 INFO - 'TMOUT': '86400', 02:10:49 INFO - 'USER': 'cltbld', 02:10:49 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417', 02:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:10:49 INFO - '_': '/tools/buildbot/bin/python'} 02:10:49 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/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 02:10:49 INFO - mozversion application_buildid: 20160713005508 02:10:49 INFO - mozversion application_changeset: e0d821942d29279c0213303560505097872b6651 02:10:49 INFO - mozversion application_display_name: Nightly 02:10:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:10:49 INFO - mozversion application_name: Firefox 02:10:49 INFO - mozversion application_remotingname: firefox 02:10:49 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:10:49 INFO - mozversion application_vendor: Mozilla 02:10:49 INFO - mozversion application_version: 50.0a1 02:10:49 INFO - mozversion platform_buildid: 20160713005508 02:10:49 INFO - mozversion platform_changeset: e0d821942d29279c0213303560505097872b6651 02:10:49 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:10:49 INFO - mozversion platform_version: 50.0a1 02:10:49 INFO - using testdate: 1468401049 02:10:49 INFO - actual date: 1468401049 02:10:49 INFO - starting webserver on 'localhost:38290' 02:10:49 INFO - SUITE-START | Running 2 tests 02:10:49 INFO - TEST-START | dromaeo_css 02:10:49 INFO - operating with platform_type : linux_ 02:10:49 INFO - Initialising browser for dromaeo_css test... 02:10:49 INFO - TEST-INFO | started process 23775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyU0jJ/profile http://localhost:38290/getInfo.html) 02:10:55 INFO - PROCESS | 23775 | __metrics Screen width/height:1600/1200 02:10:55 INFO - PROCESS | 23775 | colorDepth:24 02:10:55 INFO - PROCESS | 23775 | Browser inner width/height: 1024/697 02:10:55 INFO - PROCESS | 23775 | __metrics 02:10:56 INFO - PROCESS | 23775 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:10:56 INFO - PROCESS | 23775 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:10:57 INFO - TEST-INFO | 23775: exit 0 02:10:57 INFO - Browser initialized. 02:10:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:10:57 INFO - TEST-INFO | started process 23860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyU0jJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:11:09 INFO - PROCESS | 23860 | RSS: Main: 158838784 02:11:09 INFO - PROCESS | 23860 | 02:12:00 INFO - PROCESS | 23860 | 1468401120154 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] 02:14:13 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38290/tests/dromaeo/cssquery-ext.html) 02:14:14 INFO - PROCESS | 23860 | RSS: Main: 236171264 02:14:14 INFO - PROCESS | 23860 | 02:17:16 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-ext.html (next: http://localhost:38290/tests/dromaeo/cssquery-jquery.html) 02:17:17 INFO - PROCESS | 23860 | RSS: Main: 240242688 02:17:17 INFO - PROCESS | 23860 | 02:20:19 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38290/tests/dromaeo/cssquery-mootools.html) 02:20:20 INFO - PROCESS | 23860 | RSS: Main: 242376704 02:20:20 INFO - PROCESS | 23860 | 02:23:22 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38290/tests/dromaeo/cssquery-prototype.html) 02:23:23 INFO - PROCESS | 23860 | RSS: Main: 233783296 02:23:23 INFO - PROCESS | 23860 | 02:26:26 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38290/tests/dromaeo/cssquery-yui.html) 02:26:26 INFO - PROCESS | 23860 | RSS: Main: 219062272 02:26:26 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | Cycle 1(1): loaded http://localhost:38290/tests/dromaeo/cssquery-yui.html (next: http://localhost:38290/tests/dromaeo/cssquery-dojo.html) 02:29:30 INFO - PROCESS | 23860 | RSS: Main: 293711872 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | __start_tp_report 02:29:30 INFO - PROCESS | 23860 | _x_x_mozilla_page_load 02:29:30 INFO - PROCESS | 23860 | _x_x_mozilla_page_load_details 02:29:30 INFO - PROCESS | 23860 | |i|pagename|runs| 02:29:30 INFO - PROCESS | 23860 | |0;dojo.html;2653.3366658335417;2657.46850629874;2695.393536454297;2697.946041079177;2709.3768433260348;4561.771911404433;4634.490206077328;4687.36720542727;4739.857804265869;4806.351142595753;4685.3206285088645;4718.032803275329;4726.456457507387;4737.076270127318;4742.217534106868;4127.587241275864;4293.65650747941;4378.781060946956;4408.933865992013;4483.30508771141;4386.605205531501;4419.138268037734;4428.955710442902;4434.68957172998;4464.866054018385;4202.8318867245425;4242.300020496646;4247;4321.65426765858;4419.823207071746;4333.848315308981;4340.60934515895;4340.978295108504;4385.254506733831;4438.245498265303;4355.303151495746;4371.562843715603;4374.234508960919;4410.426644536222;4418.116376724636;4526.637868970474;4632.814687412533;4715.481297057321;4718.197906355927;4732.763361831895;5016.44819069902;5064.063148317573;5078.365204349457;5079.23811428285;5080.339555857752;5055.848324550233;5082.567981721558;5119.667221630582;5121.7439128043825;5129.974350128263;4529.6376289896725;4582.816687332469;4600.171969045537;4627.282771170474;4659.8136074557315;5155.9430316784965;5159.58723302135;5159.793608255703;5161.948380516222;5180.119379705459;4669.836555720533;4922.114019476457;4922.458529561745;4925;4950.702957822542;4994.175960966472;5050.520200580939;5061.215511595708;5069.112905241568;5074.13739664258;4982.153033984159;4982.526659967298;4984.2025275955675;5021.548060674557;5037.496250375007;4810.494898035656;4902.754862256873;4995.150824359867;5005.124103281911;5008.348914641073;4288.270993931039;4291.420658211164;4296.2696341621995;4318.028443600228;4340.240457919915;3729.272791805572;3746.812659367021;3752.137008488063;3785.1294202333615;3795.449659799369;4171.853985110507;4209.873703788891;4303.82784688609;4309.375140604595;4310.439642846472;5097.8725531861255;5121.8463446096675;5136;5136.5890728741615;5179.689218646893;4343.9348409773875;4376.584224498668;4379.737215767064;4420.248557745191;4427.490838553607;4417.271150260235;4553.817847286137;4592.678512504092;4622.907541849211;4632.768361581908;4829.637777166657;4848.272759086165;4848.5636292733825;4884.65807393479;4885.755712214375;5090.363704536933;5097.7960881565805;5098.821541246039;5099.745012749422;5101.158308878993;4662.347271382077;4670.252759558454;4674.953250467452;4699.107169637758;4889.584385327287;4856.980034192859;4877.6585639004925;4882.4629290777275;4924.901501969869;4933.112039832721;4907.950920490749;4944.975275123601;4952.2819191217795;4953.925691114564;4955.677880937727;4795.328653988375;4859.416869975626;4896.069746748107;4966.205407134841;4985.775640096132;4903.26451032348;4916.7541622918;4920.237363208708;4922.384701912261;4972.825951091694;4841.540053694894;4850.102730994778;4853.684510506806;4862.854114376574;4920.630952678492;4776.164171270083;4873.220284754422;4925.113479573711;4927.581155601671;4941.061198372297;4810.615150787999;4814.398200224972;4825.951740482691;4831.541003604652;4881.658283920234 02:29:30 INFO - PROCESS | 23860 | |1;ext.html;565.0084102400286;566.3373852592466;571.8827640333732;572.1646396261458;576.7491141353509;27086.593701094498;39882;41837.7908110459;41844.58155418445;45100;42507.57492425075;42647.78676106615;42737;42758.14483710332;42885.35671964915;7510.436717246201;7816.413768967336;7947.046354437475;7956;7961.1242763295995;7508.737194198204;7750.302472777449;7754.418418618598;9983.600655973753;10256.282060255786;10389.1688664907;10429.217808664343;10430;10430.739231519197;10446.059854613084;10264.53809578567;10340.172786177087;10341.586336546605;10345.482725863752;10350.275480716391;7572.39420846331;7804.985351904273;7806.1413244543055;9883.752906177331;10283.640072597498;40048.59951400507;40556.59443405587;40638.79680601578;40648.187036259405;40657.186856263004;3036.5596988436555;3075.400296942075;3156.6369867465305;3238.2598099195466;3441.120097468686;30167.245818854484;30225.395492090254;30225.546616800766;30684.693153068405;30771.07686769378;3520.4543295789194;3547.379208638478;3585.8744943926836;3614.168741189515;3689.520362352877;191309;192101;192295;192417;192456.9999999986;56764.148537771965;57436.712816436484;57438.7128064357;57523;57532.71233643889;57361.71319143461;57708.422915771145;57760.133597996064;57779.711101445064;57964.420355795904;12622.55821046259;12632.431540580696;12647.557335493397;12655.303958282382;12722.173058751152;10864.34813911152;10864.456777161111;10870.130389568816;10876.075533579577;10955.945220274007;16910.577235568962;17484;17500.737488937677;18150.636987260183;18154.18306176199;5911.408859114054;5946.96704680616;6013.819585412444;6141.815745527641;6185.41238582334;792.5759718550548;852.1861622150831;955.6129767444196;956.9186619137312;966.1980556138388;25800.354991124997;25818.741812582008;26440.73559264421;26896.731032689815;27041.1887643371;941.7410212191702;964.9517524123765;996.5764550066193;1001.2940876681922;1022.2946167144646;13959.581212563638;14428.783568246485;14481.565553033426;14712.485063022743;14737.852621473648;373765;375222;377586;377909;379252;50487;50613.74693126511;50692.49307506878;50759.49240507621;50857.23714144291;953.8538288850087;1102.5755084292446;1155.156735583046;1164.5923926625612;1165.6561314412268;27078.323041923322;29450.558241625964;29828.552571711876;30876.691233087382;30994;43198.568014319455;43858.78070609754;43859.99999999873;43865;43891;310867;312033;313423;313684;314066;36787.264254715294;38491.23017539577;38560;38627.80686096552;38673.41989870098;43022.35466468068;43764;43986.78006609946;44026.11947761091;44756.32865506955;37213.62786372102;37441.25117497689;37451.31469083843;37534.249315014094;37940.62059379481;36613.119476855456;37728.62271377251;37749.4337584931;37845;38125.4281185788;35519.82240088783;36587.63412365949;36830.8158459206;37672.43491347687;37850.24299514049;32494.83752581222;34545.48181777326;34715.65284347225;34820.30359392849;34825.82587087048;24663.38341541404;25103.497930041663;25222.873885630455;25356.619650705623;25669.743302567484 02:29:30 INFO - PROCESS | 23860 | |2;jquery.html;342.66761241595674;371.3519907760957;380.11433360270587;381.883525524715;386.84526189524206;13167.144135631177;16632.085235312054;17097.401590944304;18845.905770471127;18870.716939245922;17371.305147794104;18070;18086.728699069525;18093.27626894926;18097.366592169277;4889.413270407556;5337.866553336159;5342.385625653042;5347.1177255752755;5361.303030606015;3753.3244016077097;5190.688558686472;5832.883342333151;6109.175261339729;6150.630962142263;6162.5069994400565;6194.411530904579;6212.44088032077;6213.099100630406;6214.254289485268;6049.758009679607;6209.223847019122;6210.068489726532;6217.502599792006;6218.378162183791;4816.277558366238;5097.668651537638;5443.863903402407;5447.1829225616075;5450;20696.275630352866;21146.78853211479;21208.575828483343;21303.5739285215;21563.892180539155;1819.1540933466001;1860.1071485686946;1963.0283009910186;2172.9891350543303;2236.686863839064;9491.810163796754;9617.23062155026;9758;12273.833772169542;12710.809337859939;1677.1446562253216;1754.9473515794546;1798.5593529585205;1807.4939017075108;1827.6984297591014;66845.33154668439;67650;69773.30226697719;69826.99999999949;71032.83122440934;8924.910750892537;9663;10174.389536627827;10208.948955255177;10246.180305575535;12728.554500592434;13590.864091359157;13599.728005439836;14088.506902258372;14121;6060.363661815446;7337.669804858794;7347.65776614486;7385.29839665231;7445.702171913171;6876.759313424006;6902.102726645504;6993.300669932966;7027.543209691354;7029.753958611424;4045.5954404559307;4073.837046518165;4093.406456063854;4301.677374196947;4543.136804007228;1843.3456123076114;1856.647237024961;1872.925082996692;1888.5656299051295;1951.2097600471832;778.8325510015374;855.6577369052429;869.3740506835069;906.8322360363354;923.8244733500613;16304.673906521803;16961.49115526536;17104.401345952832;17255.3960611378;17546.912265438845;865.312076898867;872.965081396737;883.2271762208068;923.8706581078654;930.9441433514011;9147.679831205876;9772.21822254218;9837.55730992107;9859.211263099078;10013.249006324555;366811;370078;375860;385495;386021;40628.18743625111;41007.1798564033;68214.65892670605;76493.6175319131;76665;882.8410886040574;885.1518000876255;896.4442045931434;899.7795540092719;906.0124464333908;15455.227238637799;15587.454439094578;15702.685946281239;15726.528204153894;16042.197890105681;37694.30375633048;37720.24559508849;38112.61887381202;38525.4221186688;39481.40777888391;49327.26009109938;49746.75126624344;51311.230331545805;51490;51877;7292.781216563511;7355.338019578264;7381.667824947997;7513.098428188652;7662.578558179353;11098.5560577576;11109.333439993627;11500.597479088192;11528.827067593826;11657.766844663229;9833.508324583885;9968.50157492137;10145.847812282675;10166.440845753554;10257.538410771383;9632.518374081408;9759.853602196115;9821.656242031495;9839.901600983898;9882.407055576401;8947.373683842068;9622;9845.360051596623;10083.949580252052;10180.236482263712;6450.41946224842;6574.342565743579;6761.256261811295;6997.510174287954;7264.309890560388;9075.591598377956;9664.130228279208;9933.751656208653;10016.449095299828;10263.178945684476 02:29:30 INFO - PROCESS | 23860 | |3;mootools.html;1197.2457351868322;1357.3484727330883;1385.8129152564402;1466.8899832512557;1679.22755532455;6083.604565703232;6915.066466027085;7141.821454463641;7146.035285236491;7154.678039488229;6944.7569335073285;7085.7165713371405;7145.035420218269;7353.852922941538;7354.227806080365;1853.2772218834666;1908.065048126415;1910.6560819052634;2139.935801925945;2183.1049269799387;1930.1121484117323;2152.838537109715;2222.866628002325;2232.520008198237;2257.762934891837;2145.5172586168064;2190.080166330137;2193.056985496236;2196.417949243452;2197.8131858791944;1834.7247912813052;2144.635411979967;2148.3232781673723;2153.720016397874;2159.6004739123314;2107.873527588334;2177.368563116694;2177.4665207024223;2193.649016157423;2194.8902554872193;7195.8201044973775;7234.529755565872;7239.89140162898;7241.674124664402;7241.986121942932;4335.913281734348;4430.357598148283;4431.446069241345;4435.135148646015;4442.733435993819;2781.3741908070724;2868.182567968119;2888;2889.9596145387854;2911.621489206411;825.5088222507599;850.2517784349794;854.4958474500074;875.9474431534128;878.569500944539;9823.852642210373;10052.547635356426;10061.346012509164;10076;10084.999999999927;4033.4151548025957;4131.132462182975;4242.087951090469;4262.211490874198;4265.765382903908;8695.521746304014;8707.085755995657;8715.259202967818;8723.040465548784;8728.127187281221;4416.646668266531;4431.889202769892;4432.357308190359;4435.711678740871;4436.5785250401805;3561.6972557332397;3680.723945704083;3988.8404463821703;3988.880333589997;3990.9201815964097;3542.6634469725336;3624.130208749934;3637.872674456434;3647.908802279911;3656.6526180012856;1153.330040955186;1189.3458597771191;1190.4047976011993;1203.7231436769416;1205.9939700301443;780.4809801482064;794.5868148562715;797.5653268968426;807.1726480357563;812.1350761439048;4761.976190119027;4785.090832741768;4874.707517548958;4909.558139767438;4999.125153098194;394.53839008359716;400;401.5261990850766;404.85829959513933;418.080223508283;3349.916252093717;3480.321337339245;3506.1059429845736;3509.6314886937016;3552.3605750965075;8739.781505462288;8976.955115224382;8986.955065224633;9070.501122438198;9070.727878163665;8920.330975176888;8950.104989501127;8953.059928707522;8959.5968181432;8977.955110224408;6609.603423794491;6885;6948.374646281859;6953.165620125617;6966.79099627012;5249.055170069424;5295;5319.361676598833;5427.674339539641;5479.561635069105;8214.219649133323;8259.95870020646;8497.235248827636;8542;8599.14008599135;8347.207015333533;8656.177663121993;8681.175288347597;8689.435186712843;8697.130286971253;5770.336411312753;5986.850328741816;5989.3711160329285;6122.908156377747;6160.045192995093;6938.861222775416;7137.10786151731;7148.785536433916;7149.892751608626;7157.141143062658;6434.388733070351;6562.146920900253;6596.637184954873;6625.867482650224;6747.2915343890145;6460.515461340325;6493.740250389931;6522.804315870531;6556.475481961336;6570.8028759137305;5818.73815678304;5841.707914604338;5877.500412464818;5900.763969441346;5902.380250073852;4393.275109606879;4440.578145076212;4491.797869095833;4516.9322460163785;4575.542445755531;4393.780310984374;4401.097774956191;4418.381426600343;4427.180971520279;4520.141173177086 02:29:30 INFO - PROCESS | 23860 | |4;prototype.html;289.89418862115326;297.1560767420525;298.4165955556887;303.8025283565682;303.8070825026108;4756.619470442365;4772.522747725226;4778.4743678195455;4780;4790.137775200463;4695.530446955303;4718.669693121483;4721.315409265654;4721.598664113546;4747.5489828466325;3571.2500374921296;3640.5995340512522;3677.6322367763278;3740.4202348635868;3780.659740623343;3723.8510459581585;3732.4028155495125;3758.0604848787802;3772.3586990211593;3777.527809023872;3578.1591326038492;3714.9257014859686;3725.8695945641907;3737.121776382548;3740.588535261119;3598.3702852000924;3713.57293911201;3743.644353786386;3746.5316835395574;3755.8122093895468;3325.5011748237716;3327.8502467388785;3333.6830902522756;3348.363810875926;3355.9328813423595;4594.310853371988;4597.264437689987;4602.240630295997;4613.469451013109;4623.352730617717;4067.8169482373364;4259.190753756776;4260.616544511009;4275.3800698898485;4301.505326887417;4923.261510773377;4929.75351232437;4931.80272789088;4954.2568614707725;4961.603071754251;3660.3045421369857;3663.285659296438;3664.230511592542;3668.6881615062753;3668.853245870162;4970.925436118461;5158.92261616076;5183.585313174937;5187.299714538527;5202.401723801773;3770.7360484765804;3779.4330850372116;3786.3373909565717;3787.2046870157574;3795.6204379562373;3837.4819399380726;3838.673712734393;3841.4237864320576;3841.635044670752;3847.826847791856;4303.74177549348;4306.763128027988;4309.569043095728;4310.827566897352;4316.374125751749;4787.54518320759;4975.427825800007;4977.228529577921;4981.950180498221;4995.875103122451;1320.8150858879765;1328.136711137768;1329.2755448280516;1336.4520546576052;1340.095435580979;864.7449002544139;873.7116751471999;910.6175406329357;929.5631053404888;934.4346670264528;4323.956760432418;4341.696081274281;4343.391925130484;4350.151720414488;4367.825286988548;5014.674046186986;5015.548600625962;5035.924461133012;5043.470435604282;5057.583876514582;4245.32309737658;4362.258416069276;4366.366876802909;4375.059362237134;4380.299152135643;2670.479256544994;2682.4903268378944;2695.355832941904;2704.6619172603423;2713.213168181245;4796.832110876103;4803.3995750531185;4803.567678908915;4827.155247831615;4843.733594652328;4990.226514890198;5050.318207042076;5130.97434512825;5134.691918484828;5144.15121504955;4791.832285869978;4798.808047678123;4808.543188397167;4819.132556139788;4823.638227132979;5015.949840501548;5024.84925452237;5027.371578552681;5039.47085556026;5039.697618142924;4789.712617242976;4916.360873086476;4921.4832442593015;4952.851414457572;4953.826616068564;4806.639502037291;4807.134715751058;4808.7595620219545;4815.494373090775;4821.481233411464;3700.740948133605;3703.3148867459604;3704.666580007812;3707.3512135375663;3714.2571485703506;4764.237721964469;4984.2025275955675;5008.348914641073;5024.849254522224;5033.84898453047;4853.961336238717;4854.00492898962;4855.295982082649;4856.5871900887405;4868.853934381974;4845.6123510118405;4869.440014398389;4880.170371036861;4882.170031094652;4888.266759986031;4665.160271151225;4812.133815913029;4819.493773321955;4820.39745031871;4823.324734537237;4772.904541909073;4894.437139728834;4904.926426103682;4922.72924989129;4942.308076869169;4823.589994850477;4830.275458681226;4893.290472881484;4898.828541001048;4912.189488734319 02:29:30 INFO - PROCESS | 23860 | |5;yui.html;650.365893254077;657.1489920552883;674.4772801079164;735.3786050787083;776.5107981971357;11103.111751059916;11822.527098916033;11829.645110646694;14256.572302830906;15037;14948.925255373735;14999.925000374982;15052.774208386856;15080;15115;621.3879328861068;765.227120608187;772.9072511298652;798.2815466080516;801.6753214947955;787.4015748031509;803.3733687723585;803.9959800200991;804.1596531624466;805.6817557064956;833.2167762303445;836.4145098431092;837.3636036612188;838.3125836813815;838.681301105579;645.9709313080923;792.9167437419046;809.5790189101634;830.5390508267909;831.098258389648;604.3442864492032;609.1198218574162;609.5732986909137;609.7896225802091;610.0270069239556;13426.798598021038;13437.39531721065;13440.596782096552;13459.86540134596;13465.798013029813;11355.943220283845;11876.287422754662;12003.3398163101;12005.93997030018;12428;12025.879741202563;12026.420551968913;12072.21530600517;12092.637220883387;12146.392680365947;4161.97919010403;4167.97916010418;4229.238737027334;4268.253055715269;4358.782060896974;60748;61112.388876111116;61303.693481532304;62381.064284035776;62891.68554157246;10049.24630652704;10104.797904042025;10131.240156988255;10204.948975255225;10437.739056523647;15091.320890559951;15467.07197568127;17825.46523604294;17852.19665115073;17855.642887142185;6354.110424540568;6354.714037868307;6372.490200783926;6431.1317972073175;6459.450946669492;3629.8366573504254;3652.5251717276583;3671.2657468506404;3757.605451427615;3801.657850793442;2666.3867310518303;2818.4644917466026;2826.307554649083;2827.812318826098;2827.9010234641687;471.21777848770876;473.143610065782;480.327541441984;484.4307938172633;494.02430200354013;521.9947800521946;526.5839986410692;538.3593523706776;555.0619453124207;564.7063526965954;7562.2437756223935;7606;7898.131205567383;7970.721024764105;8158.592070396457;463.0807846424844;478.24914883633056;509.27936969188926;544.4283502322545;556.2962851992233;3784.735068545175;3858.305505009125;3891.3579259422445;3955.327594308917;3993.980030099889;89695;92671;95440;96374.51812741032;97354;81204.59397703092;81555.59222203969;81864;82069.9999999988;82306.58846705729;46750.29874551884;47629.5237047632;68574.3142568588;72758;73326.99999999894;8282.50304981703;8907.955460222658;9096.454212747256;9302.116298951589;9305;43351;43625.78187109044;44479.33281000852;45542;45797.54202457933;57523;61226.69386653038;61292;62406;62636.686816567446;11668.533258669559;12016.399180040788;12341;12519.436625351698;12923.15999460032;12470.563530276397;12721.785758822796;12796.232226066466;12901.677458063623;14051.859481405463;10302.587896484056;11698.824517632072;12314.384280786104;12471.625851224479;12481.06392020584;12566.560170393992;12569.497220111092;12593.622191333909;12989.675258118623;13474.393652285475;12387.938060309642;12649;12691.428885699981;12958.80561791555;13123.737525249251;10113.64602238918;10334.173266138841;10591.5233814477;10668.306560073881;10682.57269709203;9770.902290977283;9912.752181195528;10547.789044219226;10759.515821787882;11078.058365039062 02:29:30 INFO - PROCESS | 23860 | __end_tp_report 02:29:30 INFO - PROCESS | 23860 | __start_cc_report 02:29:30 INFO - PROCESS | 23860 | _x_x_mozilla_cycle_collect,1084 02:29:30 INFO - PROCESS | 23860 | __end_cc_report 02:29:30 INFO - PROCESS | 23860 | __startTimestamp1468402170249__endTimestamp 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | ------- Summary: start ------- 02:29:30 INFO - PROCESS | 23860 | Number of tests: 6 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#0] dojo.html Cycles:165 Average:4657.91 Median:4810.49 stddev:478.09 (9.9%) stddev-sans-first:452.96 02:29:30 INFO - PROCESS | 23860 | Values: 2653.3 2657.5 2695.4 2697.9 2709.4 4561.8 4634.5 4687.4 4739.9 4806.4 4685.3 4718.0 4726.5 4737.1 4742.2 4127.6 4293.7 4378.8 4408.9 4483.3 4386.6 4419.1 4429.0 4434.7 4464.9 4202.8 4242.3 4247.0 4321.7 4419.8 4333.8 4340.6 4341.0 4385.3 4438.2 4355.3 4371.6 4374.2 4410.4 4418.1 4526.6 4632.8 4715.5 4718.2 4732.8 5016.4 5064.1 5078.4 5079.2 5080.3 5055.8 5082.6 5119.7 5121.7 5130.0 4529.6 4582.8 4600.2 4627.3 4659.8 5155.9 5159.6 5159.8 5161.9 5180.1 4669.8 4922.1 4922.5 4925.0 4950.7 4994.2 5050.5 5061.2 5069.1 5074.1 4982.2 4982.5 4984.2 5021.5 5037.5 4810.5 4902.8 4995.2 5005.1 5008.3 4288.3 4291.4 4296.3 4318.0 4340.2 3729.3 3746.8 3752.1 3785.1 3795.4 4171.9 4209.9 4303.8 4309.4 4310.4 5097.9 5121.8 5136.0 5136.6 5179.7 4343.9 4376.6 4379.7 4420.2 4427.5 4417.3 4553.8 4592.7 4622.9 4632.8 4829.6 4848.3 4848.6 4884.7 4885.8 5090.4 5097.8 5098.8 5099.7 5101.2 4662.3 4670.3 4675.0 4699.1 4889.6 4857.0 4877.7 4882.5 4924.9 4933.1 4908.0 4945.0 4952.3 4953.9 4955.7 4795.3 4859.4 4896.1 4966.2 4985.8 4903.3 4916.8 4920.2 4922.4 4972.8 4841.5 4850.1 4853.7 4862.9 4920.6 4776.2 4873.2 4925.1 4927.6 4941.1 4810.6 4814.4 4826.0 4831.5 4881.7 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#1] ext.html Cycles:180 Average:46432.42 Median:205603.13 stddev:79875.70 (38.8%) stddev-sans-first:80025.53 02:29:30 INFO - PROCESS | 23860 | Values: 565.0 566.3 571.9 572.2 576.7 27086.6 39882.0 41837.8 41844.6 45100.0 42507.6 42647.8 42737.0 42758.1 42885.4 7510.4 7816.4 7947.0 7956.0 7961.1 7508.7 7750.3 7754.4 9983.6 10256.3 10389.2 10429.2 10430.0 10430.7 10446.1 10264.5 10340.2 10341.6 10345.5 10350.3 7572.4 7805.0 7806.1 9883.8 10283.6 40048.6 40556.6 40638.8 40648.2 40657.2 3036.6 3075.4 3156.6 3238.3 3441.1 30167.2 30225.4 30225.5 30684.7 30771.1 3520.5 3547.4 3585.9 3614.2 3689.5 191309.0 192101.0 192295.0 192417.0 192457.0 56764.1 57436.7 57438.7 57523.0 57532.7 57361.7 57708.4 57760.1 57779.7 57964.4 12622.6 12632.4 12647.6 12655.3 12722.2 10864.3 10864.5 10870.1 10876.1 10955.9 16910.6 17484.0 17500.7 18150.6 18154.2 5911.4 5947.0 6013.8 6141.8 6185.4 792.6 852.2 955.6 956.9 966.2 25800.4 25818.7 26440.7 26896.7 27041.2 941.7 965.0 996.6 1001.3 1022.3 13959.6 14428.8 14481.6 14712.5 14737.9 373765.0 375222.0 377586.0 377909.0 379252.0 50487.0 50613.7 50692.5 50759.5 50857.2 953.9 1102.6 1155.2 1164.6 1165.7 27078.3 29450.6 29828.6 30876.7 30994.0 43198.6 43858.8 43860.0 43865.0 43891.0 310867.0 312033.0 313423.0 313684.0 314066.0 36787.3 38491.2 38560.0 38627.8 38673.4 43022.4 43764.0 43986.8 44026.1 44756.3 37213.6 37441.3 37451.3 37534.2 37940.6 36613.1 37728.6 37749.4 37845.0 38125.4 35519.8 36587.6 36830.8 37672.4 37850.2 32494.8 34545.5 34715.7 34820.3 34825.8 24663.4 25103.5 25222.9 25356.6 25669.7 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#2] jquery.html Cycles:180 Average:23571.96 Median:28204.45 stddev:62050.00 (220.0%) stddev-sans-first:62199.56 02:29:30 INFO - PROCESS | 23860 | Values: 342.7 371.4 380.1 381.9 386.8 13167.1 16632.1 17097.4 18845.9 18870.7 17371.3 18070.0 18086.7 18093.3 18097.4 4889.4 5337.9 5342.4 5347.1 5361.3 3753.3 5190.7 5832.9 6109.2 6150.6 6162.5 6194.4 6212.4 6213.1 6214.3 6049.8 6209.2 6210.1 6217.5 6218.4 4816.3 5097.7 5443.9 5447.2 5450.0 20696.3 21146.8 21208.6 21303.6 21563.9 1819.2 1860.1 1963.0 2173.0 2236.7 9491.8 9617.2 9758.0 12273.8 12710.8 1677.1 1754.9 1798.6 1807.5 1827.7 66845.3 67650.0 69773.3 69827.0 71032.8 8924.9 9663.0 10174.4 10208.9 10246.2 12728.6 13590.9 13599.7 14088.5 14121.0 6060.4 7337.7 7347.7 7385.3 7445.7 6876.8 6902.1 6993.3 7027.5 7029.8 4045.6 4073.8 4093.4 4301.7 4543.1 1843.3 1856.6 1872.9 1888.6 1951.2 778.8 855.7 869.4 906.8 923.8 16304.7 16961.5 17104.4 17255.4 17546.9 865.3 873.0 883.2 923.9 930.9 9147.7 9772.2 9837.6 9859.2 10013.2 366811.0 370078.0 375860.0 385495.0 386021.0 40628.2 41007.2 68214.7 76493.6 76665.0 882.8 885.2 896.4 899.8 906.0 15455.2 15587.5 15702.7 15726.5 16042.2 37694.3 37720.2 38112.6 38525.4 39481.4 49327.3 49746.8 51311.2 51490.0 51877.0 7292.8 7355.3 7381.7 7513.1 7662.6 11098.6 11109.3 11500.6 11528.8 11657.8 9833.5 9968.5 10145.8 10166.4 10257.5 9632.5 9759.9 9821.7 9839.9 9882.4 8947.4 9622.0 9845.4 10083.9 10180.2 6450.4 6574.3 6761.3 6997.5 7264.3 9075.6 9664.1 9933.8 10016.4 10263.2 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#3] mootools.html Cycles:180 Average:4866.69 Median:4829.90 stddev:2693.67 (55.8%) stddev-sans-first:2687.11 02:29:30 INFO - PROCESS | 23860 | Values: 1197.2 1357.3 1385.8 1466.9 1679.2 6083.6 6915.1 7141.8 7146.0 7154.7 6944.8 7085.7 7145.0 7353.9 7354.2 1853.3 1908.1 1910.7 2139.9 2183.1 1930.1 2152.8 2222.9 2232.5 2257.8 2145.5 2190.1 2193.1 2196.4 2197.8 1834.7 2144.6 2148.3 2153.7 2159.6 2107.9 2177.4 2177.5 2193.6 2194.9 7195.8 7234.5 7239.9 7241.7 7242.0 4335.9 4430.4 4431.4 4435.1 4442.7 2781.4 2868.2 2888.0 2890.0 2911.6 825.5 850.3 854.5 875.9 878.6 9823.9 10052.5 10061.3 10076.0 10085.0 4033.4 4131.1 4242.1 4262.2 4265.8 8695.5 8707.1 8715.3 8723.0 8728.1 4416.6 4431.9 4432.4 4435.7 4436.6 3561.7 3680.7 3988.8 3988.9 3990.9 3542.7 3624.1 3637.9 3647.9 3656.7 1153.3 1189.3 1190.4 1203.7 1206.0 780.5 794.6 797.6 807.2 812.1 4762.0 4785.1 4874.7 4909.6 4999.1 394.5 400.0 401.5 404.9 418.1 3349.9 3480.3 3506.1 3509.6 3552.4 8739.8 8977.0 8987.0 9070.5 9070.7 8920.3 8950.1 8953.1 8959.6 8978.0 6609.6 6885.0 6948.4 6953.2 6966.8 5249.1 5295.0 5319.4 5427.7 5479.6 8214.2 8260.0 8497.2 8542.0 8599.1 8347.2 8656.2 8681.2 8689.4 8697.1 5770.3 5986.9 5989.4 6122.9 6160.0 6938.9 7137.1 7148.8 7149.9 7157.1 6434.4 6562.1 6596.6 6625.9 6747.3 6460.5 6493.7 6522.8 6556.5 6570.8 5818.7 5841.7 5877.5 5900.8 5902.4 4393.3 4440.6 4491.8 4516.9 4575.5 4393.8 4401.1 4418.4 4427.2 4520.1 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#4] prototype.html Cycles:180 Average:4125.08 Median:4752.08 stddev:1161.95 (24.5%) stddev-sans-first:1128.99 02:29:30 INFO - PROCESS | 23860 | Values: 289.9 297.2 298.4 303.8 303.8 4756.6 4772.5 4778.5 4780.0 4790.1 4695.5 4718.7 4721.3 4721.6 4747.5 3571.3 3640.6 3677.6 3740.4 3780.7 3723.9 3732.4 3758.1 3772.4 3777.5 3578.2 3714.9 3725.9 3737.1 3740.6 3598.4 3713.6 3743.6 3746.5 3755.8 3325.5 3327.9 3333.7 3348.4 3355.9 4594.3 4597.3 4602.2 4613.5 4623.4 4067.8 4259.2 4260.6 4275.4 4301.5 4923.3 4929.8 4931.8 4954.3 4961.6 3660.3 3663.3 3664.2 3668.7 3668.9 4970.9 5158.9 5183.6 5187.3 5202.4 3770.7 3779.4 3786.3 3787.2 3795.6 3837.5 3838.7 3841.4 3841.6 3847.8 4303.7 4306.8 4309.6 4310.8 4316.4 4787.5 4975.4 4977.2 4982.0 4995.9 1320.8 1328.1 1329.3 1336.5 1340.1 864.7 873.7 910.6 929.6 934.4 4324.0 4341.7 4343.4 4350.2 4367.8 5014.7 5015.5 5035.9 5043.5 5057.6 4245.3 4362.3 4366.4 4375.1 4380.3 2670.5 2682.5 2695.4 2704.7 2713.2 4796.8 4803.4 4803.6 4827.2 4843.7 4990.2 5050.3 5131.0 5134.7 5144.2 4791.8 4798.8 4808.5 4819.1 4823.6 5015.9 5024.8 5027.4 5039.5 5039.7 4789.7 4916.4 4921.5 4952.9 4953.8 4806.6 4807.1 4808.8 4815.5 4821.5 3700.7 3703.3 3704.7 3707.4 3714.3 4764.2 4984.2 5008.3 5024.8 5033.8 4854.0 4854.0 4855.3 4856.6 4868.9 4845.6 4869.4 4880.2 4882.2 4888.3 4665.2 4812.1 4819.5 4820.4 4823.3 4772.9 4894.4 4904.9 4922.7 4942.3 4823.6 4830.3 4893.3 4898.8 4912.2 02:29:30 INFO - PROCESS | 23860 | 02:29:30 INFO - PROCESS | 23860 | [#5] yui.html Cycles:180 Average:17360.17 Median:45010.67 stddev:24062.13 (53.5%) stddev-sans-first:24096.91 02:29:30 INFO - PROCESS | 23860 | Values: 650.4 657.1 674.5 735.4 776.5 11103.1 11822.5 11829.6 14256.6 15037.0 14948.9 14999.9 15052.8 15080.0 15115.0 621.4 765.2 772.9 798.3 801.7 787.4 803.4 804.0 804.2 805.7 833.2 836.4 837.4 838.3 838.7 646.0 792.9 809.6 830.5 831.1 604.3 609.1 609.6 609.8 610.0 13426.8 13437.4 13440.6 13459.9 13465.8 11355.9 11876.3 12003.3 12005.9 12428.0 12025.9 12026.4 12072.2 12092.6 12146.4 4162.0 4168.0 4229.2 4268.3 4358.8 60748.0 61112.4 61303.7 62381.1 62891.7 10049.2 10104.8 10131.2 10204.9 10437.7 15091.3 15467.1 17825.5 17852.2 17855.6 6354.1 6354.7 6372.5 6431.1 6459.5 3629.8 3652.5 3671.3 3757.6 3801.7 2666.4 2818.5 2826.3 2827.8 2827.9 471.2 473.1 480.3 484.4 494.0 522.0 526.6 538.4 555.1 564.7 7562.2 7606.0 7898.1 7970.7 8158.6 463.1 478.2 509.3 544.4 556.3 3784.7 3858.3 3891.4 3955.3 3994.0 89695.0 92671.0 95440.0 96374.5 97354.0 81204.6 81555.6 81864.0 82070.0 82306.6 46750.3 47629.5 68574.3 72758.0 73327.0 8282.5 8908.0 9096.5 9302.1 9305.0 43351.0 43625.8 44479.3 45542.0 45797.5 57523.0 61226.7 61292.0 62406.0 62636.7 11668.5 12016.4 12341.0 12519.4 12923.2 12470.6 12721.8 12796.2 12901.7 14051.9 10302.6 11698.8 12314.4 12471.6 12481.1 12566.6 12569.5 12593.6 12989.7 13474.4 12387.9 12649.0 12691.4 12958.8 13123.7 10113.6 10334.2 10591.5 10668.3 10682.6 9770.9 9912.8 10547.8 10759.5 11078.1 02:29:30 INFO - PROCESS | 23860 | -------- Summary: end -------- 02:29:30 INFO - PROCESS | 23860 | 02:29:31 INFO - TEST-INFO | 23860: exit 0 02:29:31 INFO - TEST-OK | dromaeo_css | took 1121854ms 02:29:31 INFO - TEST-START | kraken 02:29:31 INFO - operating with platform_type : linux_ 02:29:31 INFO - Initialising browser for kraken test... 02:29:31 INFO - TEST-INFO | started process 24056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R6ghM/profile http://localhost:38290/getInfo.html) 02:29:36 INFO - PROCESS | 24056 | __metrics Screen width/height:1600/1200 02:29:36 INFO - PROCESS | 24056 | colorDepth:24 02:29:36 INFO - PROCESS | 24056 | Browser inner width/height: 1024/697 02:29:36 INFO - PROCESS | 24056 | __metrics 02:29:37 INFO - PROCESS | 24056 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:29:37 INFO - PROCESS | 24056 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:29:38 INFO - TEST-INFO | 24056: exit 0 02:29:38 INFO - Browser initialized. 02:29:38 INFO - Running cycle 1/1 for kraken test... 02:29:38 INFO - TEST-INFO | started process 24140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3R6ghM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:29:50 INFO - PROCESS | 24140 | RSS: Main: 159404032 02:29:50 INFO - PROCESS | 24140 | 02:29:53 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38290/tests/kraken/driver.html?testName=audio-beat-detection) 02:29:53 INFO - PROCESS | 24140 | RSS: Main: 216858624 02:29:53 INFO - PROCESS | 24140 | 02:29:56 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38290/tests/kraken/driver.html?testName=audio-dft) 02:29:57 INFO - PROCESS | 24140 | RSS: Main: 203726848 02:29:57 INFO - PROCESS | 24140 | 02:30:00 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38290/tests/kraken/driver.html?testName=audio-fft) 02:30:01 INFO - PROCESS | 24140 | RSS: Main: 271478784 02:30:01 INFO - PROCESS | 24140 | 02:30:03 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38290/tests/kraken/driver.html?testName=audio-oscillator) 02:30:03 INFO - PROCESS | 24140 | RSS: Main: 181739520 02:30:03 INFO - PROCESS | 24140 | 02:30:06 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38290/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:30:06 INFO - PROCESS | 24140 | RSS: Main: 185352192 02:30:06 INFO - PROCESS | 24140 | 02:30:09 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38290/tests/kraken/driver.html?testName=imaging-darkroom) 02:30:10 INFO - PROCESS | 24140 | RSS: Main: 221810688 02:30:10 INFO - PROCESS | 24140 | 02:30:14 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38290/tests/kraken/driver.html?testName=imaging-desaturate) 02:30:14 INFO - PROCESS | 24140 | RSS: Main: 222105600 02:30:14 INFO - PROCESS | 24140 | 02:30:17 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38290/tests/kraken/driver.html?testName=json-parse-financial) 02:30:18 INFO - PROCESS | 24140 | RSS: Main: 223006720 02:30:18 INFO - PROCESS | 24140 | 02:30:19 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38290/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:30:20 INFO - PROCESS | 24140 | RSS: Main: 208728064 02:30:20 INFO - PROCESS | 24140 | 02:30:22 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:30:22 INFO - PROCESS | 24140 | RSS: Main: 213250048 02:30:22 INFO - PROCESS | 24140 | 02:30:25 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:30:25 INFO - PROCESS | 24140 | RSS: Main: 211210240 02:30:25 INFO - PROCESS | 24140 | 02:30:28 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:30:29 INFO - PROCESS | 24140 | RSS: Main: 225062912 02:30:29 INFO - PROCESS | 24140 | 02:30:31 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:30:32 INFO - PROCESS | 24140 | RSS: Main: 226979840 02:30:32 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | Cycle 1(1): loaded http://localhost:38290/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38290/tests/kraken/driver.html?testName=ai-astar) 02:30:34 INFO - PROCESS | 24140 | RSS: Main: 268832768 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | __start_tp_report 02:30:34 INFO - PROCESS | 24140 | _x_x_mozilla_page_load 02:30:34 INFO - PROCESS | 24140 | _x_x_mozilla_page_load_details 02:30:34 INFO - PROCESS | 24140 | |i|pagename|runs| 02:30:34 INFO - PROCESS | 24140 | |0;ai-astar;104;114;114;112;113;116;116;114;113;114 02:30:34 INFO - PROCESS | 24140 | |1;audio-beat-detection;150;123;125;178;135;125;148;126;166;122 02:30:34 INFO - PROCESS | 24140 | |2;audio-dft;162;162;167;160;163;168;162;163;160;161 02:30:34 INFO - PROCESS | 24140 | |3;audio-fft;78;76;75;122;77;79;74;75;112;76 02:30:34 INFO - PROCESS | 24140 | |4;audio-oscillator;84;86;110;85;85;86;119;85;85;128 02:30:34 INFO - PROCESS | 24140 | |5;imaging-gaussian-blur;117;117;116;117;116;117;117;117;117;117 02:30:34 INFO - PROCESS | 24140 | |6;imaging-darkroom;146;146;145;146;146;146;145;146;145;146 02:30:34 INFO - PROCESS | 24140 | |7;imaging-desaturate;95;95;95;95;95;94;95;95;95;95 02:30:34 INFO - PROCESS | 24140 | |8;json-parse-financial;63;61;63;62;61;62;62;63;62;61 02:30:34 INFO - PROCESS | 24140 | |9;json-stringify-tinderbox;63;64;64;64;65;64;64;66;63;65 02:30:34 INFO - PROCESS | 24140 | |10;stanford-crypto-aes;92;78;78;77;79;78;79;78;79;83 02:30:34 INFO - PROCESS | 24140 | |11;stanford-crypto-ccm;129;128;127;130;129;130;127;130;205;131 02:30:34 INFO - PROCESS | 24140 | |12;stanford-crypto-pbkdf2;172;168;165;169;170;170;171;166;168;168 02:30:34 INFO - PROCESS | 24140 | |13;stanford-crypto-sha256-iterative;66;67;66;72;67;66;67;70;69;66 02:30:34 INFO - PROCESS | 24140 | __end_tp_report 02:30:34 INFO - PROCESS | 24140 | __start_cc_report 02:30:34 INFO - PROCESS | 24140 | _x_x_mozilla_cycle_collect,1918 02:30:34 INFO - PROCESS | 24140 | __end_cc_report 02:30:34 INFO - PROCESS | 24140 | __startTimestamp1468402234633__endTimestamp 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | ------- Summary: start ------- 02:30:34 INFO - PROCESS | 24140 | Number of tests: 14 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.40 (3.0%) stddev-sans-first:1.32 02:30:34 INFO - PROCESS | 24140 | Values: 104.0 114.0 114.0 112.0 113.0 116.0 116.0 114.0 113.0 114.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:141.50 stddev:19.91 (14.1%) stddev-sans-first:20.77 02:30:34 INFO - PROCESS | 24140 | Values: 150.0 123.0 125.0 178.0 135.0 125.0 148.0 126.0 166.0 122.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#2] audio-dft Cycles:10 Average:162.80 Median:162.50 stddev:2.70 (1.7%) stddev-sans-first:2.85 02:30:34 INFO - PROCESS | 24140 | Values: 162.0 162.0 167.0 160.0 163.0 168.0 162.0 163.0 160.0 161.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#3] audio-fft Cycles:10 Average:84.40 Median:76.00 stddev:17.40 (22.9%) stddev-sans-first:18.31 02:30:34 INFO - PROCESS | 24140 | Values: 78.0 76.0 75.0 122.0 77.0 79.0 74.0 75.0 112.0 76.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:85.00 stddev:16.91 (19.9%) stddev-sans-first:17.43 02:30:34 INFO - PROCESS | 24140 | Values: 84.0 86.0 110.0 85.0 85.0 86.0 119.0 85.0 85.0 128.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:30:34 INFO - PROCESS | 24140 | Values: 117.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 02:30:34 INFO - PROCESS | 24140 | Values: 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 145.0 146.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 02:30:34 INFO - PROCESS | 24140 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#8] json-parse-financial Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 02:30:34 INFO - PROCESS | 24140 | Values: 63.0 61.0 63.0 62.0 61.0 62.0 62.0 63.0 62.0 61.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.92 (1.4%) stddev-sans-first:0.87 02:30:34 INFO - PROCESS | 24140 | Values: 63.0 64.0 64.0 64.0 65.0 64.0 64.0 66.0 63.0 65.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:79.00 stddev:4.48 (5.7%) stddev-sans-first:1.72 02:30:34 INFO - PROCESS | 24140 | Values: 92.0 78.0 78.0 77.0 79.0 78.0 79.0 78.0 79.0 83.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:130.00 stddev:24.07 (18.5%) stddev-sans-first:25.37 02:30:34 INFO - PROCESS | 24140 | Values: 129.0 128.0 127.0 130.0 129.0 130.0 127.0 130.0 205.0 131.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.70 Median:169.50 stddev:2.16 (1.3%) stddev-sans-first:1.94 02:30:34 INFO - PROCESS | 24140 | Values: 172.0 168.0 165.0 169.0 170.0 170.0 171.0 166.0 168.0 168.0 02:30:34 INFO - PROCESS | 24140 | 02:30:34 INFO - PROCESS | 24140 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:2.11 02:30:34 INFO - PROCESS | 24140 | Values: 66.0 67.0 66.0 72.0 67.0 66.0 67.0 70.0 69.0 66.0 02:30:34 INFO - PROCESS | 24140 | -------- Summary: end -------- 02:30:34 INFO - PROCESS | 24140 | 02:30:35 INFO - TEST-INFO | 24140: exit 0 02:30:36 INFO - TEST-OK | kraken | took 64897ms 02:30:36 INFO - SUITE-END | took 1186s 02:30:36 INFO - Completed test suite (00:19:47) 02:30:36 INFO - javascript benchmark 02:30:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2653.3366658335417, 2657.46850629874, 2695.393536454297, 2697.946041079177, 2709.3768433260348, 4561.771911404433, 4634.490206077328, 4687.36720542727, 4739.857804265869, 4806.351142595753, 4685.3206285088645, 4718.032803275329, 4726.456457507387, 4737.076270127318, 4742.217534106868, 4127.587241275864, 4293.65650747941, 4378.781060946956, 4408.933865992013, 4483.30508771141, 4386.605205531501, 4419.138268037734, 4428.955710442902, 4434.68957172998, 4464.866054018385, 4202.8318867245425, 4242.300020496646, 4247.0, 4321.65426765858, 4419.823207071746, 4333.848315308981, 4340.60934515895, 4340.978295108504, 4385.254506733831, 4438.245498265303, 4355.303151495746, 4371.562843715603, 4374.234508960919, 4410.426644536222, 4418.116376724636, 4526.637868970474, 4632.814687412533, 4715.481297057321, 4718.197906355927, 4732.763361831895, 5016.44819069902, 5064.063148317573, 5078.365204349457, 5079.23811428285, 5080.339555857752, 5055.848324550233, 5082.567981721558, 5119.667221630582, 5121.7439128043825, 5129.974350128263, 4529.6376289896725, 4582.816687332469, 4600.171969045537, 4627.282771170474, 4659.8136074557315, 5155.9430316784965, 5159.58723302135, 5159.793608255703, 5161.948380516222, 5180.119379705459, 4669.836555720533, 4922.114019476457, 4922.458529561745, 4925.0, 4950.702957822542, 4994.175960966472, 5050.520200580939, 5061.215511595708, 5069.112905241568, 5074.13739664258, 4982.153033984159, 4982.526659967298, 4984.2025275955675, 5021.548060674557, 5037.496250375007, 4810.494898035656, 4902.754862256873, 4995.150824359867, 5005.124103281911, 5008.348914641073, 4288.270993931039, 4291.420658211164, 4296.2696341621995, 4318.028443600228, 4340.240457919915, 3729.272791805572, 3746.812659367021, 3752.137008488063, 3785.1294202333615, 3795.449659799369, 4171.853985110507, 4209.873703788891, 4303.82784688609, 4309.375140604595, 4310.439642846472, 5097.8725531861255, 5121.8463446096675, 5136.0, 5136.5890728741615, 5179.689218646893, 4343.9348409773875, 4376.584224498668, 4379.737215767064, 4420.248557745191, 4427.490838553607, 4417.271150260235, 4553.817847286137, 4592.678512504092, 4622.907541849211, 4632.768361581908, 4829.637777166657, 4848.272759086165, 4848.5636292733825, 4884.65807393479, 4885.755712214375, 5090.363704536933, 5097.7960881565805, 5098.821541246039, 5099.745012749422, 5101.158308878993, 4662.347271382077, 4670.252759558454, 4674.953250467452, 4699.107169637758, 4889.584385327287, 4856.980034192859, 4877.6585639004925, 4882.4629290777275, 4924.901501969869, 4933.112039832721, 4907.950920490749, 4944.975275123601, 4952.2819191217795, 4953.925691114564, 4955.677880937727, 4795.328653988375, 4859.416869975626, 4896.069746748107, 4966.205407134841, 4985.775640096132, 4903.26451032348, 4916.7541622918, 4920.237363208708, 4922.384701912261, 4972.825951091694, 4841.540053694894, 4850.102730994778, 4853.684510506806, 4862.854114376574, 4920.630952678492, 4776.164171270083, 4873.220284754422, 4925.113479573711, 4927.581155601671, 4941.061198372297, 4810.615150787999, 4814.398200224972, 4825.951740482691, 4831.541003604652, 4881.658283920234], "value": 4628.376566672584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.0084102400286, 566.3373852592466, 571.8827640333732, 572.1646396261458, 576.7491141353509, 27086.593701094498, 39882.0, 41837.7908110459, 41844.58155418445, 45100.0, 42507.57492425075, 42647.78676106615, 42737.0, 42758.14483710332, 42885.35671964915, 7510.436717246201, 7816.413768967336, 7947.046354437475, 7956.0, 7961.1242763295995, 7508.737194198204, 7750.302472777449, 7754.418418618598, 9983.600655973753, 10256.282060255786, 10389.1688664907, 10429.217808664343, 10430.0, 10430.739231519197, 10446.059854613084, 10264.53809578567, 10340.172786177087, 10341.586336546605, 10345.482725863752, 10350.275480716391, 7572.39420846331, 7804.985351904273, 7806.1413244543055, 9883.752906177331, 10283.640072597498, 40048.59951400507, 40556.59443405587, 40638.79680601578, 40648.187036259405, 40657.186856263004, 3036.5596988436555, 3075.400296942075, 3156.6369867465305, 3238.2598099195466, 3441.120097468686, 30167.245818854484, 30225.395492090254, 30225.546616800766, 30684.693153068405, 30771.07686769378, 3520.4543295789194, 3547.379208638478, 3585.8744943926836, 3614.168741189515, 3689.520362352877, 191309.0, 192101.0, 192295.0, 192417.0, 192456.9999999986, 56764.148537771965, 57436.712816436484, 57438.7128064357, 57523.0, 57532.71233643889, 57361.71319143461, 57708.422915771145, 57760.133597996064, 57779.711101445064, 57964.420355795904, 12622.55821046259, 12632.431540580696, 12647.557335493397, 12655.303958282382, 12722.173058751152, 10864.34813911152, 10864.456777161111, 10870.130389568816, 10876.075533579577, 10955.945220274007, 16910.577235568962, 17484.0, 17500.737488937677, 18150.636987260183, 18154.18306176199, 5911.408859114054, 5946.96704680616, 6013.819585412444, 6141.815745527641, 6185.41238582334, 792.5759718550548, 852.1861622150831, 955.6129767444196, 956.9186619137312, 966.1980556138388, 25800.354991124997, 25818.741812582008, 26440.73559264421, 26896.731032689815, 27041.1887643371, 941.7410212191702, 964.9517524123765, 996.5764550066193, 1001.2940876681922, 1022.2946167144646, 13959.581212563638, 14428.783568246485, 14481.565553033426, 14712.485063022743, 14737.852621473648, 373765.0, 375222.0, 377586.0, 377909.0, 379252.0, 50487.0, 50613.74693126511, 50692.49307506878, 50759.49240507621, 50857.23714144291, 953.8538288850087, 1102.5755084292446, 1155.156735583046, 1164.5923926625612, 1165.6561314412268, 27078.323041923322, 29450.558241625964, 29828.552571711876, 30876.691233087382, 30994.0, 43198.568014319455, 43858.78070609754, 43859.99999999873, 43865.0, 43891.0, 310867.0, 312033.0, 313423.0, 313684.0, 314066.0, 36787.264254715294, 38491.23017539577, 38560.0, 38627.80686096552, 38673.41989870098, 43022.35466468068, 43764.0, 43986.78006609946, 44026.11947761091, 44756.32865506955, 37213.62786372102, 37441.25117497689, 37451.31469083843, 37534.249315014094, 37940.62059379481, 36613.119476855456, 37728.62271377251, 37749.4337584931, 37845.0, 38125.4281185788, 35519.82240088783, 36587.63412365949, 36830.8158459206, 37672.43491347687, 37850.24299514049, 32494.83752581222, 34545.48181777326, 34715.65284347225, 34820.30359392849, 34825.82587087048, 24663.38341541404, 25103.497930041663, 25222.873885630455, 25356.619650705623, 25669.743302567484], "value": 18065.034047025558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.66761241595674, 371.3519907760957, 380.11433360270587, 381.883525524715, 386.84526189524206, 13167.144135631177, 16632.085235312054, 17097.401590944304, 18845.905770471127, 18870.716939245922, 17371.305147794104, 18070.0, 18086.728699069525, 18093.27626894926, 18097.366592169277, 4889.413270407556, 5337.866553336159, 5342.385625653042, 5347.1177255752755, 5361.303030606015, 3753.3244016077097, 5190.688558686472, 5832.883342333151, 6109.175261339729, 6150.630962142263, 6162.5069994400565, 6194.411530904579, 6212.44088032077, 6213.099100630406, 6214.254289485268, 6049.758009679607, 6209.223847019122, 6210.068489726532, 6217.502599792006, 6218.378162183791, 4816.277558366238, 5097.668651537638, 5443.863903402407, 5447.1829225616075, 5450.0, 20696.275630352866, 21146.78853211479, 21208.575828483343, 21303.5739285215, 21563.892180539155, 1819.1540933466001, 1860.1071485686946, 1963.0283009910186, 2172.9891350543303, 2236.686863839064, 9491.810163796754, 9617.23062155026, 9758.0, 12273.833772169542, 12710.809337859939, 1677.1446562253216, 1754.9473515794546, 1798.5593529585205, 1807.4939017075108, 1827.6984297591014, 66845.33154668439, 67650.0, 69773.30226697719, 69826.99999999949, 71032.83122440934, 8924.910750892537, 9663.0, 10174.389536627827, 10208.948955255177, 10246.180305575535, 12728.554500592434, 13590.864091359157, 13599.728005439836, 14088.506902258372, 14121.0, 6060.363661815446, 7337.669804858794, 7347.65776614486, 7385.29839665231, 7445.702171913171, 6876.759313424006, 6902.102726645504, 6993.300669932966, 7027.543209691354, 7029.753958611424, 4045.5954404559307, 4073.837046518165, 4093.406456063854, 4301.677374196947, 4543.136804007228, 1843.3456123076114, 1856.647237024961, 1872.925082996692, 1888.5656299051295, 1951.2097600471832, 778.8325510015374, 855.6577369052429, 869.3740506835069, 906.8322360363354, 923.8244733500613, 16304.673906521803, 16961.49115526536, 17104.401345952832, 17255.3960611378, 17546.912265438845, 865.312076898867, 872.965081396737, 883.2271762208068, 923.8706581078654, 930.9441433514011, 9147.679831205876, 9772.21822254218, 9837.55730992107, 9859.211263099078, 10013.249006324555, 366811.0, 370078.0, 375860.0, 385495.0, 386021.0, 40628.18743625111, 41007.1798564033, 68214.65892670605, 76493.6175319131, 76665.0, 882.8410886040574, 885.1518000876255, 896.4442045931434, 899.7795540092719, 906.0124464333908, 15455.227238637799, 15587.454439094578, 15702.685946281239, 15726.528204153894, 16042.197890105681, 37694.30375633048, 37720.24559508849, 38112.61887381202, 38525.4221186688, 39481.40777888391, 49327.26009109938, 49746.75126624344, 51311.230331545805, 51490.0, 51877.0, 7292.781216563511, 7355.338019578264, 7381.667824947997, 7513.098428188652, 7662.578558179353, 11098.5560577576, 11109.333439993627, 11500.597479088192, 11528.827067593826, 11657.766844663229, 9833.508324583885, 9968.50157492137, 10145.847812282675, 10166.440845753554, 10257.538410771383, 9632.518374081408, 9759.853602196115, 9821.656242031495, 9839.901600983898, 9882.407055576401, 8947.373683842068, 9622.0, 9845.360051596623, 10083.949580252052, 10180.236482263712, 6450.41946224842, 6574.342565743579, 6761.256261811295, 6997.510174287954, 7264.309890560388, 9075.591598377956, 9664.130228279208, 9933.751656208653, 10016.449095299828, 10263.178945684476], "value": 8213.225478458386, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1197.2457351868322, 1357.3484727330883, 1385.8129152564402, 1466.8899832512557, 1679.22755532455, 6083.604565703232, 6915.066466027085, 7141.821454463641, 7146.035285236491, 7154.678039488229, 6944.7569335073285, 7085.7165713371405, 7145.035420218269, 7353.852922941538, 7354.227806080365, 1853.2772218834666, 1908.065048126415, 1910.6560819052634, 2139.935801925945, 2183.1049269799387, 1930.1121484117323, 2152.838537109715, 2222.866628002325, 2232.520008198237, 2257.762934891837, 2145.5172586168064, 2190.080166330137, 2193.056985496236, 2196.417949243452, 2197.8131858791944, 1834.7247912813052, 2144.635411979967, 2148.3232781673723, 2153.720016397874, 2159.6004739123314, 2107.873527588334, 2177.368563116694, 2177.4665207024223, 2193.649016157423, 2194.8902554872193, 7195.8201044973775, 7234.529755565872, 7239.89140162898, 7241.674124664402, 7241.986121942932, 4335.913281734348, 4430.357598148283, 4431.446069241345, 4435.135148646015, 4442.733435993819, 2781.3741908070724, 2868.182567968119, 2888.0, 2889.9596145387854, 2911.621489206411, 825.5088222507599, 850.2517784349794, 854.4958474500074, 875.9474431534128, 878.569500944539, 9823.852642210373, 10052.547635356426, 10061.346012509164, 10076.0, 10084.999999999927, 4033.4151548025957, 4131.132462182975, 4242.087951090469, 4262.211490874198, 4265.765382903908, 8695.521746304014, 8707.085755995657, 8715.259202967818, 8723.040465548784, 8728.127187281221, 4416.646668266531, 4431.889202769892, 4432.357308190359, 4435.711678740871, 4436.5785250401805, 3561.6972557332397, 3680.723945704083, 3988.8404463821703, 3988.880333589997, 3990.9201815964097, 3542.6634469725336, 3624.130208749934, 3637.872674456434, 3647.908802279911, 3656.6526180012856, 1153.330040955186, 1189.3458597771191, 1190.4047976011993, 1203.7231436769416, 1205.9939700301443, 780.4809801482064, 794.5868148562715, 797.5653268968426, 807.1726480357563, 812.1350761439048, 4761.976190119027, 4785.090832741768, 4874.707517548958, 4909.558139767438, 4999.125153098194, 394.53839008359716, 400.0, 401.5261990850766, 404.85829959513933, 418.080223508283, 3349.916252093717, 3480.321337339245, 3506.1059429845736, 3509.6314886937016, 3552.3605750965075, 8739.781505462288, 8976.955115224382, 8986.955065224633, 9070.501122438198, 9070.727878163665, 8920.330975176888, 8950.104989501127, 8953.059928707522, 8959.5968181432, 8977.955110224408, 6609.603423794491, 6885.0, 6948.374646281859, 6953.165620125617, 6966.79099627012, 5249.055170069424, 5295.0, 5319.361676598833, 5427.674339539641, 5479.561635069105, 8214.219649133323, 8259.95870020646, 8497.235248827636, 8542.0, 8599.14008599135, 8347.207015333533, 8656.177663121993, 8681.175288347597, 8689.435186712843, 8697.130286971253, 5770.336411312753, 5986.850328741816, 5989.3711160329285, 6122.908156377747, 6160.045192995093, 6938.861222775416, 7137.10786151731, 7148.785536433916, 7149.892751608626, 7157.141143062658, 6434.388733070351, 6562.146920900253, 6596.637184954873, 6625.867482650224, 6747.2915343890145, 6460.515461340325, 6493.740250389931, 6522.804315870531, 6556.475481961336, 6570.8028759137305, 5818.73815678304, 5841.707914604338, 5877.500412464818, 5900.763969441346, 5902.380250073852, 4393.275109606879, 4440.578145076212, 4491.797869095833, 4516.9322460163785, 4575.542445755531, 4393.780310984374, 4401.097774956191, 4418.381426600343, 4427.180971520279, 4520.141173177086], "value": 3880.3413474356466, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.89418862115326, 297.1560767420525, 298.4165955556887, 303.8025283565682, 303.8070825026108, 4756.619470442365, 4772.522747725226, 4778.4743678195455, 4780.0, 4790.137775200463, 4695.530446955303, 4718.669693121483, 4721.315409265654, 4721.598664113546, 4747.5489828466325, 3571.2500374921296, 3640.5995340512522, 3677.6322367763278, 3740.4202348635868, 3780.659740623343, 3723.8510459581585, 3732.4028155495125, 3758.0604848787802, 3772.3586990211593, 3777.527809023872, 3578.1591326038492, 3714.9257014859686, 3725.8695945641907, 3737.121776382548, 3740.588535261119, 3598.3702852000924, 3713.57293911201, 3743.644353786386, 3746.5316835395574, 3755.8122093895468, 3325.5011748237716, 3327.8502467388785, 3333.6830902522756, 3348.363810875926, 3355.9328813423595, 4594.310853371988, 4597.264437689987, 4602.240630295997, 4613.469451013109, 4623.352730617717, 4067.8169482373364, 4259.190753756776, 4260.616544511009, 4275.3800698898485, 4301.505326887417, 4923.261510773377, 4929.75351232437, 4931.80272789088, 4954.2568614707725, 4961.603071754251, 3660.3045421369857, 3663.285659296438, 3664.230511592542, 3668.6881615062753, 3668.853245870162, 4970.925436118461, 5158.92261616076, 5183.585313174937, 5187.299714538527, 5202.401723801773, 3770.7360484765804, 3779.4330850372116, 3786.3373909565717, 3787.2046870157574, 3795.6204379562373, 3837.4819399380726, 3838.673712734393, 3841.4237864320576, 3841.635044670752, 3847.826847791856, 4303.74177549348, 4306.763128027988, 4309.569043095728, 4310.827566897352, 4316.374125751749, 4787.54518320759, 4975.427825800007, 4977.228529577921, 4981.950180498221, 4995.875103122451, 1320.8150858879765, 1328.136711137768, 1329.2755448280516, 1336.4520546576052, 1340.095435580979, 864.7449002544139, 873.7116751471999, 910.6175406329357, 929.5631053404888, 934.4346670264528, 4323.956760432418, 4341.696081274281, 4343.391925130484, 4350.151720414488, 4367.825286988548, 5014.674046186986, 5015.548600625962, 5035.924461133012, 5043.470435604282, 5057.583876514582, 4245.32309737658, 4362.258416069276, 4366.366876802909, 4375.059362237134, 4380.299152135643, 2670.479256544994, 2682.4903268378944, 2695.355832941904, 2704.6619172603423, 2713.213168181245, 4796.832110876103, 4803.3995750531185, 4803.567678908915, 4827.155247831615, 4843.733594652328, 4990.226514890198, 5050.318207042076, 5130.97434512825, 5134.691918484828, 5144.15121504955, 4791.832285869978, 4798.808047678123, 4808.543188397167, 4819.132556139788, 4823.638227132979, 5015.949840501548, 5024.84925452237, 5027.371578552681, 5039.47085556026, 5039.697618142924, 4789.712617242976, 4916.360873086476, 4921.4832442593015, 4952.851414457572, 4953.826616068564, 4806.639502037291, 4807.134715751058, 4808.7595620219545, 4815.494373090775, 4821.481233411464, 3700.740948133605, 3703.3148867459604, 3704.666580007812, 3707.3512135375663, 3714.2571485703506, 4764.237721964469, 4984.2025275955675, 5008.348914641073, 5024.849254522224, 5033.84898453047, 4853.961336238717, 4854.00492898962, 4855.295982082649, 4856.5871900887405, 4868.853934381974, 4845.6123510118405, 4869.440014398389, 4880.170371036861, 4882.170031094652, 4888.266759986031, 4665.160271151225, 4812.133815913029, 4819.493773321955, 4820.39745031871, 4823.324734537237, 4772.904541909073, 4894.437139728834, 4904.926426103682, 4922.72924989129, 4942.308076869169, 4823.589994850477, 4830.275458681226, 4893.290472881484, 4898.828541001048, 4912.189488734319], "value": 3760.9334685505783, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.365893254077, 657.1489920552883, 674.4772801079164, 735.3786050787083, 776.5107981971357, 11103.111751059916, 11822.527098916033, 11829.645110646694, 14256.572302830906, 15037.0, 14948.925255373735, 14999.925000374982, 15052.774208386856, 15080.0, 15115.0, 621.3879328861068, 765.227120608187, 772.9072511298652, 798.2815466080516, 801.6753214947955, 787.4015748031509, 803.3733687723585, 803.9959800200991, 804.1596531624466, 805.6817557064956, 833.2167762303445, 836.4145098431092, 837.3636036612188, 838.3125836813815, 838.681301105579, 645.9709313080923, 792.9167437419046, 809.5790189101634, 830.5390508267909, 831.098258389648, 604.3442864492032, 609.1198218574162, 609.5732986909137, 609.7896225802091, 610.0270069239556, 13426.798598021038, 13437.39531721065, 13440.596782096552, 13459.86540134596, 13465.798013029813, 11355.943220283845, 11876.287422754662, 12003.3398163101, 12005.93997030018, 12428.0, 12025.879741202563, 12026.420551968913, 12072.21530600517, 12092.637220883387, 12146.392680365947, 4161.97919010403, 4167.97916010418, 4229.238737027334, 4268.253055715269, 4358.782060896974, 60748.0, 61112.388876111116, 61303.693481532304, 62381.064284035776, 62891.68554157246, 10049.24630652704, 10104.797904042025, 10131.240156988255, 10204.948975255225, 10437.739056523647, 15091.320890559951, 15467.07197568127, 17825.46523604294, 17852.19665115073, 17855.642887142185, 6354.110424540568, 6354.714037868307, 6372.490200783926, 6431.1317972073175, 6459.450946669492, 3629.8366573504254, 3652.5251717276583, 3671.2657468506404, 3757.605451427615, 3801.657850793442, 2666.3867310518303, 2818.4644917466026, 2826.307554649083, 2827.812318826098, 2827.9010234641687, 471.21777848770876, 473.143610065782, 480.327541441984, 484.4307938172633, 494.02430200354013, 521.9947800521946, 526.5839986410692, 538.3593523706776, 555.0619453124207, 564.7063526965954, 7562.2437756223935, 7606.0, 7898.131205567383, 7970.721024764105, 8158.592070396457, 463.0807846424844, 478.24914883633056, 509.27936969188926, 544.4283502322545, 556.2962851992233, 3784.735068545175, 3858.305505009125, 3891.3579259422445, 3955.327594308917, 3993.980030099889, 89695.0, 92671.0, 95440.0, 96374.51812741032, 97354.0, 81204.59397703092, 81555.59222203969, 81864.0, 82069.9999999988, 82306.58846705729, 46750.29874551884, 47629.5237047632, 68574.3142568588, 72758.0, 73326.99999999894, 8282.50304981703, 8907.955460222658, 9096.454212747256, 9302.116298951589, 9305.0, 43351.0, 43625.78187109044, 44479.33281000852, 45542.0, 45797.54202457933, 57523.0, 61226.69386653038, 61292.0, 62406.0, 62636.686816567446, 11668.533258669559, 12016.399180040788, 12341.0, 12519.436625351698, 12923.15999460032, 12470.563530276397, 12721.785758822796, 12796.232226066466, 12901.677458063623, 14051.859481405463, 10302.587896484056, 11698.824517632072, 12314.384280786104, 12471.625851224479, 12481.06392020584, 12566.560170393992, 12569.497220111092, 12593.622191333909, 12989.675258118623, 13474.393652285475, 12387.938060309642, 12649.0, 12691.428885699981, 12958.80561791555, 13123.737525249251, 10113.64602238918, 10334.173266138841, 10591.5233814477, 10668.306560073881, 10682.57269709203, 9770.902290977283, 9912.752181195528, 10547.789044219226, 10759.515821787882, 11078.058365039062], "value": 6588.364910358983, "unit": "score"}], "name": "dromaeo_css", "value": 6357.647406630818, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 112.0, 113.0, 116.0, 116.0, 114.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 125.0, 178.0, 135.0, 125.0, 148.0, 126.0, 166.0, 122.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 167.0, 160.0, 163.0, 168.0, 162.0, 163.0, 160.0, 161.0], "value": 162.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 122.0, 77.0, 79.0, 74.0, 75.0, 112.0, 76.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 110.0, 85.0, 85.0, 86.0, 119.0, 85.0, 85.0, 128.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 63.0, 62.0, 61.0], "value": 62.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 66.0, 63.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 78.0, 78.0, 77.0, 79.0, 78.0, 79.0, 78.0, 79.0, 83.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 127.0, 130.0, 129.0, 130.0, 127.0, 130.0, 205.0, 131.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 165.0, 169.0, 170.0, 170.0, 171.0, 166.0, 168.0, 168.0], "value": 168.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 72.0, 67.0, 66.0, 67.0, 70.0, 69.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1531.8999999999996, "alertThreshold": 2.0}]} 02:30:36 INFO - Return code: 0 02:30:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:30:36 INFO - # TBPL SUCCESS # 02:30:36 INFO - Running post-action listener: _resource_record_post_action 02:30:36 INFO - ##### 02:30:36 INFO - ##### Finished run-tests step (success) 02:30:36 INFO - ##### 02:30:36 INFO - Running post-run listener: _resource_record_post_run 02:30:36 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 543834112; Read time: 104; Write time: 641948 02:30:36 INFO - TinderboxPrint: CPU usage
13.0% 02:30:36 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 104 02:30:36 INFO - TinderboxPrint: I/O write bytes / time
543,834,112 / 641,948 02:30:36 INFO - TinderboxPrint: CPU idle
8,361.3 (87.0%) 02:30:36 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 02:30:36 INFO - TinderboxPrint: Swap in / out
0 / 0 02:30:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246697984; Read time: 0; Write time: 355120 02:30:36 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296521728; Read time: 92; Write time: 286828 02:30:37 INFO - Running post-run listener: _upload_blobber_files 02:30:37 INFO - Blob upload gear active. 02:30:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:30:37 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 02:30:37 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'] 02:30:37 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 02:30:37 INFO - (blobuploader) - INFO - Open directory for files ... 02:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:38 INFO - (blobuploader) - INFO - Done attempting. 02:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:39 INFO - (blobuploader) - INFO - Done attempting. 02:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:30:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:30:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:30:44 INFO - (blobuploader) - INFO - Done attempting. 02:30:44 INFO - (blobuploader) - INFO - Iteration through files over. 02:30:44 INFO - Return code: 0 02:30:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:30:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:30:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14daae86cd4b0a3276a7a6964ce33f499305e096bbe7bea197d94a6023ad72bf552c0a7990a36b4a0078d82cf938c6951abc2a7d3064feaf0ee4fe1c99c031cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a8c75c7f9be8cb25c0065fa3b43d6051b766a3c4e699bdd82390ad495b3437afd3d3eecc56e9792ff10efcdd84064064213b56ccd3da0dc502acefd56ae917a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c8de5ebc94427eabae80730313734334e4c5730ef6d15949b9def930660164b533d32d54d6bc7d92ac16164693829b75038a6e170ee7c9aebc1c1dcbb983db"} 02:30:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:30:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:30:44 INFO - Contents: 02:30:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/14daae86cd4b0a3276a7a6964ce33f499305e096bbe7bea197d94a6023ad72bf552c0a7990a36b4a0078d82cf938c6951abc2a7d3064feaf0ee4fe1c99c031cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a8c75c7f9be8cb25c0065fa3b43d6051b766a3c4e699bdd82390ad495b3437afd3d3eecc56e9792ff10efcdd84064064213b56ccd3da0dc502acefd56ae917a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c8de5ebc94427eabae80730313734334e4c5730ef6d15949b9def930660164b533d32d54d6bc7d92ac16164693829b75038a6e170ee7c9aebc1c1dcbb983db"} 02:30:44 INFO - Running post-run listener: copy_logs_to_upload_dir 02:30:44 INFO - Copying logs to upload dir... 02:30:44 INFO - mkdir: /builds/slave/test/build/upload/logs 02:30:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.210840 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-07-13 02:30:44.623843) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 02:30:44.627774) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 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/14daae86cd4b0a3276a7a6964ce33f499305e096bbe7bea197d94a6023ad72bf552c0a7990a36b4a0078d82cf938c6951abc2a7d3064feaf0ee4fe1c99c031cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a8c75c7f9be8cb25c0065fa3b43d6051b766a3c4e699bdd82390ad495b3437afd3d3eecc56e9792ff10efcdd84064064213b56ccd3da0dc502acefd56ae917a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c8de5ebc94427eabae80730313734334e4c5730ef6d15949b9def930660164b533d32d54d6bc7d92ac16164693829b75038a6e170ee7c9aebc1c1dcbb983db"} build_url:https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/bJy8L8iFScGA5w-5mSRHMQ/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/14daae86cd4b0a3276a7a6964ce33f499305e096bbe7bea197d94a6023ad72bf552c0a7990a36b4a0078d82cf938c6951abc2a7d3064feaf0ee4fe1c99c031cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9a8c75c7f9be8cb25c0065fa3b43d6051b766a3c4e699bdd82390ad495b3437afd3d3eecc56e9792ff10efcdd84064064213b56ccd3da0dc502acefd56ae917a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a1c8de5ebc94427eabae80730313734334e4c5730ef6d15949b9def930660164b533d32d54d6bc7d92ac16164693829b75038a6e170ee7c9aebc1c1dcbb983db"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 02:30:44.653494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:30:44.653824) ========= 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=5cf47e208febbcd81da23b2e0000026f-1468400999.936826-1838205417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 02:30:44.739954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 02:30:44.740383) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 02:30:44.740752) ========= ========= Total master_lag: 0.18 =========