builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1467744373.17 results: success (0) buildid: 20160705104225 builduid: 1a8ff23a04664e2eae284953b4fbca91 revision: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.172981) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.173454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.173744) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.186056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.186371) ========= 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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 11:46:13-- 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% 71.2M=0s 2016-07-05 11:46:13 (71.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.295798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.296147) ========= 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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018147 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.345579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:13.345895) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3db27bf874fa9e5057b7bcb96f325699bb7f1688 --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 3db27bf874fa9e5057b7bcb96f325699bb7f1688 --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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 11:46:13,520 truncating revision to first 12 chars 2016-07-05 11:46:13,520 Setting DEBUG logging. 2016-07-05 11:46:13,520 attempt 1/10 2016-07-05 11:46:13,520 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3db27bf874fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 11:46:13,852 unpacking tar archive at: fx-team-3db27bf874fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679983 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:14.039937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:14.040267) ========= script_repo_revision: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:14.040702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:14.040973) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 11:46:14.050573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-05 11:46:14.050915) ========= /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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:14 INFO - MultiFileLogger online at 20160705 11:46:14 in /builds/slave/test 11:46:14 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 11:46:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:14 INFO - {'append_to_log': False, 11:46:14 INFO - 'base_work_dir': '/builds/slave/test', 11:46:14 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:14 INFO - 'branch': 'Fx-Team-Non-PGO', 11:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:14 INFO - 'config_files': ('talos/linux_config.py',), 11:46:14 INFO - 'default_actions': ('clobber', 11:46:14 INFO - 'read-buildbot-config', 11:46:14 INFO - 'download-and-extract', 11:46:14 INFO - 'populate-webroot', 11:46:14 INFO - 'create-virtualenv', 11:46:14 INFO - 'install', 11:46:14 INFO - 'run-tests'), 11:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:14 INFO - 'download_minidump_stackwalk': True, 11:46:14 INFO - 'download_symbols': 'ondemand', 11:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:14 INFO - 'installer_path': 'installer.exe', 11:46:14 INFO - 'log_level': 'info', 11:46:14 INFO - 'log_name': 'talos', 11:46:14 INFO - 'log_to_console': True, 11:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:14 INFO - 'opt_config_files': (), 11:46:14 INFO - 'pip_index': False, 11:46:14 INFO - 'sps_profile': False, 11:46:14 INFO - 'sps_profile_interval': 0, 11:46:14 INFO - 'suite': 'dromaeojs', 11:46:14 INFO - 'system_bits': '32', 11:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:14 INFO - 'title': 'talos-linux64-ix-028', 11:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:14 INFO - 'use_talos_json': True, 11:46:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:14 INFO - 'work_dir': 'build'} 11:46:14 INFO - ##### 11:46:14 INFO - ##### Running clobber step. 11:46:14 INFO - ##### 11:46:14 INFO - Running pre-action listener: _resource_record_pre_action 11:46:14 INFO - Running main action method: clobber 11:46:14 INFO - rmtree: /builds/slave/test/build 11:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:14 INFO - Running post-action listener: _resource_record_post_action 11:46:14 INFO - ##### 11:46:14 INFO - ##### Finished clobber step (success) 11:46:14 INFO - ##### 11:46:14 INFO - ##### 11:46:14 INFO - ##### Running read-buildbot-config step. 11:46:14 INFO - ##### 11:46:14 INFO - Running pre-action listener: _resource_record_pre_action 11:46:14 INFO - Running main action method: read_buildbot_config 11:46:14 INFO - Using buildbot properties: 11:46:14 INFO - { 11:46:14 INFO - "project": "", 11:46:14 INFO - "product": "firefox", 11:46:14 INFO - "script_repo_revision": "production", 11:46:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:46:14 INFO - "repository": "", 11:46:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:46:14 INFO - "buildid": "20160705104225", 11:46:14 INFO - "pgo_build": "False", 11:46:14 INFO - "basedir": "/builds/slave/test", 11:46:14 INFO - "buildnumber": 3131, 11:46:14 INFO - "slavename": "talos-linux64-ix-028", 11:46:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:46:14 INFO - "platform": "ubuntu64_hw", 11:46:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:46:14 INFO - "branch": "fx-team", 11:46:14 INFO - "repo_path": "integration/fx-team", 11:46:14 INFO - "revision": "3db27bf874fa9e5057b7bcb96f325699bb7f1688", 11:46:14 INFO - "stage_platform": "linux64", 11:46:14 INFO - "builduid": "1a8ff23a04664e2eae284953b4fbca91", 11:46:14 INFO - "slavebuilddir": "test" 11:46:14 INFO - } 11:46:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:46:14 INFO - Running post-action listener: _resource_record_post_action 11:46:14 INFO - ##### 11:46:14 INFO - ##### Finished read-buildbot-config step (success) 11:46:14 INFO - ##### 11:46:14 INFO - ##### 11:46:14 INFO - ##### Running download-and-extract step. 11:46:14 INFO - ##### 11:46:14 INFO - Running pre-action listener: _resource_record_pre_action 11:46:14 INFO - Running main action method: download_and_extract 11:46:14 INFO - mkdir: /builds/slave/test/build/tests 11:46:14 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')]} 11:46:14 INFO - https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:15 INFO - Downloaded 1361 bytes. 11:46:15 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:46:15 INFO - Using the following test package requirements: 11:46:15 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:15 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:46:15 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:46:15 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'jsshell-linux-x86_64.zip'], 11:46:15 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:46:15 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:15 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:46:15 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:46:15 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:46:15 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:15 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:46:15 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:46:15 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')]} 11:46:15 INFO - https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:46:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:16 INFO - Downloaded 22729946 bytes. 11:46:16 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'] 11:46:16 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 11:46:17 INFO - Return code: 0 11:46:17 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 11:46:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:46:17 INFO - https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:46:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:46:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:46:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:18 INFO - Downloaded 22729946 bytes. 11:46:18 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'] 11:46:18 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 11:46:20 INFO - Return code: 0 11:46:20 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')]} 11:46:20 INFO - https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:21 INFO - Downloaded 14403333 bytes. 11:46:21 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'] 11:46:21 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 11:46:21 INFO - Return code: 0 11:46: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')]} 11:46:21 INFO - https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:46:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:46:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:46:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4oBKog0QtK5sozSluoBng/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 11:46:22 INFO - Downloaded 56499854 bytes. 11:46:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:46:22 INFO - mkdir: /builds/slave/test/properties 11:46:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:22 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:22 INFO - Contents: 11:46:22 INFO - build_url:https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:46:23 INFO - Running post-action listener: _resource_record_post_action 11:46:23 INFO - Running post-action listener: set_extra_try_arguments 11:46:23 INFO - ##### 11:46:23 INFO - ##### Finished download-and-extract step (success) 11:46:23 INFO - ##### 11:46:23 INFO - ##### 11:46:23 INFO - ##### Running populate-webroot step. 11:46:23 INFO - ##### 11:46:23 INFO - Running pre-action listener: _resource_record_pre_action 11:46:23 INFO - Running main action method: populate_webroot 11:46:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:46:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:46:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:46:23 INFO - '--tppagecycles', 11:46:23 INFO - '7'], 11:46:23 INFO - 'tests': ['tsvgm']}}, 11:46:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:46:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:46:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:46:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:46:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['damp', 'tps']}, 11:46:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'tests': ['damp', 'tps']}, 11:46:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['dromaeo_dom']}, 11:46:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['basic_compositor_video']}, 11:46:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:46:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'other-e10s': {'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['a11yr', 11:46:23 INFO - 'ts_paint', 11:46:23 INFO - 'tpaint', 11:46:23 INFO - 'sessionrestore', 11:46:23 INFO - 'sessionrestore_no_auto_restore', 11:46:23 INFO - 'tabpaint']}, 11:46:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['tsvgx', 11:46:23 INFO - 'tsvgr_opacity', 11:46:23 INFO - 'tart', 11:46:23 INFO - 'tscrollx', 11:46:23 INFO - 'cart']}, 11:46:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:46:23 INFO - 'tsvgr_opacity', 11:46:23 INFO - 'tart', 11:46:23 INFO - 'tscrollx', 11:46:23 INFO - 'cart']}, 11:46:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'talos_options': ['--disable-e10s'], 11:46:23 INFO - 'tests': ['tp5o']}, 11:46:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'tests': ['tp5o']}, 11:46:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'talos_options': ['--disable-e10s', 11:46:23 INFO - '--xperf_path', 11:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:23 INFO - 'tests': ['tp5n']}, 11:46:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:23 INFO - 'talos_options': ['--xperf_path', 11:46:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:23 INFO - 'tests': ['tp5n']}}, 11:46:23 INFO - 'talos.zip': {'path': '', 11:46:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:46:23 INFO - Running post-action listener: _resource_record_post_action 11:46:23 INFO - ##### 11:46:23 INFO - ##### Finished populate-webroot step (success) 11:46:23 INFO - ##### 11:46:23 INFO - ##### 11:46:23 INFO - ##### Running create-virtualenv step. 11:46:23 INFO - ##### 11:46:23 INFO - Running pre-action listener: _resource_record_pre_action 11:46:23 INFO - Running main action method: create_virtualenv 11:46:23 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:23 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 11:46:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:23 INFO - Using real prefix '/usr' 11:46:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:26 INFO - Installing pip.................done. 11:46:26 INFO - Return code: 0 11:46:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:26 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')]} 11:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:26 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')]} 11:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:26 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:26 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 11:46:26 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 11:46:26 INFO - Using env: {'DISPLAY': ':0', 11:46:26 INFO - 'HOME': '/home/cltbld', 11:46:26 INFO - 'LANG': 'en_US.UTF-8', 11:46:26 INFO - 'LANGUAGE': 'en_US:en', 11:46:26 INFO - 'LOGNAME': 'cltbld', 11:46:26 INFO - 'MAIL': '/var/mail/cltbld', 11:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:26 INFO - 'MOZ_NO_REMOTE': '1', 11:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:26 INFO - 'NO_EM_RESTART': '1', 11:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:26 INFO - 'PWD': '/builds/slave/test', 11:46:26 INFO - 'SHELL': '/bin/bash', 11:46:26 INFO - 'SHLVL': '1', 11:46:26 INFO - 'TERM': 'linux', 11:46:26 INFO - 'TMOUT': '86400', 11:46:26 INFO - 'USER': 'cltbld', 11:46:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:26 INFO - '_': '/tools/buildbot/bin/python'} 11:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:26 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 11:46:26 INFO - Cleaning up... 11:46:26 INFO - Return code: 0 11:46:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:46:26 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')]} 11:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:26 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')]} 11:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:26 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:26 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 11:46:26 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 11:46:26 INFO - Using env: {'DISPLAY': ':0', 11:46:26 INFO - 'HOME': '/home/cltbld', 11:46:26 INFO - 'LANG': 'en_US.UTF-8', 11:46:26 INFO - 'LANGUAGE': 'en_US:en', 11:46:26 INFO - 'LOGNAME': 'cltbld', 11:46:26 INFO - 'MAIL': '/var/mail/cltbld', 11:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:26 INFO - 'MOZ_NO_REMOTE': '1', 11:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:26 INFO - 'NO_EM_RESTART': '1', 11:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:26 INFO - 'PWD': '/builds/slave/test', 11:46:26 INFO - 'SHELL': '/bin/bash', 11:46:26 INFO - 'SHLVL': '1', 11:46:26 INFO - 'TERM': 'linux', 11:46:26 INFO - 'TMOUT': '86400', 11:46:26 INFO - 'USER': 'cltbld', 11:46:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:26 INFO - '_': '/tools/buildbot/bin/python'} 11:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:26 INFO - Downloading/unpacking psutil>=3.1.1 11:46:26 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 11:46:26 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 11:46:26 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 11:46:26 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 11:46:26 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 11:46:26 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 11:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:28 INFO - Installing collected packages: psutil 11:46:28 INFO - Running setup.py install for psutil 11:46:28 INFO - building 'psutil._psutil_linux' extension 11:46:28 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 11:46:28 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 11:46:28 INFO - building 'psutil._psutil_posix' extension 11:46:28 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 11:46:28 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 11:46:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:28 INFO - Successfully installed psutil 11:46:28 INFO - Cleaning up... 11:46:29 INFO - Return code: 0 11:46:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:29 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:29 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 11:46:29 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 11:46:29 INFO - Using env: {'DISPLAY': ':0', 11:46:29 INFO - 'HOME': '/home/cltbld', 11:46:29 INFO - 'LANG': 'en_US.UTF-8', 11:46:29 INFO - 'LANGUAGE': 'en_US:en', 11:46:29 INFO - 'LOGNAME': 'cltbld', 11:46:29 INFO - 'MAIL': '/var/mail/cltbld', 11:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:29 INFO - 'MOZ_NO_REMOTE': '1', 11:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:29 INFO - 'NO_EM_RESTART': '1', 11:46:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:29 INFO - 'PWD': '/builds/slave/test', 11:46:29 INFO - 'SHELL': '/bin/bash', 11:46:29 INFO - 'SHLVL': '1', 11:46:29 INFO - 'TERM': 'linux', 11:46:29 INFO - 'TMOUT': '86400', 11:46:29 INFO - 'USER': 'cltbld', 11:46:29 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:29 INFO - '_': '/tools/buildbot/bin/python'} 11:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46: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 11:46:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:31 INFO - Installing collected packages: mozsystemmonitor 11:46:31 INFO - Running setup.py install for mozsystemmonitor 11:46:31 INFO - Successfully installed mozsystemmonitor 11:46:31 INFO - Cleaning up... 11:46:31 INFO - Return code: 0 11:46:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:31 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:31 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 11:46:31 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 11:46:31 INFO - Using env: {'DISPLAY': ':0', 11:46:31 INFO - 'HOME': '/home/cltbld', 11:46:31 INFO - 'LANG': 'en_US.UTF-8', 11:46:31 INFO - 'LANGUAGE': 'en_US:en', 11:46:31 INFO - 'LOGNAME': 'cltbld', 11:46:31 INFO - 'MAIL': '/var/mail/cltbld', 11:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:31 INFO - 'MOZ_NO_REMOTE': '1', 11:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:31 INFO - 'NO_EM_RESTART': '1', 11:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:31 INFO - 'PWD': '/builds/slave/test', 11:46:31 INFO - 'SHELL': '/bin/bash', 11:46:31 INFO - 'SHLVL': '1', 11:46:31 INFO - 'TERM': 'linux', 11:46:31 INFO - 'TMOUT': '86400', 11:46:31 INFO - 'USER': 'cltbld', 11:46:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:31 INFO - '_': '/tools/buildbot/bin/python'} 11:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:31 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:31 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 11:46:31 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 11:46:31 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 11:46:31 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 11:46:31 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 11:46:31 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 11:46:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:46:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:46:33 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 11:46:33 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 11:46:33 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 11:46:33 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 11:46:33 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 11:46:33 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 11:46:33 INFO - Downloading functools32-3.2.3-2.tar.gz 11:46:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:46:33 INFO - warning: no files found matching '*.txt' 11:46:33 INFO - no previously-included directories found matching 'build' 11:46:33 INFO - no previously-included directories found matching 'dist' 11:46:33 INFO - no previously-included directories found matching '.git*' 11:46:33 INFO - Installing collected packages: jsonschema, functools32 11:46:33 INFO - Running setup.py install for functools32 11:46:33 INFO - warning: no files found matching '*.txt' 11:46:33 INFO - no previously-included directories found matching 'build' 11:46:33 INFO - no previously-included directories found matching 'dist' 11:46:33 INFO - no previously-included directories found matching '.git*' 11:46:33 INFO - Successfully installed jsonschema functools32 11:46:33 INFO - Cleaning up... 11:46:33 INFO - Return code: 0 11:46:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:33 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:33 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 11:46:33 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 11:46:33 INFO - Using env: {'DISPLAY': ':0', 11:46:33 INFO - 'HOME': '/home/cltbld', 11:46:33 INFO - 'LANG': 'en_US.UTF-8', 11:46:33 INFO - 'LANGUAGE': 'en_US:en', 11:46:33 INFO - 'LOGNAME': 'cltbld', 11:46:33 INFO - 'MAIL': '/var/mail/cltbld', 11:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:33 INFO - 'MOZ_NO_REMOTE': '1', 11:46:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:33 INFO - 'NO_EM_RESTART': '1', 11:46:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:33 INFO - 'PWD': '/builds/slave/test', 11:46:33 INFO - 'SHELL': '/bin/bash', 11:46:33 INFO - 'SHLVL': '1', 11:46:33 INFO - 'TERM': 'linux', 11:46:33 INFO - 'TMOUT': '86400', 11:46:33 INFO - 'USER': 'cltbld', 11:46:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:33 INFO - '_': '/tools/buildbot/bin/python'} 11:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:35 INFO - Downloading blobuploader-1.2.4.tar.gz 11:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:46:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:46:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 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 11:46:36 INFO - Downloading docopt-0.6.1.tar.gz 11:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:46:36 INFO - Installing collected packages: blobuploader, requests, docopt 11:46:36 INFO - Running setup.py install for blobuploader 11:46:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:46:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:46:36 INFO - Running setup.py install for requests 11:46:37 INFO - Running setup.py install for docopt 11:46:37 INFO - Successfully installed blobuploader requests docopt 11:46:37 INFO - Cleaning up... 11:46:37 INFO - Return code: 0 11:46:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 11:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:37 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:37 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 11:46:37 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 11:46:37 INFO - Using env: {'DISPLAY': ':0', 11:46:37 INFO - 'HOME': '/home/cltbld', 11:46:37 INFO - 'LANG': 'en_US.UTF-8', 11:46:37 INFO - 'LANGUAGE': 'en_US:en', 11:46:37 INFO - 'LOGNAME': 'cltbld', 11:46:37 INFO - 'MAIL': '/var/mail/cltbld', 11:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:37 INFO - 'MOZ_NO_REMOTE': '1', 11:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:37 INFO - 'NO_EM_RESTART': '1', 11:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:37 INFO - 'PWD': '/builds/slave/test', 11:46:37 INFO - 'SHELL': '/bin/bash', 11:46:37 INFO - 'SHLVL': '1', 11:46:37 INFO - 'TERM': 'linux', 11:46:37 INFO - 'TMOUT': '86400', 11:46:37 INFO - 'USER': 'cltbld', 11:46:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:37 INFO - '_': '/tools/buildbot/bin/python'} 11:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:37 INFO - Running setup.py (path:/tmp/pip-dg4z50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:37 INFO - Running setup.py (path:/tmp/pip-lAYeSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:37 INFO - Running setup.py (path:/tmp/pip-qO7cDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:37 INFO - Running setup.py (path:/tmp/pip-T6mIU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:37 INFO - Running setup.py (path:/tmp/pip-4dTXkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:37 INFO - Running setup.py (path:/tmp/pip-1E9pB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:38 INFO - Running setup.py (path:/tmp/pip-5fYUQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:38 INFO - Running setup.py (path:/tmp/pip-1_tB5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:38 INFO - Running setup.py (path:/tmp/pip-tShoaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:38 INFO - Running setup.py (path:/tmp/pip-TwGusU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:38 INFO - Running setup.py (path:/tmp/pip-C5fg7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:38 INFO - Running setup.py (path:/tmp/pip-8_uugy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:38 INFO - Running setup.py (path:/tmp/pip-cmjVC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:38 INFO - Running setup.py (path:/tmp/pip-zDivQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:38 INFO - Running setup.py (path:/tmp/pip-HAZPPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:38 INFO - Running setup.py (path:/tmp/pip-k9swW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:38 INFO - Running setup.py (path:/tmp/pip-mmvxbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:46:38 INFO - Running setup.py install for manifestparser 11:46:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:46:38 INFO - Running setup.py install for mozcrash 11:46:39 INFO - Running setup.py install for mozdebug 11:46:39 INFO - Running setup.py install for mozdevice 11:46:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Running setup.py install for mozfile 11:46:39 INFO - Running setup.py install for mozhttpd 11:46:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Running setup.py install for mozinfo 11:46:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Running setup.py install for mozInstall 11:46:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Running setup.py install for mozleak 11:46:39 INFO - Running setup.py install for mozlog 11:46:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:46:39 INFO - Running setup.py install for moznetwork 11:46:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Running setup.py install for mozprocess 11:46:40 INFO - Running setup.py install for mozprofile 11:46:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Running setup.py install for mozrunner 11:46:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Running setup.py install for mozscreenshot 11:46:40 INFO - Running setup.py install for moztest 11:46:40 INFO - Running setup.py install for mozversion 11:46:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:46:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:46:40 INFO - Cleaning up... 11:46:40 INFO - Return code: 0 11:46:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:40 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:40 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 11:46:40 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 11:46:40 INFO - Using env: {'DISPLAY': ':0', 11:46:40 INFO - 'HOME': '/home/cltbld', 11:46:40 INFO - 'LANG': 'en_US.UTF-8', 11:46:40 INFO - 'LANGUAGE': 'en_US:en', 11:46:40 INFO - 'LOGNAME': 'cltbld', 11:46:40 INFO - 'MAIL': '/var/mail/cltbld', 11:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:40 INFO - 'MOZ_NO_REMOTE': '1', 11:46:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:40 INFO - 'NO_EM_RESTART': '1', 11:46:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:40 INFO - 'PWD': '/builds/slave/test', 11:46:40 INFO - 'SHELL': '/bin/bash', 11:46:40 INFO - 'SHLVL': '1', 11:46:40 INFO - 'TERM': 'linux', 11:46:40 INFO - 'TMOUT': '86400', 11:46:40 INFO - 'USER': 'cltbld', 11:46:40 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:40 INFO - '_': '/tools/buildbot/bin/python'} 11:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:46:40 INFO - Running setup.py (path:/tmp/pip-h_2kDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:46:40 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)) 11:46:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:46:40 INFO - Running setup.py (path:/tmp/pip-Ncmz3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:46:41 INFO - Running setup.py (path:/tmp/pip-M7dSa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:46:41 INFO - Running setup.py (path:/tmp/pip-xOVuAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:46:41 INFO - Running setup.py (path:/tmp/pip-B2Kn3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:46:41 INFO - Running setup.py (path:/tmp/pip-QEjrbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:46:41 INFO - Running setup.py (path:/tmp/pip-EYRD0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:46:41 INFO - Running setup.py (path:/tmp/pip-1EPLSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:46:41 INFO - Running setup.py (path:/tmp/pip-QSGBV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:46:41 INFO - Running setup.py (path:/tmp/pip-IIE7gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:46:41 INFO - Running setup.py (path:/tmp/pip-sdm7zM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:46:41 INFO - Running setup.py (path:/tmp/pip-XDFpwt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:46:41 INFO - Running setup.py (path:/tmp/pip-Js1S0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:46:41 INFO - Running setup.py (path:/tmp/pip-MBAb1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:41 INFO - Running setup.py (path:/tmp/pip-63YYkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:46:41 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)) 11:46:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:46:41 INFO - Running setup.py (path:/tmp/pip-f4uuah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:46:42 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)) 11:46:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:46:42 INFO - Running setup.py (path:/tmp/pip-WS9Tj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:46:42 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)) 11:46:42 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)) 11:46:42 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)) 11:46:42 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)) 11:46:42 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)) 11:46:42 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)) 11:46:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:44 INFO - Downloading blessings-1.6.tar.gz 11:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:46:44 INFO - Installing collected packages: blessings 11:46:44 INFO - Running setup.py install for blessings 11:46:44 INFO - Successfully installed blessings 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:46:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:44 INFO - Reading from file tmpfile_stdout 11:46:44 INFO - Current package versions: 11:46:44 INFO - argparse == 1.2.1 11:46:44 INFO - blessings == 1.6 11:46:44 INFO - blobuploader == 1.2.4 11:46:44 INFO - docopt == 0.6.1 11:46:44 INFO - functools32 == 3.2.3-2 11:46:44 INFO - jsonschema == 2.5.1 11:46:44 INFO - manifestparser == 1.1 11:46:44 INFO - mozInstall == 1.12 11:46:44 INFO - mozcrash == 0.17 11:46:44 INFO - mozdebug == 0.1 11:46:44 INFO - mozdevice == 0.48 11:46:44 INFO - mozfile == 1.2 11:46:44 INFO - mozhttpd == 0.7 11:46:44 INFO - mozinfo == 0.9 11:46:44 INFO - mozleak == 0.1 11:46:44 INFO - mozlog == 3.2 11:46:44 INFO - moznetwork == 0.27 11:46:44 INFO - mozprocess == 0.22 11:46:44 INFO - mozprofile == 0.28 11:46:44 INFO - mozrunner == 6.11 11:46:44 INFO - mozscreenshot == 0.1 11:46:44 INFO - mozsystemmonitor == 0.3 11:46:44 INFO - moztest == 0.7 11:46:44 INFO - mozversion == 1.4 11:46:44 INFO - psutil == 3.1.1 11:46:44 INFO - requests == 1.2.3 11:46:44 INFO - wsgiref == 0.1.2 11:46:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:46:44 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')]} 11:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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')]} 11:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:44 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 11:46:44 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 11:46:44 INFO - Using env: {'DISPLAY': ':0', 11:46:44 INFO - 'HOME': '/home/cltbld', 11:46:44 INFO - 'LANG': 'en_US.UTF-8', 11:46:44 INFO - 'LANGUAGE': 'en_US:en', 11:46:44 INFO - 'LOGNAME': 'cltbld', 11:46:44 INFO - 'MAIL': '/var/mail/cltbld', 11:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:44 INFO - 'MOZ_NO_REMOTE': '1', 11:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:44 INFO - 'NO_EM_RESTART': '1', 11:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:44 INFO - 'PWD': '/builds/slave/test', 11:46:44 INFO - 'SHELL': '/bin/bash', 11:46:44 INFO - 'SHLVL': '1', 11:46:44 INFO - 'TERM': 'linux', 11:46:44 INFO - 'TMOUT': '86400', 11:46:44 INFO - 'USER': 'cltbld', 11:46:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:44 INFO - '_': '/tools/buildbot/bin/python'} 11:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 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)) 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:46:44 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')]} 11:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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')]} 11:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:44 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 0x205e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x231f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, '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': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', '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 11:46:44 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 11:46:44 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 11:46:44 INFO - Using env: {'DISPLAY': ':0', 11:46:44 INFO - 'HOME': '/home/cltbld', 11:46:44 INFO - 'LANG': 'en_US.UTF-8', 11:46:44 INFO - 'LANGUAGE': 'en_US:en', 11:46:44 INFO - 'LOGNAME': 'cltbld', 11:46:44 INFO - 'MAIL': '/var/mail/cltbld', 11:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:44 INFO - 'MOZ_NO_REMOTE': '1', 11:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:44 INFO - 'NO_EM_RESTART': '1', 11:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:44 INFO - 'PWD': '/builds/slave/test', 11:46:44 INFO - 'SHELL': '/bin/bash', 11:46:44 INFO - 'SHLVL': '1', 11:46:44 INFO - 'TERM': 'linux', 11:46:44 INFO - 'TMOUT': '86400', 11:46:44 INFO - 'USER': 'cltbld', 11:46:44 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:44 INFO - '_': '/tools/buildbot/bin/python'} 11:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:46:44 INFO - Cleaning up... 11:46:44 INFO - Return code: 0 11:46:44 INFO - Running post-action listener: _resource_record_post_action 11:46:44 INFO - Running post-action listener: _start_resource_monitoring 11:46:44 INFO - Starting resource monitoring. 11:46:44 INFO - ##### 11:46:44 INFO - ##### Finished create-virtualenv step (success) 11:46:45 INFO - ##### 11:46:45 INFO - ##### 11:46:45 INFO - ##### Running install step. 11:46:45 INFO - ##### 11:46:45 INFO - Running pre-action listener: _resource_record_pre_action 11:46:45 INFO - Running main action method: install 11:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:46:45 INFO - Reading from file tmpfile_stdout 11:46:45 INFO - Detecting whether we're running mozinstall >=1.0... 11:46:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:46:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:46:45 INFO - Reading from file tmpfile_stdout 11:46:45 INFO - Output received: 11:46:45 INFO - Usage: mozinstall [options] installer 11:46:45 INFO - Options: 11:46:45 INFO - -h, --help show this help message and exit 11:46:45 INFO - -d DEST, --destination=DEST 11:46:45 INFO - Directory to install application into. [default: 11:46:45 INFO - "/builds/slave/test"] 11:46:45 INFO - --app=APP Application being installed. [default: firefox] 11:46:45 INFO - mkdir: /builds/slave/test/build/application 11:46:45 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'] 11:46:45 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 11:47:01 INFO - Reading from file tmpfile_stdout 11:47:01 INFO - Output received: 11:47:01 INFO - /builds/slave/test/build/application/firefox/firefox 11:47:01 INFO - Running post-action listener: _resource_record_post_action 11:47:01 INFO - ##### 11:47:01 INFO - ##### Finished install step (success) 11:47:01 INFO - ##### 11:47:01 INFO - ##### 11:47:01 INFO - ##### Running run-tests step. 11:47:01 INFO - ##### 11:47:01 INFO - Running pre-action listener: _resource_record_pre_action 11:47:01 INFO - Running main action method: run_tests 11:47:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:01 INFO - Python 2.7.3 11:47:01 INFO - Return code: 0 11:47:01 INFO - grabbing minidump binary from tooltool 11:47:01 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')]} 11:47:01 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 0x231d3b0>, '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 0x231e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x231e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:01 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 11:47:01 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 11:47:01 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 11:47:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:01 INFO - Return code: 0 11:47:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:47:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:47:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:01 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/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:47:01 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/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --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 11:47:01 INFO - Using env: {'DISPLAY': ':0', 11:47:01 INFO - 'HOME': '/home/cltbld', 11:47:01 INFO - 'LANG': 'en_US.UTF-8', 11:47:01 INFO - 'LANGUAGE': 'en_US:en', 11:47:01 INFO - 'LOGNAME': 'cltbld', 11:47:01 INFO - 'MAIL': '/var/mail/cltbld', 11:47:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:01 INFO - 'MOZ_NO_REMOTE': '1', 11:47:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:01 INFO - 'NO_EM_RESTART': '1', 11:47:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:01 INFO - 'PWD': '/builds/slave/test', 11:47:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:01 INFO - 'SHELL': '/bin/bash', 11:47:01 INFO - 'SHLVL': '1', 11:47:01 INFO - 'TERM': 'linux', 11:47:01 INFO - 'TMOUT': '86400', 11:47:01 INFO - 'USER': 'cltbld', 11:47:01 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421', 11:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:01 INFO - '_': '/tools/buildbot/bin/python'} 11:47:01 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/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--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 11:47:01 INFO - mozversion application_buildid: 20160705104225 11:47:01 INFO - mozversion application_changeset: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 11:47:01 INFO - mozversion application_display_name: Nightly 11:47:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:01 INFO - mozversion application_name: Firefox 11:47:01 INFO - mozversion application_remotingname: firefox 11:47:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:47:01 INFO - mozversion application_vendor: Mozilla 11:47:01 INFO - mozversion application_version: 50.0a1 11:47:01 INFO - mozversion platform_buildid: 20160705104225 11:47:01 INFO - mozversion platform_changeset: 3db27bf874fa9e5057b7bcb96f325699bb7f1688 11:47:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:47:01 INFO - mozversion platform_version: 50.0a1 11:47:01 INFO - using testdate: 1467744421 11:47:01 INFO - actual date: 1467744421 11:47:01 INFO - starting webserver on 'localhost:41568' 11:47:01 INFO - SUITE-START | Running 2 tests 11:47:01 INFO - TEST-START | dromaeo_css 11:47:01 INFO - operating with platform_type : linux_ 11:47:01 INFO - Initialising browser for dromaeo_css test... 11:47:01 INFO - TEST-INFO | started process 31763 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8bgWwI/profile http://localhost:41568/getInfo.html) 11:47:06 INFO - PROCESS | 31763 | __metrics Screen width/height:1600/1200 11:47:06 INFO - PROCESS | 31763 | colorDepth:24 11:47:06 INFO - PROCESS | 31763 | Browser inner width/height: 1024/697 11:47:06 INFO - PROCESS | 31763 | __metrics 11:47:07 INFO - PROCESS | 31763 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:47:08 INFO - TEST-INFO | 31763: exit 0 11:47:08 INFO - Browser initialized. 11:47:08 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:08 INFO - TEST-INFO | started process 31842 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8bgWwI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:20 INFO - PROCESS | 31842 | RSS: Main: 158412800 11:47:20 INFO - PROCESS | 31842 | 11:48:10 INFO - PROCESS | 31842 | 1467744490842 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] 11:50:24 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41568/tests/dromaeo/cssquery-ext.html) 11:50:25 INFO - PROCESS | 31842 | RSS: Main: 255074304 11:50:25 INFO - PROCESS | 31842 | 11:53:28 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-ext.html (next: http://localhost:41568/tests/dromaeo/cssquery-jquery.html) 11:53:28 INFO - PROCESS | 31842 | RSS: Main: 248115200 11:53:28 INFO - PROCESS | 31842 | 11:56:30 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41568/tests/dromaeo/cssquery-mootools.html) 11:56:31 INFO - PROCESS | 31842 | RSS: Main: 246669312 11:56:31 INFO - PROCESS | 31842 | 11:59:33 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41568/tests/dromaeo/cssquery-prototype.html) 11:59:34 INFO - PROCESS | 31842 | RSS: Main: 237903872 11:59:34 INFO - PROCESS | 31842 | 12:02:37 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41568/tests/dromaeo/cssquery-yui.html) 12:02:38 INFO - PROCESS | 31842 | RSS: Main: 215556096 12:02:38 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | Cycle 1(1): loaded http://localhost:41568/tests/dromaeo/cssquery-yui.html (next: http://localhost:41568/tests/dromaeo/cssquery-dojo.html) 12:05:41 INFO - PROCESS | 31842 | RSS: Main: 274288640 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | __start_tp_report 12:05:41 INFO - PROCESS | 31842 | _x_x_mozilla_page_load 12:05:41 INFO - PROCESS | 31842 | _x_x_mozilla_page_load_details 12:05:41 INFO - PROCESS | 31842 | |i|pagename|runs| 12:05:41 INFO - PROCESS | 31842 | |0;dojo.html;2568.5376632206203;2603.153974958139;2615.411532405209;2616.751408616181;2618.4632150409157;4642.814287428499;4643.326717625942;4665.580097791202;4686.343911852344;4703.035877645083;4700.717956922587;4757.04859028194;4774.045190961813;4785.449673287573;4789.856304310868;4265.658747300224;4305.526392096866;4349.195398851207;4368.148211098829;4409.360642706805;4350.891227719317;4405;4431.091626216617;4480;4520.5253448387775;4418.756968366739;4463.776811159445;4470.463544374663;4477.888052798689;4512.435945506812;4248.830046798124;4300.22595932732;4312.28847240205;4341.261985462479;4357.912841743179;4275.337322714984;4275.700700950934;4281.571842815724;4324.481062272516;4437.445319335083;4705.6470764692785;4714.080754252922;4756.167670657621;4770.856874293777;4774.546418090275;4851.539103785135;5016.799328026875;5040.84877453677;5070.822521211777;5089.440161582223;5087.821926232564;5176.275321454999;5177.663451875616;5179.119549676564;5180.041692286902;4787.473377928425;4790.161721698723;4795.328653988445;4814.614830813526;4818.566329030404;4961.206207006861;5109.284700141983;5209.453007434165;5235.110031294689;5265.104932161542;5036.571891389273;5056.342675452168;5063.594912406998;5067.467915868854;5073.213651883964;5089.796408143633;5095.1847704367865;5102.285680004802;5103.413107492612;5134.15286477727;4884.340614017134;4897.755112244374;4917.188663870421;4963.429205641398;5095.133827249377;4925.359703238556;4933.062718083553;4963.751812409365;4968.925466118011;4986.576141027981;4172.520160181618;4172.77049762266;4174.812133454002;4202.915941681149;4215.557366476537;3696.075981004749;3698.6856117230336;3699.7780133192095;3702.9259414811554;3751.6248375162813;4286.7856607169515;4344.522102568715;4351.760653164043;4353.891152721208;4358.56414358568;5128.461511541309;5137.51193636604;5139.331886854685;5149.613778966593;5169.172932330809;4203.327467605169;4284.635805956528;4344.4352234209355;4351;4397.9560204398185;4564.657650676212;4572.5092067283895;4594.104149690778;4600.95399046012;4647.55848194421;4847.127517046824;4850.223964165858;4857.0528746894015;4881.975590121956;4898.118338699069;5008;5049.596032317332;5099.515546023122;5122.462141475092;5137.152369858932;4818.132736107535;4848.539388758062;4853.296272040464;4877.024595080927;4877.609791216623;5018.698878067327;5032.924506132485;5040.773165207501;5054.721990290569;5057.039162559102;4956.405231372259;5066.493350664904;5110.361204849394;5125.5899528036925;5179.015986962465;4967.3542439482635;4983.70097794119;5002.924956125588;5003.624728145331;5039.042581909425;4977.552020318189;4992.176290911959;4995.400551933792;5002.449730529566;5046.798128074836;4739.620830333496;4864.124457597666;4868.2940973557925;4873.171560834596;4986.426560945538;4990.301357809982;5029.798808047637;5036.597072234285;5038.697678139323;5072.365954255718;4701.882452938704;4909.214525675875;4920.827771027997;4922.876928076684;4923.458419573915 12:05:41 INFO - PROCESS | 31842 | |1;ext.html;571.5570432914492;579.4118969246216;581.8080033588916;595.3272801734041;599.9310079340877;27729.722702772968;39579.80210098949;41842.372364414485;41866.76665416823;44845.7757711211;42173.367399489034;42656.57343426565;42792.786036069854;42850.35724464135;42918.78540607292;7813.062432508093;7945.801354966115;7957.72147974821;7957.920420795805;7958.36333093354;7792.805179870492;7870.724524641639;7880.211978802131;7885.172056934025;7886.80282992924;7860.253275938777;7905.051393832719;7905.802354941144;7911.960440197791;7912.446128770988;7851.882221766678;7886.09309929354;7895.289423951815;7895.289423951815;7899.407544434133;7767.844643107106;7861.371090312761;7871.606419678993;7873.133955264973;7873.173316801711;39645;39992;40012.59987400118;40021.39967900484;40022.19955600901;3000.5499175123905;3014.0053782252025;3025.2739342557848;3083.9074827755203;3101.5347697845505;30000.849995749883;30130.54804177939;30404.632934774425;31307.686923130706;31630.841845790856;3447.827608619584;3520.489529018278;3551.396262635358;3565.16218688608;3572.0534058474527;229415;265500;265609;266553;266754.9999999981;53158.20262696063;53497.73251133719;53589.46410535923;53706.7314663432;53820.73089634605;32691.67308326934;33744.325113497594;33750.15624609405;35473.290534189175;35521.46717799235;15377.308021139075;15554.22228888551;15555.688886222211;15575.610609734847;15609.765853512206;11791.646250612324;11870.34713090771;11898.345590992578;11921.165518413802;11952.64142075739;18343.54141146482;18496.075196240134;18547.44357669272;18609.906950465433;18611.90694046521;6755.695993680296;6820.0903746950935;6852.246252912176;6927.016965244904;7054.294570542905;838.7022606974558;874.6457684637732;887.8845750052452;891.7280229530055;981.651513712636;25950.87024564865;27314.863425683143;27445;27612.171634850583;27732;919.5632074764434;973.4986481961795;997.3175938966627;1021.3157184686278;1031.5461197073264;14642.194679292741;14811.25943702832;15046.774298385533;15076.24618769057;15125.470608528869;384081;384505;384687;385621;386433;49861.750691246314;50274.74862625664;50485.495145048815;50541;50622.49377506252;1079.422508957704;1151.2977083978767;1186.8041773107514;1224.3878060969337;1231.0459393969745;27587.586186207624;28745;28808.135755927357;29175.270618234714;29266.70733292725;41295;42261.15477690491;42375.36436953386;42462.78768606137;42485.36271955985;300029;300144;303711;303974;304194;21879.67180492326;23973.52052958896;24655.753442465346;25145.87427062853;25458.490830183662;40620.59379406168;41282.38076428916;41774;42130.578694212665;42908.141837163705;36296.81851590831;36637.81681091578;36959.815200923826;37028;37442.43836342511;35843.28313433769;36859;37466.43800342942;37626.81186594049;38056.23887522179;35642.821785890905;35728.64271357253;35944.101397465274;36210.8189459051;36833.26333473262;32531.674683252866;32724.686974769666;33177.50233746447;33557.496637549964;33623.32753344969;24906.871681064855;25052.749472505042;25227.873860630578;25538.489230215662;25694.229173124837 12:05:41 INFO - PROCESS | 31842 | |2;jquery.html;369.0920335973505;373.2832960715426;375.38999126419566;381.25084209528274;384.9480320156778;16336.26486808095;17284.740728889075;18125.456236312897;18162.455126346198;18212.81787182131;10976.670699879016;16256;17111.486655400357;17113;17490.68819838514;4571.725696458215;4719.339292499053;4757.3815403997605;4759.881002974936;4763.976180119112;3474.5656792900886;3644.4533320001947;4657.6273898088075;5237.528622423981;5534.114541673333;5573.665580065189;5575.888482230353;5613.9157912631135;5623.550115990732;5629.60592758507;5114.590832733391;5449.754761035743;5452.863678408032;5454.372747134091;5559.416261292567;3433.9141521461916;4935.407751069859;5248.816291429782;5248.8687782805355;5305.814296499604;12522.74954500914;12541.623751287476;12620.81068783969;12752.043596730282;12859.742805143938;1698.583846957491;1842.3551756884983;1885.066891888524;1957.921683132673;1997.7203191553194;9350.438973661601;9618.567164477545;9625.855612165824;11132.16508761838;14020.088694234842;1754.456118603237;1754.7192449208064;1794.921323605891;1816.8637352198639;1871.737956686065;65123.67438162826;70323.64838175828;70623;71135.64432177857;72560.27439725536;10163.237757168243;10215.693529194135;10270.127039201752;10493.9475302623;10528.894711052944;14386.28068596566;14486.492972745904;14487.78268325976;14506.637334066521;14517.854821451861;7315;7396.0754905636795;7400.48196626231;7714.190010048977;7772.727954521564;7199.568025918462;7207.423406127497;7292.088488938883;7311.561306321638;7639.541627502367;4418.9337159942625;4434.55654434554;4499.460064792181;4501.504834468205;4556.908861822745;1629.7066528024832;1661.3935913391767;1764.6911790436623;1846.6583682018602;1953.326102494637;832.7918020494876;853.2832420766462;897.7979954510314;915.6291701860757;921.5254144115786;17225.1387430628;17742.467725968243;17943.85621762938;18093.36673216431;18302.54243643893;855.576489637621;862.3058437957379;890.8084761776249;901.4816480523725;929.9767505812409;9790.461524616072;10130.848037279447;10190.184785217165;10227.846582301272;10300.690979270634;373032;376168;376802;382686;388508;73224.63387683028;77596.61201693956;77981.61009195031;78513.60743196247;78704;931.0456781798711;931.6413180925392;931.8043210925781;957.2198658093631;957.8706874571983;15602;15783.368665253261;15806.60483487876;15869.2858821351;16136.838631613533;36924.261514769016;37057.81471092627;37515.81242093772;37706.62293377031;38141.237175256894;50595.2410713847;50752.74623627006;51101.74449127879;54862;55187.44812551823;7845.725399610987;7895.960520197362;8049.83900322002;8052.355811535181;8062.798430039296;11558.47986840611;11697.181197316446;12105;12337.629871103882;12947;4763;5239.711815850165;8382.413231073766;10068.798624027624;11049.337039777318;10451.320664156805;10596.523156458132;10723.571057157626;10726.839097413702;10815.35107893529;10491.213159013258;10725.249232553646;10916;10923.453827308762;10990.725231869268;7890.802729931568;7908;7993.8401231976195;8149.103598604267;8153.388495862952;9545.952270238604;10437.11284540792;10529.262951593315;10781.892181078088;10797.568097276335 12:05:41 INFO - PROCESS | 31842 | |3;mootools.html;1367.80166875803;1388.1532265318158;1463.963400914977;1635.8773092018087;1663.3014134063692;6668.466522678186;6934.687939042743;7378.704851805928;7915.129335773067;7916.129225785166;7333.926660733391;7611;7612.314891659749;7735.30382265596;7827.530348179099;2177.314146043995;2199.351191398533;2201.9449513762206;2204.184451752854;2205.2171479124922;1835.8531317494635;1914.5787926656183;1917.2714368540005;1924.5284905198246;2172.6523756199012;2096.433962830035;2200.2959053103014;2201.6917631531596;2203.9449013774624;2205.3935167828895;2159.2334721173916;2181.7163768710047;2187.6937228787983;2188.037263604017;2210.9005094770773;1818.8544916406656;2107.79975902289;2156.8490205685607;2161.945951351213;2163.0374483354913;7780.299773020455;7844.058712954482;7849.921500784976;7854.842903141962;7857.921420785776;4470.9105817883465;4593.885152871171;4596.54034596541;4597.103564804865;4600.148972440076;2806.677232118312;2830.306574889145;2889.061055157061;2896.406236721467;2908.2729317670583;924.8612708093773;926.6988228825659;938.9483578403185;942.472215559289;947.166493485735;10524.421156836372;10535.73660658482;10540.841887371696;10569.947150264275;10575.36547807134;3964.5440774310746;4078.7348822326453;4170.35359519275;4173.10278290163;4196.3705444183615;8987.281017518713;9050.818983620291;9066.501342426098;9078.86381704275;9078.954605226932;4601.539846015372;4608.861734147981;4612.723236605747;4618.976905115453;4621.4223222097235;4157.355609880413;4233.153369326147;4233.5554766749665;4234.6188843003665;4264.488261408589;3339.415602269593;3472.5659292588425;3478.756487045933;3674.356987527172;3785.0537365658583;1081.3187691754144;1109.5339957217989;1111.3165403276926;1192.1059205595802;1195.6472840511897;692.6225207262054;768.1435199752236;773.7601343583507;792.397777688949;806.8668669669439;5074.112030394666;5199.896002080013;5291.576673866081;5326.7869285228935;5381.434949330264;814.3159745813545;842.5155535567073;858.6479543387181;865.3466632692277;900.2797761790541;3504.491848681927;3583.229605634749;3596.6223546527763;3605.6394360563736;3684.2263124743567;9260.722178334661;9553.04469553053;9591.568379422943;9625.133737963477;9666.323357365058;9535.2371810255;9557.808843823084;9584.37701549397;9610.615575377047;9629.229661627052;7209.134903811576;7283.635818209068;7400.925990740131;7408.0369551958975;7412.221716719775;5113.53978141969;5126.512981266774;5130.51260130287;5247.632665713363;5307.548858347083;8498.065212826461;8781.692640757543;8829.293656507592;8855.822883542422;8975.2371048459;8733.08302628215;9045;9067.319951003568;9225.630974760934;9234.1689247968;6656.267810540933;6721.630310332978;6741.561798483083;6826.93173068263;6896.4827637926355;7443.627818609156;7459.36595389398;7501.324880760758;7521.736739214101;7538.321551060211;6801.8639627206185;6848.288677096374;6938.965305173442;6980.057692211486;7020.403265722266;6848.220261940743;6879.759208427681;6888.690008949509;6933.791986240421;6981.3367730065565;6215.378462153749;6318.589291696025;6375.521835862236;6385.521085918667;6394.26465956421;4177.498700156001;4183.309753890574;4223.97888010558;4230.302000169938;4249.851255206053;4245.172191422766;4252.978735106305;4282.528921818535;4292.399064130962;4466.553344665507 12:05:41 INFO - PROCESS | 31842 | |4;prototype.html;296.9272528230584;300.62722224441694;303.57954233386755;305.75692324601965;308.63889249578;4822.276658501227;4847.321375007502;4861.368022157119;4867.464578896319;4867.732274724893;4811.446683631383;4819.951520603739;4820.325154478376;4825.662203645747;4843.58829499493;3632.527771389716;3745.6515654364407;3772.77363358198;3845.4039623858207;3854.8265328060306;3774.792386418746;3823.483829682985;3827.827747751358;3841.0973421245985;3841.42378643203;3785.9621403786023;3803.885883423488;3803.9429408558753;3808.6953043756434;3819.236152769457;3627.7097832173495;3700.463432802242;3795.7912314822674;3796.373598356268;3814.7138964577766;3366.3267346530793;3370.865165393381;3372.4941258811373;3379.729621630264;3381.0871064812363;4647.628189744846;4653.348531205634;4658.697184682985;4662.347271382009;4718.905621887578;4191.937120943157;4293.613574778254;4321.962728945062;4325.978370108161;4354.325079612665;4938.259261110827;4947.307376967227;4964.60283177345;4973.975130124326;4987.376577927759;3667.1198912260866;3703.7037037037244;3704.3517384457614;3707.4994875691978;3713.3687273163628;5087.364079490064;5217.200065977232;5234.528892399702;5279.208118782175;5281.656692315026;3764.435334699817;3766.8681596144;3769.6230376962085;3801.2777572261184;3806.8960001599226;3846.288436639231;3856.749311294757;3858.054776579756;3862.208247309295;3865.1110244643887;4329.718568293051;4335.1979883721615;4337.934930976038;4341.630961368319;4350.564943505624;4828.275758636232;4999.3000979862845;5006.1739812930455;5011.824586139468;5017.774200161001;1315.3620494060374;1319.070055610792;1319.346923272986;1328.63150954517;1329.268902103839;844.6114787197835;853.8078932240196;862.4178679391385;874.5583480342386;875.5534677314615;4249.936250956238;4363.127374525107;4373.781310934504;4375.431193944767;4379.802908869108;5123.231515272739;5124.564412024945;5129.589632829365;5143.8199663012365;5156.845294641167;4308.4399028126145;4365.869023929287;4369.344598310216;4376.956230437719;4384.210842048462;2584.3280747005915;2727.2500062482977;2752.2844060544003;2753.187809596174;2754.1737478756695;4868.44603439484;4880.585150262267;4887.462379138292;4911.557959783565;4917.950820491749;5034.748262586929;5280.947190528045;5288.153895376721;5288.8413347599635;5299.44355842631;4843;4872.829450969199;4878.926816097762;4887.7556122194455;4891.144049791344;5101.367562380003;5132.204508301219;5138.820141295037;5139.794408223629;5157.819476318311;4832.806687732451;5027.497250274943;5046.268291097844;5053.69677819332;5073.11220536412;4916.8770780730765;4918.852434426973;4938.950610493849;4942.308076869169;4947.2579113133315;3691.870784522529;3712.9443058354686;3722.3671975763646;3736.271427071695;3742.2702572998005;5002.8498500730475;5181.974090129525;5193.246979187921;5229.320188375486;5238.895222095613;5050.72221027847;5058.241263810458;5069.112905241494;5080.974595127001;5097.719625420637;5028.773705183348;5046.243063540498;5080.898382032413;5081.263216833465;5085.186370180753;4729.125111854318;5010.49895010496;5014.6991180529285;5016.899662006813;5031.069252188357;4849.830255941025;4946.727929963887;5088.389393272683;5113.718745469035;5132.178851383761;4974.850754477371;4980.800767969241;4985.6011519077665;5000.2499625056535;5037.848864534069 12:05:41 INFO - PROCESS | 31842 | |5;yui.html;645.0807599171183;647.8542327976204;691.8028361916855;692.6848284030766;744.5086243079569;12524.436400361983;13152.276624785633;13523.661908452294;13551.322433878317;13877.791833122512;13183.472661093545;13218.603441896734;13370.398332075056;13381.197128172316;13390.196588204715;621.1459243540132;749.5277974875847;784.5371230973724;792;800.2837460472873;798.7763426240633;800.2597597222575;801.6112185589984;805.1706742055662;805.4844899264475;834.7203686764941;835.2774849754949;835.9582020898961;836.8870202522672;837;647.3073811022232;797.5414136871265;821.9013718353776;825.6821123867294;831.6673330667721;603.1013789453726;603.5684485592778;603.9456448919574;604.1179877379031;604.2115039872964;12735.490580376774;12758.553450629277;12762.23426594398;12764.936175319064;12774.23354598727;12665.366731663473;12973.740525189538;13039.282839443827;13071.092395343077;13464.663383415394;11643.417829108595;11701.3564253966;11751.823722644167;11919.821202681967;12171.573994910135;3869.0771828747224;3895.220955808821;3939.4484772131636;4031.072853243741;4073.816678249486;61889.690551547406;61981.38018619801;62117.68941155265;62194;62216.37783622151;9772.853407198898;10296.124829389437;10600.04599586041;10701.571937122428;10711.78576428467;17255;18629.068546572616;18646.53383665419;18653.253869845325;18666.346677866208;6637.137172167587;6652.70062847173;6793.116894803644;6817.625030623264;6997.755078572225;3728.4780130781714;3748.269087527906;3771.396576547739;3776.584575696671;4013.979930100331;2938.441696077781;3071.938561228763;3073.646530649004;3074.8923787667322;3076.661567227603;529.4202847881563;535.1277417809024;537.502809900848;540.6404740847371;549.1076999875203;443.93562933374477;468.35367193273066;519.3404376441973;539.8542393553719;550.7163810637525;7118.572885626879;7250.3112204340505;7583;7636.923630763732;7659.234076592296;496.0946273051623;503.22754571732946;520.9400918894376;534.4735435595935;537.6532136771839;3291.53918451417;3462.2036931505895;3499.2126771476214;3530.0821786335737;3599.4420864766003;89008.5549572248;92186;93471.06528934624;93741.5312923431;95740.52129739306;82974.58512707398;83505.58247208847;84054;84800;84930;72738;73325;73806;74603.62698186474;75459.24540754632;6864.107666003388;6899.551529150589;7012.7545535906;7040.190378106583;7071.434285257064;43924.780376097915;44867.775661121486;44927.550724492336;44933;45395.54604453913;63254.683726581075;65264.67367663131;65682;65816;65979.67010164919;9264.11990860867;9369.109934556207;9482.620695172116;9489.383190092622;9571.856422153813;9974.20206383502;10235.795284094425;10410.115140213167;10507.159427245955;12379.75240495203;10989.560417583207;11222.55109795599;11741;11945.641630751092;12870.292133932724;12511.499540018662;12753.74492510126;12804.487820487077;12998.415071322002;13077.803832942323;12113.15207935436;12276.324802135969;12293.139480236297;12440.937795310965;12527.624171274876;8749.518776467356;9287.582058807506;9838.803223935623;9990.750231244278;10148.985101489792;9720.902790972283;10029.297949143782;10066.194704423775;10101.44442055694;10104.646337378157 12:05:41 INFO - PROCESS | 31842 | __end_tp_report 12:05:41 INFO - PROCESS | 31842 | __start_cc_report 12:05:41 INFO - PROCESS | 31842 | _x_x_mozilla_cycle_collect,981 12:05:41 INFO - PROCESS | 31842 | __end_cc_report 12:05:41 INFO - PROCESS | 31842 | __startTimestamp1467745541469__endTimestamp 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | ------- Summary: start ------- 12:05:41 INFO - PROCESS | 31842 | Number of tests: 6 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#0] dojo.html Cycles:165 Average:4692.82 Median:4853.30 stddev:509.49 (10.5%) stddev-sans-first:483.03 12:05:41 INFO - PROCESS | 31842 | Values: 2568.5 2603.2 2615.4 2616.8 2618.5 4642.8 4643.3 4665.6 4686.3 4703.0 4700.7 4757.0 4774.0 4785.4 4789.9 4265.7 4305.5 4349.2 4368.1 4409.4 4350.9 4405.0 4431.1 4480.0 4520.5 4418.8 4463.8 4470.5 4477.9 4512.4 4248.8 4300.2 4312.3 4341.3 4357.9 4275.3 4275.7 4281.6 4324.5 4437.4 4705.6 4714.1 4756.2 4770.9 4774.5 4851.5 5016.8 5040.8 5070.8 5089.4 5087.8 5176.3 5177.7 5179.1 5180.0 4787.5 4790.2 4795.3 4814.6 4818.6 4961.2 5109.3 5209.5 5235.1 5265.1 5036.6 5056.3 5063.6 5067.5 5073.2 5089.8 5095.2 5102.3 5103.4 5134.2 4884.3 4897.8 4917.2 4963.4 5095.1 4925.4 4933.1 4963.8 4968.9 4986.6 4172.5 4172.8 4174.8 4202.9 4215.6 3696.1 3698.7 3699.8 3702.9 3751.6 4286.8 4344.5 4351.8 4353.9 4358.6 5128.5 5137.5 5139.3 5149.6 5169.2 4203.3 4284.6 4344.4 4351.0 4398.0 4564.7 4572.5 4594.1 4601.0 4647.6 4847.1 4850.2 4857.1 4882.0 4898.1 5008.0 5049.6 5099.5 5122.5 5137.2 4818.1 4848.5 4853.3 4877.0 4877.6 5018.7 5032.9 5040.8 5054.7 5057.0 4956.4 5066.5 5110.4 5125.6 5179.0 4967.4 4983.7 5002.9 5003.6 5039.0 4977.6 4992.2 4995.4 5002.4 5046.8 4739.6 4864.1 4868.3 4873.2 4986.4 4990.3 5029.8 5036.6 5038.7 5072.4 4701.9 4909.2 4920.8 4922.9 4923.5 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#1] ext.html Cycles:180 Average:46857.66 Median:36846.13 stddev:84092.23 (228.2%) stddev-sans-first:84256.32 12:05:41 INFO - PROCESS | 31842 | Values: 571.6 579.4 581.8 595.3 599.9 27729.7 39579.8 41842.4 41866.8 44845.8 42173.4 42656.6 42792.8 42850.4 42918.8 7813.1 7945.8 7957.7 7957.9 7958.4 7792.8 7870.7 7880.2 7885.2 7886.8 7860.3 7905.1 7905.8 7912.0 7912.4 7851.9 7886.1 7895.3 7895.3 7899.4 7767.8 7861.4 7871.6 7873.1 7873.2 39645.0 39992.0 40012.6 40021.4 40022.2 3000.5 3014.0 3025.3 3083.9 3101.5 30000.8 30130.5 30404.6 31307.7 31630.8 3447.8 3520.5 3551.4 3565.2 3572.1 229415.0 265500.0 265609.0 266553.0 266755.0 53158.2 53497.7 53589.5 53706.7 53820.7 32691.7 33744.3 33750.2 35473.3 35521.5 15377.3 15554.2 15555.7 15575.6 15609.8 11791.6 11870.3 11898.3 11921.2 11952.6 18343.5 18496.1 18547.4 18609.9 18611.9 6755.7 6820.1 6852.2 6927.0 7054.3 838.7 874.6 887.9 891.7 981.7 25950.9 27314.9 27445.0 27612.2 27732.0 919.6 973.5 997.3 1021.3 1031.5 14642.2 14811.3 15046.8 15076.2 15125.5 384081.0 384505.0 384687.0 385621.0 386433.0 49861.8 50274.7 50485.5 50541.0 50622.5 1079.4 1151.3 1186.8 1224.4 1231.0 27587.6 28745.0 28808.1 29175.3 29266.7 41295.0 42261.2 42375.4 42462.8 42485.4 300029.0 300144.0 303711.0 303974.0 304194.0 21879.7 23973.5 24655.8 25145.9 25458.5 40620.6 41282.4 41774.0 42130.6 42908.1 36296.8 36637.8 36959.8 37028.0 37442.4 35843.3 36859.0 37466.4 37626.8 38056.2 35642.8 35728.6 35944.1 36210.8 36833.3 32531.7 32724.7 33177.5 33557.5 33623.3 24906.9 25052.7 25227.9 25538.5 25694.2 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#2] jquery.html Cycles:180 Average:23969.07 Median:19261.24 stddev:62788.90 (326.0%) stddev-sans-first:62940.04 12:05:41 INFO - PROCESS | 31842 | Values: 369.1 373.3 375.4 381.3 384.9 16336.3 17284.7 18125.5 18162.5 18212.8 10976.7 16256.0 17111.5 17113.0 17490.7 4571.7 4719.3 4757.4 4759.9 4764.0 3474.6 3644.5 4657.6 5237.5 5534.1 5573.7 5575.9 5613.9 5623.6 5629.6 5114.6 5449.8 5452.9 5454.4 5559.4 3433.9 4935.4 5248.8 5248.9 5305.8 12522.7 12541.6 12620.8 12752.0 12859.7 1698.6 1842.4 1885.1 1957.9 1997.7 9350.4 9618.6 9625.9 11132.2 14020.1 1754.5 1754.7 1794.9 1816.9 1871.7 65123.7 70323.6 70623.0 71135.6 72560.3 10163.2 10215.7 10270.1 10493.9 10528.9 14386.3 14486.5 14487.8 14506.6 14517.9 7315.0 7396.1 7400.5 7714.2 7772.7 7199.6 7207.4 7292.1 7311.6 7639.5 4418.9 4434.6 4499.5 4501.5 4556.9 1629.7 1661.4 1764.7 1846.7 1953.3 832.8 853.3 897.8 915.6 921.5 17225.1 17742.5 17943.9 18093.4 18302.5 855.6 862.3 890.8 901.5 930.0 9790.5 10130.8 10190.2 10227.8 10300.7 373032.0 376168.0 376802.0 382686.0 388508.0 73224.6 77596.6 77981.6 78513.6 78704.0 931.0 931.6 931.8 957.2 957.9 15602.0 15783.4 15806.6 15869.3 16136.8 36924.3 37057.8 37515.8 37706.6 38141.2 50595.2 50752.7 51101.7 54862.0 55187.4 7845.7 7896.0 8049.8 8052.4 8062.8 11558.5 11697.2 12105.0 12337.6 12947.0 4763.0 5239.7 8382.4 10068.8 11049.3 10451.3 10596.5 10723.6 10726.8 10815.4 10491.2 10725.2 10916.0 10923.5 10990.7 7890.8 7908.0 7993.8 8149.1 8153.4 9546.0 10437.1 10529.3 10781.9 10797.6 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#3] mootools.html Cycles:180 Average:5096.16 Median:5269.60 stddev:2875.98 (54.6%) stddev-sans-first:2870.40 12:05:41 INFO - PROCESS | 31842 | Values: 1367.8 1388.2 1464.0 1635.9 1663.3 6668.5 6934.7 7378.7 7915.1 7916.1 7333.9 7611.0 7612.3 7735.3 7827.5 2177.3 2199.4 2201.9 2204.2 2205.2 1835.9 1914.6 1917.3 1924.5 2172.7 2096.4 2200.3 2201.7 2203.9 2205.4 2159.2 2181.7 2187.7 2188.0 2210.9 1818.9 2107.8 2156.8 2161.9 2163.0 7780.3 7844.1 7849.9 7854.8 7857.9 4470.9 4593.9 4596.5 4597.1 4600.1 2806.7 2830.3 2889.1 2896.4 2908.3 924.9 926.7 938.9 942.5 947.2 10524.4 10535.7 10540.8 10569.9 10575.4 3964.5 4078.7 4170.4 4173.1 4196.4 8987.3 9050.8 9066.5 9078.9 9079.0 4601.5 4608.9 4612.7 4619.0 4621.4 4157.4 4233.2 4233.6 4234.6 4264.5 3339.4 3472.6 3478.8 3674.4 3785.1 1081.3 1109.5 1111.3 1192.1 1195.6 692.6 768.1 773.8 792.4 806.9 5074.1 5199.9 5291.6 5326.8 5381.4 814.3 842.5 858.6 865.3 900.3 3504.5 3583.2 3596.6 3605.6 3684.2 9260.7 9553.0 9591.6 9625.1 9666.3 9535.2 9557.8 9584.4 9610.6 9629.2 7209.1 7283.6 7400.9 7408.0 7412.2 5113.5 5126.5 5130.5 5247.6 5307.5 8498.1 8781.7 8829.3 8855.8 8975.2 8733.1 9045.0 9067.3 9225.6 9234.2 6656.3 6721.6 6741.6 6826.9 6896.5 7443.6 7459.4 7501.3 7521.7 7538.3 6801.9 6848.3 6939.0 6980.1 7020.4 6848.2 6879.8 6888.7 6933.8 6981.3 6215.4 6318.6 6375.5 6385.5 6394.3 4177.5 4183.3 4224.0 4230.3 4249.9 4245.2 4253.0 4282.5 4292.4 4466.6 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#4] prototype.html Cycles:180 Average:4198.02 Median:4826.97 stddev:1201.36 (24.9%) stddev-sans-first:1168.51 12:05:41 INFO - PROCESS | 31842 | Values: 296.9 300.6 303.6 305.8 308.6 4822.3 4847.3 4861.4 4867.5 4867.7 4811.4 4820.0 4820.3 4825.7 4843.6 3632.5 3745.7 3772.8 3845.4 3854.8 3774.8 3823.5 3827.8 3841.1 3841.4 3786.0 3803.9 3803.9 3808.7 3819.2 3627.7 3700.5 3795.8 3796.4 3814.7 3366.3 3370.9 3372.5 3379.7 3381.1 4647.6 4653.3 4658.7 4662.3 4718.9 4191.9 4293.6 4322.0 4326.0 4354.3 4938.3 4947.3 4964.6 4974.0 4987.4 3667.1 3703.7 3704.4 3707.5 3713.4 5087.4 5217.2 5234.5 5279.2 5281.7 3764.4 3766.9 3769.6 3801.3 3806.9 3846.3 3856.7 3858.1 3862.2 3865.1 4329.7 4335.2 4337.9 4341.6 4350.6 4828.3 4999.3 5006.2 5011.8 5017.8 1315.4 1319.1 1319.3 1328.6 1329.3 844.6 853.8 862.4 874.6 875.6 4249.9 4363.1 4373.8 4375.4 4379.8 5123.2 5124.6 5129.6 5143.8 5156.8 4308.4 4365.9 4369.3 4377.0 4384.2 2584.3 2727.3 2752.3 2753.2 2754.2 4868.4 4880.6 4887.5 4911.6 4918.0 5034.7 5280.9 5288.2 5288.8 5299.4 4843.0 4872.8 4878.9 4887.8 4891.1 5101.4 5132.2 5138.8 5139.8 5157.8 4832.8 5027.5 5046.3 5053.7 5073.1 4916.9 4918.9 4939.0 4942.3 4947.3 3691.9 3712.9 3722.4 3736.3 3742.3 5002.8 5182.0 5193.2 5229.3 5238.9 5050.7 5058.2 5069.1 5081.0 5097.7 5028.8 5046.2 5080.9 5081.3 5085.2 4729.1 5010.5 5014.7 5016.9 5031.1 4849.8 4946.7 5088.4 5113.7 5132.2 4974.9 4980.8 4985.6 5000.2 5037.8 12:05:41 INFO - PROCESS | 31842 | 12:05:41 INFO - PROCESS | 31842 | [#5] yui.html Cycles:180 Average:17616.61 Median:534.80 stddev:25034.52 (4681.1%) stddev-sans-first:25072.31 12:05:41 INFO - PROCESS | 31842 | Values: 645.1 647.9 691.8 692.7 744.5 12524.4 13152.3 13523.7 13551.3 13877.8 13183.5 13218.6 13370.4 13381.2 13390.2 621.1 749.5 784.5 792.0 800.3 798.8 800.3 801.6 805.2 805.5 834.7 835.3 836.0 836.9 837.0 647.3 797.5 821.9 825.7 831.7 603.1 603.6 603.9 604.1 604.2 12735.5 12758.6 12762.2 12764.9 12774.2 12665.4 12973.7 13039.3 13071.1 13464.7 11643.4 11701.4 11751.8 11919.8 12171.6 3869.1 3895.2 3939.4 4031.1 4073.8 61889.7 61981.4 62117.7 62194.0 62216.4 9772.9 10296.1 10600.0 10701.6 10711.8 17255.0 18629.1 18646.5 18653.3 18666.3 6637.1 6652.7 6793.1 6817.6 6997.8 3728.5 3748.3 3771.4 3776.6 4014.0 2938.4 3071.9 3073.6 3074.9 3076.7 529.4 535.1 537.5 540.6 549.1 443.9 468.4 519.3 539.9 550.7 7118.6 7250.3 7583.0 7636.9 7659.2 496.1 503.2 520.9 534.5 537.7 3291.5 3462.2 3499.2 3530.1 3599.4 89008.6 92186.0 93471.1 93741.5 95740.5 82974.6 83505.6 84054.0 84800.0 84930.0 72738.0 73325.0 73806.0 74603.6 75459.2 6864.1 6899.6 7012.8 7040.2 7071.4 43924.8 44867.8 44927.6 44933.0 45395.5 63254.7 65264.7 65682.0 65816.0 65979.7 9264.1 9369.1 9482.6 9489.4 9571.9 9974.2 10235.8 10410.1 10507.2 12379.8 10989.6 11222.6 11741.0 11945.6 12870.3 12511.5 12753.7 12804.5 12998.4 13077.8 12113.2 12276.3 12293.1 12440.9 12527.6 8749.5 9287.6 9838.8 9990.8 10149.0 9720.9 10029.3 10066.2 10101.4 10104.6 12:05:41 INFO - PROCESS | 31842 | -------- Summary: end -------- 12:05:41 INFO - PROCESS | 31842 | 12:05:42 INFO - TEST-INFO | 31842: exit 0 12:05:42 INFO - TEST-OK | dromaeo_css | took 1120374ms 12:05:42 INFO - TEST-START | kraken 12:05:42 INFO - operating with platform_type : linux_ 12:05:42 INFO - Initialising browser for kraken test... 12:05:42 INFO - TEST-INFO | started process 32026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppP1AKz/profile http://localhost:41568/getInfo.html) 12:05:46 INFO - PROCESS | 32026 | __metrics Screen width/height:1600/1200 12:05:46 INFO - PROCESS | 32026 | colorDepth:24 12:05:46 INFO - PROCESS | 32026 | Browser inner width/height: 1024/697 12:05:46 INFO - PROCESS | 32026 | __metrics 12:05:47 INFO - PROCESS | 32026 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:05:48 INFO - TEST-INFO | 32026: exit 0 12:05:48 INFO - Browser initialized. 12:05:48 INFO - Running cycle 1/1 for kraken test... 12:05:48 INFO - TEST-INFO | started process 32108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppP1AKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:00 INFO - PROCESS | 32108 | RSS: Main: 158720000 12:06:00 INFO - PROCESS | 32108 | 12:06:02 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41568/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:03 INFO - PROCESS | 32108 | RSS: Main: 216301568 12:06:03 INFO - PROCESS | 32108 | 12:06:06 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41568/tests/kraken/driver.html?testName=audio-dft) 12:06:07 INFO - PROCESS | 32108 | RSS: Main: 204365824 12:06:07 INFO - PROCESS | 32108 | 12:06:10 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41568/tests/kraken/driver.html?testName=audio-fft) 12:06:11 INFO - PROCESS | 32108 | RSS: Main: 270917632 12:06:11 INFO - PROCESS | 32108 | 12:06:13 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41568/tests/kraken/driver.html?testName=audio-oscillator) 12:06:13 INFO - PROCESS | 32108 | RSS: Main: 181829632 12:06:13 INFO - PROCESS | 32108 | 12:06:16 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41568/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:16 INFO - PROCESS | 32108 | RSS: Main: 185700352 12:06:16 INFO - PROCESS | 32108 | 12:06:19 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41568/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:20 INFO - PROCESS | 32108 | RSS: Main: 221937664 12:06:20 INFO - PROCESS | 32108 | 12:06:24 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41568/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:24 INFO - PROCESS | 32108 | RSS: Main: 217821184 12:06:24 INFO - PROCESS | 32108 | 12:06:27 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41568/tests/kraken/driver.html?testName=json-parse-financial) 12:06:28 INFO - PROCESS | 32108 | RSS: Main: 220368896 12:06:28 INFO - PROCESS | 32108 | 12:06:29 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41568/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:30 INFO - PROCESS | 32108 | RSS: Main: 206733312 12:06:30 INFO - PROCESS | 32108 | 12:06:32 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:32 INFO - PROCESS | 32108 | RSS: Main: 211714048 12:06:32 INFO - PROCESS | 32108 | 12:06:35 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:06:35 INFO - PROCESS | 32108 | RSS: Main: 209461248 12:06:35 INFO - PROCESS | 32108 | 12:06:38 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:06:39 INFO - PROCESS | 32108 | RSS: Main: 225263616 12:06:39 INFO - PROCESS | 32108 | 12:06:42 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:06:42 INFO - PROCESS | 32108 | RSS: Main: 223014912 12:06:42 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | Cycle 1(1): loaded http://localhost:41568/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41568/tests/kraken/driver.html?testName=ai-astar) 12:06:44 INFO - PROCESS | 32108 | RSS: Main: 266227712 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | __start_tp_report 12:06:44 INFO - PROCESS | 32108 | _x_x_mozilla_page_load 12:06:44 INFO - PROCESS | 32108 | _x_x_mozilla_page_load_details 12:06:44 INFO - PROCESS | 32108 | |i|pagename|runs| 12:06:44 INFO - PROCESS | 32108 | |0;ai-astar;105;114;112;113;112;113;113;116;112;114 12:06:44 INFO - PROCESS | 32108 | |1;audio-beat-detection;148;121;123;170;126;123;146;124;159;124 12:06:44 INFO - PROCESS | 32108 | |2;audio-dft;163;160;161;168;162;162;162;161;171;162 12:06:44 INFO - PROCESS | 32108 | |3;audio-fft;77;74;75;119;80;77;76;75;110;76 12:06:44 INFO - PROCESS | 32108 | |4;audio-oscillator;84;85;121;86;85;87;119;84;85;135 12:06:44 INFO - PROCESS | 32108 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 12:06:44 INFO - PROCESS | 32108 | |6;imaging-darkroom;146;147;146;146;146;146;147;146;146;145 12:06:44 INFO - PROCESS | 32108 | |7;imaging-desaturate;94;95;95;95;95;95;95;96;95;95 12:06:44 INFO - PROCESS | 32108 | |8;json-parse-financial;64;64;64;64;64;65;74;66;64;64 12:06:44 INFO - PROCESS | 32108 | |9;json-stringify-tinderbox;64;65;65;64;65;64;64;67;64;64 12:06:44 INFO - PROCESS | 32108 | |10;stanford-crypto-aes;78;79;88;81;79;78;78;78;79;86 12:06:44 INFO - PROCESS | 32108 | |11;stanford-crypto-ccm;127;124;135;138;129;136;138;141;214;132 12:06:44 INFO - PROCESS | 32108 | |12;stanford-crypto-pbkdf2;167;166;179;171;171;168;168;171;171;168 12:06:44 INFO - PROCESS | 32108 | |13;stanford-crypto-sha256-iterative;68;67;67;67;67;67;66;67;65;68 12:06:44 INFO - PROCESS | 32108 | __end_tp_report 12:06:44 INFO - PROCESS | 32108 | __start_cc_report 12:06:44 INFO - PROCESS | 32108 | _x_x_mozilla_cycle_collect,1906 12:06:44 INFO - PROCESS | 32108 | __end_cc_report 12:06:44 INFO - PROCESS | 32108 | __startTimestamp1467745604782__endTimestamp 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | ------- Summary: start ------- 12:06:44 INFO - PROCESS | 32108 | Number of tests: 14 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.88 (2.5%) stddev-sans-first:1.30 12:06:44 INFO - PROCESS | 32108 | Values: 105.0 114.0 112.0 113.0 112.0 113.0 113.0 116.0 112.0 114.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:136.00 stddev:17.88 (13.1%) stddev-sans-first:18.47 12:06:44 INFO - PROCESS | 32108 | Values: 148.0 121.0 123.0 170.0 126.0 123.0 146.0 124.0 159.0 124.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#2] audio-dft Cycles:10 Average:163.20 Median:162.00 stddev:3.49 (2.2%) stddev-sans-first:3.70 12:06:44 INFO - PROCESS | 32108 | Values: 163.0 160.0 161.0 168.0 162.0 162.0 162.0 161.0 171.0 162.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:16.35 (21.5%) stddev-sans-first:17.15 12:06:44 INFO - PROCESS | 32108 | Values: 77.0 74.0 75.0 119.0 80.0 77.0 76.0 75.0 110.0 76.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:85.00 stddev:19.71 (23.2%) stddev-sans-first:20.32 12:06:44 INFO - PROCESS | 32108 | Values: 84.0 85.0 121.0 86.0 85.0 87.0 119.0 84.0 85.0 135.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:06:44 INFO - PROCESS | 32108 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 12:06:44 INFO - PROCESS | 32108 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 12:06:44 INFO - PROCESS | 32108 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:64.00 stddev:3.13 (4.9%) stddev-sans-first:3.28 12:06:44 INFO - PROCESS | 32108 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 74.0 66.0 64.0 64.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 12:06:44 INFO - PROCESS | 32108 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 64.0 67.0 64.0 64.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:79.00 stddev:3.63 (4.6%) stddev-sans-first:3.74 12:06:44 INFO - PROCESS | 32108 | Values: 78.0 79.0 88.0 81.0 79.0 78.0 78.0 78.0 79.0 86.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:137.00 stddev:26.07 (19.0%) stddev-sans-first:27.12 12:06:44 INFO - PROCESS | 32108 | Values: 127.0 124.0 135.0 138.0 129.0 136.0 138.0 141.0 214.0 132.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:171.00 stddev:3.68 (2.2%) stddev-sans-first:3.74 12:06:44 INFO - PROCESS | 32108 | Values: 167.0 166.0 179.0 171.0 171.0 168.0 168.0 171.0 171.0 168.0 12:06:44 INFO - PROCESS | 32108 | 12:06:44 INFO - PROCESS | 32108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.83 12:06:44 INFO - PROCESS | 32108 | Values: 68.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 65.0 68.0 12:06:44 INFO - PROCESS | 32108 | -------- Summary: end -------- 12:06:44 INFO - PROCESS | 32108 | 12:06:45 INFO - TEST-INFO | 32108: exit 0 12:06:45 INFO - TEST-OK | kraken | took 63657ms 12:06:45 INFO - SUITE-END | took 1184s 12:06:45 INFO - Completed test suite (00:19:44) 12:06:45 INFO - javascript benchmark 12:06:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.5376632206203, 2603.153974958139, 2615.411532405209, 2616.751408616181, 2618.4632150409157, 4642.814287428499, 4643.326717625942, 4665.580097791202, 4686.343911852344, 4703.035877645083, 4700.717956922587, 4757.04859028194, 4774.045190961813, 4785.449673287573, 4789.856304310868, 4265.658747300224, 4305.526392096866, 4349.195398851207, 4368.148211098829, 4409.360642706805, 4350.891227719317, 4405.0, 4431.091626216617, 4480.0, 4520.5253448387775, 4418.756968366739, 4463.776811159445, 4470.463544374663, 4477.888052798689, 4512.435945506812, 4248.830046798124, 4300.22595932732, 4312.28847240205, 4341.261985462479, 4357.912841743179, 4275.337322714984, 4275.700700950934, 4281.571842815724, 4324.481062272516, 4437.445319335083, 4705.6470764692785, 4714.080754252922, 4756.167670657621, 4770.856874293777, 4774.546418090275, 4851.539103785135, 5016.799328026875, 5040.84877453677, 5070.822521211777, 5089.440161582223, 5087.821926232564, 5176.275321454999, 5177.663451875616, 5179.119549676564, 5180.041692286902, 4787.473377928425, 4790.161721698723, 4795.328653988445, 4814.614830813526, 4818.566329030404, 4961.206207006861, 5109.284700141983, 5209.453007434165, 5235.110031294689, 5265.104932161542, 5036.571891389273, 5056.342675452168, 5063.594912406998, 5067.467915868854, 5073.213651883964, 5089.796408143633, 5095.1847704367865, 5102.285680004802, 5103.413107492612, 5134.15286477727, 4884.340614017134, 4897.755112244374, 4917.188663870421, 4963.429205641398, 5095.133827249377, 4925.359703238556, 4933.062718083553, 4963.751812409365, 4968.925466118011, 4986.576141027981, 4172.520160181618, 4172.77049762266, 4174.812133454002, 4202.915941681149, 4215.557366476537, 3696.075981004749, 3698.6856117230336, 3699.7780133192095, 3702.9259414811554, 3751.6248375162813, 4286.7856607169515, 4344.522102568715, 4351.760653164043, 4353.891152721208, 4358.56414358568, 5128.461511541309, 5137.51193636604, 5139.331886854685, 5149.613778966593, 5169.172932330809, 4203.327467605169, 4284.635805956528, 4344.4352234209355, 4351.0, 4397.9560204398185, 4564.657650676212, 4572.5092067283895, 4594.104149690778, 4600.95399046012, 4647.55848194421, 4847.127517046824, 4850.223964165858, 4857.0528746894015, 4881.975590121956, 4898.118338699069, 5008.0, 5049.596032317332, 5099.515546023122, 5122.462141475092, 5137.152369858932, 4818.132736107535, 4848.539388758062, 4853.296272040464, 4877.024595080927, 4877.609791216623, 5018.698878067327, 5032.924506132485, 5040.773165207501, 5054.721990290569, 5057.039162559102, 4956.405231372259, 5066.493350664904, 5110.361204849394, 5125.5899528036925, 5179.015986962465, 4967.3542439482635, 4983.70097794119, 5002.924956125588, 5003.624728145331, 5039.042581909425, 4977.552020318189, 4992.176290911959, 4995.400551933792, 5002.449730529566, 5046.798128074836, 4739.620830333496, 4864.124457597666, 4868.2940973557925, 4873.171560834596, 4986.426560945538, 4990.301357809982, 5029.798808047637, 5036.597072234285, 5038.697678139323, 5072.365954255718, 4701.882452938704, 4909.214525675875, 4920.827771027997, 4922.876928076684, 4923.458419573915], "value": 4658.944513248998, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.5570432914492, 579.4118969246216, 581.8080033588916, 595.3272801734041, 599.9310079340877, 27729.722702772968, 39579.80210098949, 41842.372364414485, 41866.76665416823, 44845.7757711211, 42173.367399489034, 42656.57343426565, 42792.786036069854, 42850.35724464135, 42918.78540607292, 7813.062432508093, 7945.801354966115, 7957.72147974821, 7957.920420795805, 7958.36333093354, 7792.805179870492, 7870.724524641639, 7880.211978802131, 7885.172056934025, 7886.80282992924, 7860.253275938777, 7905.051393832719, 7905.802354941144, 7911.960440197791, 7912.446128770988, 7851.882221766678, 7886.09309929354, 7895.289423951815, 7895.289423951815, 7899.407544434133, 7767.844643107106, 7861.371090312761, 7871.606419678993, 7873.133955264973, 7873.173316801711, 39645.0, 39992.0, 40012.59987400118, 40021.39967900484, 40022.19955600901, 3000.5499175123905, 3014.0053782252025, 3025.2739342557848, 3083.9074827755203, 3101.5347697845505, 30000.849995749883, 30130.54804177939, 30404.632934774425, 31307.686923130706, 31630.841845790856, 3447.827608619584, 3520.489529018278, 3551.396262635358, 3565.16218688608, 3572.0534058474527, 229415.0, 265500.0, 265609.0, 266553.0, 266754.9999999981, 53158.20262696063, 53497.73251133719, 53589.46410535923, 53706.7314663432, 53820.73089634605, 32691.67308326934, 33744.325113497594, 33750.15624609405, 35473.290534189175, 35521.46717799235, 15377.308021139075, 15554.22228888551, 15555.688886222211, 15575.610609734847, 15609.765853512206, 11791.646250612324, 11870.34713090771, 11898.345590992578, 11921.165518413802, 11952.64142075739, 18343.54141146482, 18496.075196240134, 18547.44357669272, 18609.906950465433, 18611.90694046521, 6755.695993680296, 6820.0903746950935, 6852.246252912176, 6927.016965244904, 7054.294570542905, 838.7022606974558, 874.6457684637732, 887.8845750052452, 891.7280229530055, 981.651513712636, 25950.87024564865, 27314.863425683143, 27445.0, 27612.171634850583, 27732.0, 919.5632074764434, 973.4986481961795, 997.3175938966627, 1021.3157184686278, 1031.5461197073264, 14642.194679292741, 14811.25943702832, 15046.774298385533, 15076.24618769057, 15125.470608528869, 384081.0, 384505.0, 384687.0, 385621.0, 386433.0, 49861.750691246314, 50274.74862625664, 50485.495145048815, 50541.0, 50622.49377506252, 1079.422508957704, 1151.2977083978767, 1186.8041773107514, 1224.3878060969337, 1231.0459393969745, 27587.586186207624, 28745.0, 28808.135755927357, 29175.270618234714, 29266.70733292725, 41295.0, 42261.15477690491, 42375.36436953386, 42462.78768606137, 42485.36271955985, 300029.0, 300144.0, 303711.0, 303974.0, 304194.0, 21879.67180492326, 23973.52052958896, 24655.753442465346, 25145.87427062853, 25458.490830183662, 40620.59379406168, 41282.38076428916, 41774.0, 42130.578694212665, 42908.141837163705, 36296.81851590831, 36637.81681091578, 36959.815200923826, 37028.0, 37442.43836342511, 35843.28313433769, 36859.0, 37466.43800342942, 37626.81186594049, 38056.23887522179, 35642.821785890905, 35728.64271357253, 35944.101397465274, 36210.8189459051, 36833.26333473262, 32531.674683252866, 32724.686974769666, 33177.50233746447, 33557.496637549964, 33623.32753344969, 24906.871681064855, 25052.749472505042, 25227.873860630578, 25538.489230215662, 25694.229173124837], "value": 17493.78572746347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.0920335973505, 373.2832960715426, 375.38999126419566, 381.25084209528274, 384.9480320156778, 16336.26486808095, 17284.740728889075, 18125.456236312897, 18162.455126346198, 18212.81787182131, 10976.670699879016, 16256.0, 17111.486655400357, 17113.0, 17490.68819838514, 4571.725696458215, 4719.339292499053, 4757.3815403997605, 4759.881002974936, 4763.976180119112, 3474.5656792900886, 3644.4533320001947, 4657.6273898088075, 5237.528622423981, 5534.114541673333, 5573.665580065189, 5575.888482230353, 5613.9157912631135, 5623.550115990732, 5629.60592758507, 5114.590832733391, 5449.754761035743, 5452.863678408032, 5454.372747134091, 5559.416261292567, 3433.9141521461916, 4935.407751069859, 5248.816291429782, 5248.8687782805355, 5305.814296499604, 12522.74954500914, 12541.623751287476, 12620.81068783969, 12752.043596730282, 12859.742805143938, 1698.583846957491, 1842.3551756884983, 1885.066891888524, 1957.921683132673, 1997.7203191553194, 9350.438973661601, 9618.567164477545, 9625.855612165824, 11132.16508761838, 14020.088694234842, 1754.456118603237, 1754.7192449208064, 1794.921323605891, 1816.8637352198639, 1871.737956686065, 65123.67438162826, 70323.64838175828, 70623.0, 71135.64432177857, 72560.27439725536, 10163.237757168243, 10215.693529194135, 10270.127039201752, 10493.9475302623, 10528.894711052944, 14386.28068596566, 14486.492972745904, 14487.78268325976, 14506.637334066521, 14517.854821451861, 7315.0, 7396.0754905636795, 7400.48196626231, 7714.190010048977, 7772.727954521564, 7199.568025918462, 7207.423406127497, 7292.088488938883, 7311.561306321638, 7639.541627502367, 4418.9337159942625, 4434.55654434554, 4499.460064792181, 4501.504834468205, 4556.908861822745, 1629.7066528024832, 1661.3935913391767, 1764.6911790436623, 1846.6583682018602, 1953.326102494637, 832.7918020494876, 853.2832420766462, 897.7979954510314, 915.6291701860757, 921.5254144115786, 17225.1387430628, 17742.467725968243, 17943.85621762938, 18093.36673216431, 18302.54243643893, 855.576489637621, 862.3058437957379, 890.8084761776249, 901.4816480523725, 929.9767505812409, 9790.461524616072, 10130.848037279447, 10190.184785217165, 10227.846582301272, 10300.690979270634, 373032.0, 376168.0, 376802.0, 382686.0, 388508.0, 73224.63387683028, 77596.61201693956, 77981.61009195031, 78513.60743196247, 78704.0, 931.0456781798711, 931.6413180925392, 931.8043210925781, 957.2198658093631, 957.8706874571983, 15602.0, 15783.368665253261, 15806.60483487876, 15869.2858821351, 16136.838631613533, 36924.261514769016, 37057.81471092627, 37515.81242093772, 37706.62293377031, 38141.237175256894, 50595.2410713847, 50752.74623627006, 51101.74449127879, 54862.0, 55187.44812551823, 7845.725399610987, 7895.960520197362, 8049.83900322002, 8052.355811535181, 8062.798430039296, 11558.47986840611, 11697.181197316446, 12105.0, 12337.629871103882, 12947.0, 4763.0, 5239.711815850165, 8382.413231073766, 10068.798624027624, 11049.337039777318, 10451.320664156805, 10596.523156458132, 10723.571057157626, 10726.839097413702, 10815.35107893529, 10491.213159013258, 10725.249232553646, 10916.0, 10923.453827308762, 10990.725231869268, 7890.802729931568, 7908.0, 7993.8401231976195, 8149.103598604267, 8153.388495862952, 9545.952270238604, 10437.11284540792, 10529.262951593315, 10781.892181078088, 10797.568097276335], "value": 8145.662941207704, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.80166875803, 1388.1532265318158, 1463.963400914977, 1635.8773092018087, 1663.3014134063692, 6668.466522678186, 6934.687939042743, 7378.704851805928, 7915.129335773067, 7916.129225785166, 7333.926660733391, 7611.0, 7612.314891659749, 7735.30382265596, 7827.530348179099, 2177.314146043995, 2199.351191398533, 2201.9449513762206, 2204.184451752854, 2205.2171479124922, 1835.8531317494635, 1914.5787926656183, 1917.2714368540005, 1924.5284905198246, 2172.6523756199012, 2096.433962830035, 2200.2959053103014, 2201.6917631531596, 2203.9449013774624, 2205.3935167828895, 2159.2334721173916, 2181.7163768710047, 2187.6937228787983, 2188.037263604017, 2210.9005094770773, 1818.8544916406656, 2107.79975902289, 2156.8490205685607, 2161.945951351213, 2163.0374483354913, 7780.299773020455, 7844.058712954482, 7849.921500784976, 7854.842903141962, 7857.921420785776, 4470.9105817883465, 4593.885152871171, 4596.54034596541, 4597.103564804865, 4600.148972440076, 2806.677232118312, 2830.306574889145, 2889.061055157061, 2896.406236721467, 2908.2729317670583, 924.8612708093773, 926.6988228825659, 938.9483578403185, 942.472215559289, 947.166493485735, 10524.421156836372, 10535.73660658482, 10540.841887371696, 10569.947150264275, 10575.36547807134, 3964.5440774310746, 4078.7348822326453, 4170.35359519275, 4173.10278290163, 4196.3705444183615, 8987.281017518713, 9050.818983620291, 9066.501342426098, 9078.86381704275, 9078.954605226932, 4601.539846015372, 4608.861734147981, 4612.723236605747, 4618.976905115453, 4621.4223222097235, 4157.355609880413, 4233.153369326147, 4233.5554766749665, 4234.6188843003665, 4264.488261408589, 3339.415602269593, 3472.5659292588425, 3478.756487045933, 3674.356987527172, 3785.0537365658583, 1081.3187691754144, 1109.5339957217989, 1111.3165403276926, 1192.1059205595802, 1195.6472840511897, 692.6225207262054, 768.1435199752236, 773.7601343583507, 792.397777688949, 806.8668669669439, 5074.112030394666, 5199.896002080013, 5291.576673866081, 5326.7869285228935, 5381.434949330264, 814.3159745813545, 842.5155535567073, 858.6479543387181, 865.3466632692277, 900.2797761790541, 3504.491848681927, 3583.229605634749, 3596.6223546527763, 3605.6394360563736, 3684.2263124743567, 9260.722178334661, 9553.04469553053, 9591.568379422943, 9625.133737963477, 9666.323357365058, 9535.2371810255, 9557.808843823084, 9584.37701549397, 9610.615575377047, 9629.229661627052, 7209.134903811576, 7283.635818209068, 7400.925990740131, 7408.0369551958975, 7412.221716719775, 5113.53978141969, 5126.512981266774, 5130.51260130287, 5247.632665713363, 5307.548858347083, 8498.065212826461, 8781.692640757543, 8829.293656507592, 8855.822883542422, 8975.2371048459, 8733.08302628215, 9045.0, 9067.319951003568, 9225.630974760934, 9234.1689247968, 6656.267810540933, 6721.630310332978, 6741.561798483083, 6826.93173068263, 6896.4827637926355, 7443.627818609156, 7459.36595389398, 7501.324880760758, 7521.736739214101, 7538.321551060211, 6801.8639627206185, 6848.288677096374, 6938.965305173442, 6980.057692211486, 7020.403265722266, 6848.220261940743, 6879.759208427681, 6888.690008949509, 6933.791986240421, 6981.3367730065565, 6215.378462153749, 6318.589291696025, 6375.521835862236, 6385.521085918667, 6394.26465956421, 4177.498700156001, 4183.309753890574, 4223.97888010558, 4230.302000169938, 4249.851255206053, 4245.172191422766, 4252.978735106305, 4282.528921818535, 4292.399064130962, 4466.553344665507], "value": 4087.38893672762, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.9272528230584, 300.62722224441694, 303.57954233386755, 305.75692324601965, 308.63889249578, 4822.276658501227, 4847.321375007502, 4861.368022157119, 4867.464578896319, 4867.732274724893, 4811.446683631383, 4819.951520603739, 4820.325154478376, 4825.662203645747, 4843.58829499493, 3632.527771389716, 3745.6515654364407, 3772.77363358198, 3845.4039623858207, 3854.8265328060306, 3774.792386418746, 3823.483829682985, 3827.827747751358, 3841.0973421245985, 3841.42378643203, 3785.9621403786023, 3803.885883423488, 3803.9429408558753, 3808.6953043756434, 3819.236152769457, 3627.7097832173495, 3700.463432802242, 3795.7912314822674, 3796.373598356268, 3814.7138964577766, 3366.3267346530793, 3370.865165393381, 3372.4941258811373, 3379.729621630264, 3381.0871064812363, 4647.628189744846, 4653.348531205634, 4658.697184682985, 4662.347271382009, 4718.905621887578, 4191.937120943157, 4293.613574778254, 4321.962728945062, 4325.978370108161, 4354.325079612665, 4938.259261110827, 4947.307376967227, 4964.60283177345, 4973.975130124326, 4987.376577927759, 3667.1198912260866, 3703.7037037037244, 3704.3517384457614, 3707.4994875691978, 3713.3687273163628, 5087.364079490064, 5217.200065977232, 5234.528892399702, 5279.208118782175, 5281.656692315026, 3764.435334699817, 3766.8681596144, 3769.6230376962085, 3801.2777572261184, 3806.8960001599226, 3846.288436639231, 3856.749311294757, 3858.054776579756, 3862.208247309295, 3865.1110244643887, 4329.718568293051, 4335.1979883721615, 4337.934930976038, 4341.630961368319, 4350.564943505624, 4828.275758636232, 4999.3000979862845, 5006.1739812930455, 5011.824586139468, 5017.774200161001, 1315.3620494060374, 1319.070055610792, 1319.346923272986, 1328.63150954517, 1329.268902103839, 844.6114787197835, 853.8078932240196, 862.4178679391385, 874.5583480342386, 875.5534677314615, 4249.936250956238, 4363.127374525107, 4373.781310934504, 4375.431193944767, 4379.802908869108, 5123.231515272739, 5124.564412024945, 5129.589632829365, 5143.8199663012365, 5156.845294641167, 4308.4399028126145, 4365.869023929287, 4369.344598310216, 4376.956230437719, 4384.210842048462, 2584.3280747005915, 2727.2500062482977, 2752.2844060544003, 2753.187809596174, 2754.1737478756695, 4868.44603439484, 4880.585150262267, 4887.462379138292, 4911.557959783565, 4917.950820491749, 5034.748262586929, 5280.947190528045, 5288.153895376721, 5288.8413347599635, 5299.44355842631, 4843.0, 4872.829450969199, 4878.926816097762, 4887.7556122194455, 4891.144049791344, 5101.367562380003, 5132.204508301219, 5138.820141295037, 5139.794408223629, 5157.819476318311, 4832.806687732451, 5027.497250274943, 5046.268291097844, 5053.69677819332, 5073.11220536412, 4916.8770780730765, 4918.852434426973, 4938.950610493849, 4942.308076869169, 4947.2579113133315, 3691.870784522529, 3712.9443058354686, 3722.3671975763646, 3736.271427071695, 3742.2702572998005, 5002.8498500730475, 5181.974090129525, 5193.246979187921, 5229.320188375486, 5238.895222095613, 5050.72221027847, 5058.241263810458, 5069.112905241494, 5080.974595127001, 5097.719625420637, 5028.773705183348, 5046.243063540498, 5080.898382032413, 5081.263216833465, 5085.186370180753, 4729.125111854318, 5010.49895010496, 5014.6991180529285, 5016.899662006813, 5031.069252188357, 4849.830255941025, 4946.727929963887, 5088.389393272683, 5113.718745469035, 5132.178851383761, 4974.850754477371, 4980.800767969241, 4985.6011519077665, 5000.2499625056535, 5037.848864534069], "value": 3817.2811355588406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.0807599171183, 647.8542327976204, 691.8028361916855, 692.6848284030766, 744.5086243079569, 12524.436400361983, 13152.276624785633, 13523.661908452294, 13551.322433878317, 13877.791833122512, 13183.472661093545, 13218.603441896734, 13370.398332075056, 13381.197128172316, 13390.196588204715, 621.1459243540132, 749.5277974875847, 784.5371230973724, 792.0, 800.2837460472873, 798.7763426240633, 800.2597597222575, 801.6112185589984, 805.1706742055662, 805.4844899264475, 834.7203686764941, 835.2774849754949, 835.9582020898961, 836.8870202522672, 837.0, 647.3073811022232, 797.5414136871265, 821.9013718353776, 825.6821123867294, 831.6673330667721, 603.1013789453726, 603.5684485592778, 603.9456448919574, 604.1179877379031, 604.2115039872964, 12735.490580376774, 12758.553450629277, 12762.23426594398, 12764.936175319064, 12774.23354598727, 12665.366731663473, 12973.740525189538, 13039.282839443827, 13071.092395343077, 13464.663383415394, 11643.417829108595, 11701.3564253966, 11751.823722644167, 11919.821202681967, 12171.573994910135, 3869.0771828747224, 3895.220955808821, 3939.4484772131636, 4031.072853243741, 4073.816678249486, 61889.690551547406, 61981.38018619801, 62117.68941155265, 62194.0, 62216.37783622151, 9772.853407198898, 10296.124829389437, 10600.04599586041, 10701.571937122428, 10711.78576428467, 17255.0, 18629.068546572616, 18646.53383665419, 18653.253869845325, 18666.346677866208, 6637.137172167587, 6652.70062847173, 6793.116894803644, 6817.625030623264, 6997.755078572225, 3728.4780130781714, 3748.269087527906, 3771.396576547739, 3776.584575696671, 4013.979930100331, 2938.441696077781, 3071.938561228763, 3073.646530649004, 3074.8923787667322, 3076.661567227603, 529.4202847881563, 535.1277417809024, 537.502809900848, 540.6404740847371, 549.1076999875203, 443.93562933374477, 468.35367193273066, 519.3404376441973, 539.8542393553719, 550.7163810637525, 7118.572885626879, 7250.3112204340505, 7583.0, 7636.923630763732, 7659.234076592296, 496.0946273051623, 503.22754571732946, 520.9400918894376, 534.4735435595935, 537.6532136771839, 3291.53918451417, 3462.2036931505895, 3499.2126771476214, 3530.0821786335737, 3599.4420864766003, 89008.5549572248, 92186.0, 93471.06528934624, 93741.5312923431, 95740.52129739306, 82974.58512707398, 83505.58247208847, 84054.0, 84800.0, 84930.0, 72738.0, 73325.0, 73806.0, 74603.62698186474, 75459.24540754632, 6864.107666003388, 6899.551529150589, 7012.7545535906, 7040.190378106583, 7071.434285257064, 43924.780376097915, 44867.775661121486, 44927.550724492336, 44933.0, 45395.54604453913, 63254.683726581075, 65264.67367663131, 65682.0, 65816.0, 65979.67010164919, 9264.11990860867, 9369.109934556207, 9482.620695172116, 9489.383190092622, 9571.856422153813, 9974.20206383502, 10235.795284094425, 10410.115140213167, 10507.159427245955, 12379.75240495203, 10989.560417583207, 11222.55109795599, 11741.0, 11945.641630751092, 12870.292133932724, 12511.499540018662, 12753.74492510126, 12804.487820487077, 12998.415071322002, 13077.803832942323, 12113.15207935436, 12276.324802135969, 12293.139480236297, 12440.937795310965, 12527.624171274876, 8749.518776467356, 9287.582058807506, 9838.803223935623, 9990.750231244278, 10148.985101489792, 9720.902790972283, 10029.297949143782, 10066.194704423775, 10101.44442055694, 10104.646337378157], "value": 6480.364210027626, "unit": "score"}], "name": "dromaeo_css", "value": 6375.16101652999, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 113.0, 112.0, 113.0, 113.0, 116.0, 112.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 123.0, 170.0, 126.0, 123.0, 146.0, 124.0, 159.0, 124.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 168.0, 162.0, 162.0, 162.0, 161.0, 171.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 119.0, 80.0, 77.0, 76.0, 75.0, 110.0, 76.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 121.0, 86.0, 85.0, 87.0, 119.0, 84.0, 85.0, 135.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 74.0, 66.0, 64.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 67.0, 64.0, 64.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 88.0, 81.0, 79.0, 78.0, 78.0, 78.0, 79.0, 86.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 124.0, 135.0, 138.0, 129.0, 136.0, 138.0, 141.0, 214.0, 132.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 179.0, 171.0, 171.0, 168.0, 168.0, 171.0, 171.0, 168.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 65.0, 68.0], "value": 66.9, "unit": "score"}], "name": "kraken", "value": 1539.7000000000003, "alertThreshold": 2.0}]} 12:06:46 INFO - Return code: 0 12:06:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:06:46 INFO - # TBPL SUCCESS # 12:06:46 INFO - Running post-action listener: _resource_record_post_action 12:06:46 INFO - ##### 12:06:46 INFO - ##### Finished run-tests step (success) 12:06:46 INFO - ##### 12:06:46 INFO - Running post-run listener: _resource_record_post_run 12:06:46 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 544395264; Read time: 40; Write time: 640636 12:06:46 INFO - TinderboxPrint: CPU usage
13.0% 12:06:46 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 40 12:06:46 INFO - TinderboxPrint: I/O write bytes / time
544,395,264 / 640,636 12:06:46 INFO - TinderboxPrint: CPU idle
8,341.7 (87.0%) 12:06:46 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 12:06:46 INFO - TinderboxPrint: Swap in / out
0 / 0 12:06:46 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 256622592; Read time: 0; Write time: 360452 12:06:46 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 287772672; Read time: 28; Write time: 280184 12:06:46 INFO - Running post-run listener: _upload_blobber_files 12:06:46 INFO - Blob upload gear active. 12:06:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:06:46 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 12:06:46 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'] 12:06:46 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 12:06:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:06:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:47 INFO - (blobuploader) - INFO - Done attempting. 12:06:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:06:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:51 INFO - (blobuploader) - INFO - Done attempting. 12:06:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:06:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:06:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:06:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:06:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:06:51 INFO - (blobuploader) - INFO - Done attempting. 12:06:51 INFO - (blobuploader) - INFO - Iteration through files over. 12:06:51 INFO - Return code: 0 12:06:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:06:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:06:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57a1772b437bb4b9c0d58a812306a6ed0bb8b718af676c57dd851636a1879b28cbea22bf2750a48d64a1ef586da7e8c00720c430525d4d902208e9922393810a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd748f62b3cd148a7f633e354c86f1112cbf25d366fdb8827822e62a92beb3f083448e7dec816f4e341145493b66bde46f5ed376ac6a606dde9dfcc167843efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b154eb4ac34f44739d0e40d4917dd4ce804e68785e354dd777661af3c1e8eaa5f524fb46bc21557d083d0452c7dfb7169bae5d4d42a311c3cb96f5c16347e33"} 12:06:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:06:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:06:51 INFO - Contents: 12:06:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/57a1772b437bb4b9c0d58a812306a6ed0bb8b718af676c57dd851636a1879b28cbea22bf2750a48d64a1ef586da7e8c00720c430525d4d902208e9922393810a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd748f62b3cd148a7f633e354c86f1112cbf25d366fdb8827822e62a92beb3f083448e7dec816f4e341145493b66bde46f5ed376ac6a606dde9dfcc167843efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b154eb4ac34f44739d0e40d4917dd4ce804e68785e354dd777661af3c1e8eaa5f524fb46bc21557d083d0452c7dfb7169bae5d4d42a311c3cb96f5c16347e33"} 12:06:51 INFO - Running post-run listener: copy_logs_to_upload_dir 12:06:51 INFO - Copying logs to upload dir... 12:06:51 INFO - mkdir: /builds/slave/test/build/upload/logs 12:06:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.818323 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-05 12:06:51.878615) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 12:06:51.882453) ========= 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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 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/57a1772b437bb4b9c0d58a812306a6ed0bb8b718af676c57dd851636a1879b28cbea22bf2750a48d64a1ef586da7e8c00720c430525d4d902208e9922393810a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd748f62b3cd148a7f633e354c86f1112cbf25d366fdb8827822e62a92beb3f083448e7dec816f4e341145493b66bde46f5ed376ac6a606dde9dfcc167843efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b154eb4ac34f44739d0e40d4917dd4ce804e68785e354dd777661af3c1e8eaa5f524fb46bc21557d083d0452c7dfb7169bae5d4d42a311c3cb96f5c16347e33"} build_url:https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/f4oBKog0QtK5sozSluoBng/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/57a1772b437bb4b9c0d58a812306a6ed0bb8b718af676c57dd851636a1879b28cbea22bf2750a48d64a1ef586da7e8c00720c430525d4d902208e9922393810a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd748f62b3cd148a7f633e354c86f1112cbf25d366fdb8827822e62a92beb3f083448e7dec816f4e341145493b66bde46f5ed376ac6a606dde9dfcc167843efd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9b154eb4ac34f44739d0e40d4917dd4ce804e68785e354dd777661af3c1e8eaa5f524fb46bc21557d083d0452c7dfb7169bae5d4d42a311c3cb96f5c16347e33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 12:06:51.907958) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 12:06:51.908287) ========= 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=836cfdc75598d54cb747368e000001a9-1467744367.650803-1013385421 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 12:06:51.991673) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 12:06:51.991974) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 12:06:51.992264) ========= ========= Total master_lag: 0.16 =========