builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-019 starttime: 1467758879.13 results: success (0) buildid: 20160705151823 builduid: 821785e89e02451db7c402a8777a2589 revision: e08bba68cf4700aefa9c6b6e79750a396e921268 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.130711) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.131140) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.131412) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.245326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.245651) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 15:47:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-07-05 15:47:59 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132099 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.431810) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.434949) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.128841 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 15:47:59.605930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:47:59.606251) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e08bba68cf4700aefa9c6b6e79750a396e921268 --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 e08bba68cf4700aefa9c6b6e79750a396e921268 --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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 15:47:59,659 truncating revision to first 12 chars 2016-07-05 15:47:59,659 Setting DEBUG logging. 2016-07-05 15:47:59,659 attempt 1/10 2016-07-05 15:47:59,659 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e08bba68cf47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 15:48:00,437 unpacking tar archive at: fx-team-e08bba68cf47/testing/mozharness/ program finished with exit code 0 elapsedTime=1.153498 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 15:48:00.800165) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:00.800467) ========= script_repo_revision: e08bba68cf4700aefa9c6b6e79750a396e921268 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:00.800878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:00.801142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 15:48:00.810884) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-05 15:48:00.811197) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:48:01 INFO - MultiFileLogger online at 20160705 15:48:01 in /builds/slave/test 15:48:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 15:48:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:48:01 INFO - {'append_to_log': False, 15:48:01 INFO - 'base_work_dir': '/builds/slave/test', 15:48:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 15:48:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:48:01 INFO - 'branch': 'Fx-Team-Non-PGO', 15:48:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:48:01 INFO - 'config_files': ('talos/linux_config.py',), 15:48:01 INFO - 'default_actions': ('clobber', 15:48:01 INFO - 'read-buildbot-config', 15:48:01 INFO - 'download-and-extract', 15:48:01 INFO - 'populate-webroot', 15:48:01 INFO - 'create-virtualenv', 15:48:01 INFO - 'install', 15:48:01 INFO - 'run-tests'), 15:48:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:48:01 INFO - 'download_minidump_stackwalk': True, 15:48:01 INFO - 'download_symbols': 'ondemand', 15:48:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:48:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:48:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:48:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:48:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:48:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:48:01 INFO - 'installer_path': 'installer.exe', 15:48:01 INFO - 'log_level': 'info', 15:48:01 INFO - 'log_name': 'talos', 15:48:01 INFO - 'log_to_console': True, 15:48:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:48:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:48:01 INFO - 'opt_config_files': (), 15:48:01 INFO - 'pip_index': False, 15:48:01 INFO - 'sps_profile': False, 15:48:01 INFO - 'sps_profile_interval': 0, 15:48:01 INFO - 'suite': 'dromaeojs-e10s', 15:48:01 INFO - 'system_bits': '32', 15:48:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:48:01 INFO - 'title': 'talos-linux64-ix-019', 15:48:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:48:01 INFO - 'use_talos_json': True, 15:48:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:48:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:48:01 INFO - 'work_dir': 'build'} 15:48:01 INFO - ##### 15:48:01 INFO - ##### Running clobber step. 15:48:01 INFO - ##### 15:48:01 INFO - Running pre-action listener: _resource_record_pre_action 15:48:01 INFO - Running main action method: clobber 15:48:01 INFO - rmtree: /builds/slave/test/build 15:48:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:48:02 INFO - Running post-action listener: _resource_record_post_action 15:48:02 INFO - ##### 15:48:02 INFO - ##### Finished clobber step (success) 15:48:02 INFO - ##### 15:48:02 INFO - ##### 15:48:02 INFO - ##### Running read-buildbot-config step. 15:48:02 INFO - ##### 15:48:02 INFO - Running pre-action listener: _resource_record_pre_action 15:48:02 INFO - Running main action method: read_buildbot_config 15:48:02 INFO - Using buildbot properties: 15:48:02 INFO - { 15:48:02 INFO - "project": "", 15:48:02 INFO - "product": "firefox", 15:48:02 INFO - "script_repo_revision": "production", 15:48:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:48:02 INFO - "repository": "", 15:48:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 15:48:02 INFO - "buildid": "20160705151823", 15:48:02 INFO - "pgo_build": "False", 15:48:02 INFO - "basedir": "/builds/slave/test", 15:48:02 INFO - "buildnumber": 1415, 15:48:02 INFO - "slavename": "talos-linux64-ix-019", 15:48:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:48:02 INFO - "platform": "ubuntu64_hw", 15:48:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 15:48:02 INFO - "branch": "fx-team", 15:48:02 INFO - "repo_path": "integration/fx-team", 15:48:02 INFO - "revision": "e08bba68cf4700aefa9c6b6e79750a396e921268", 15:48:02 INFO - "stage_platform": "linux64", 15:48:02 INFO - "builduid": "821785e89e02451db7c402a8777a2589", 15:48:02 INFO - "slavebuilddir": "test" 15:48:02 INFO - } 15:48:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:48:02 INFO - Running post-action listener: _resource_record_post_action 15:48:02 INFO - ##### 15:48:02 INFO - ##### Finished read-buildbot-config step (success) 15:48:02 INFO - ##### 15:48:02 INFO - ##### 15:48:02 INFO - ##### Running download-and-extract step. 15:48:02 INFO - ##### 15:48:02 INFO - Running pre-action listener: _resource_record_pre_action 15:48:02 INFO - Running main action method: download_and_extract 15:48:02 INFO - mkdir: /builds/slave/test/build/tests 15:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:02 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:09 INFO - Downloaded 1361 bytes. 15:48:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:48:09 INFO - Using the following test package requirements: 15:48:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:48:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:48:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'jsshell-linux-x86_64.zip'], 15:48:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:48:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:48:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:48:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:48:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:48:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:48:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:48:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:48:09 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:27 INFO - Downloaded 22729872 bytes. 15:48:27 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'] 15:48:27 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 15:48:28 INFO - Return code: 0 15:48:28 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 15:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:28 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:48:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:48:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:29 INFO - Downloaded 22729872 bytes. 15:48:29 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'] 15:48:29 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 15:48:30 INFO - Return code: 0 15:48:30 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')]} 15:48:30 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:48:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:48:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:31 INFO - Downloaded 14403333 bytes. 15:48:31 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'] 15:48:31 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 15:48:32 INFO - Return code: 0 15:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:32 INFO - https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:48:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VVxlJti2Sg-l_u9uT0k_IA/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 15:48:33 INFO - Downloaded 56469719 bytes. 15:48:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:33 INFO - mkdir: /builds/slave/test/properties 15:48:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:48:33 INFO - Writing to file /builds/slave/test/properties/build_url 15:48:33 INFO - Contents: 15:48:33 INFO - build_url:https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:48:34 INFO - Running post-action listener: _resource_record_post_action 15:48:34 INFO - Running post-action listener: set_extra_try_arguments 15:48:34 INFO - ##### 15:48:34 INFO - ##### Finished download-and-extract step (success) 15:48:34 INFO - ##### 15:48:34 INFO - ##### 15:48:34 INFO - ##### Running populate-webroot step. 15:48:34 INFO - ##### 15:48:34 INFO - Running pre-action listener: _resource_record_pre_action 15:48:34 INFO - Running main action method: populate_webroot 15:48:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:48:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:48:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:48:34 INFO - '--tppagecycles', 15:48:34 INFO - '7'], 15:48:34 INFO - 'tests': ['tsvgm']}}, 15:48:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:48:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:48:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:48:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:48:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:48:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['damp', 'tps']}, 15:48:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'tests': ['damp', 'tps']}, 15:48:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['dromaeo_dom']}, 15:48:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:48:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['basic_compositor_video']}, 15:48:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:48:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'other-e10s': {'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['a11yr', 15:48:34 INFO - 'ts_paint', 15:48:34 INFO - 'tpaint', 15:48:34 INFO - 'sessionrestore', 15:48:34 INFO - 'sessionrestore_no_auto_restore', 15:48:34 INFO - 'tabpaint']}, 15:48:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['tsvgx', 15:48:34 INFO - 'tsvgr_opacity', 15:48:34 INFO - 'tart', 15:48:34 INFO - 'tscrollx', 15:48:34 INFO - 'cart']}, 15:48:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:48:34 INFO - 'tsvgr_opacity', 15:48:34 INFO - 'tart', 15:48:34 INFO - 'tscrollx', 15:48:34 INFO - 'cart']}, 15:48:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'talos_options': ['--disable-e10s'], 15:48:34 INFO - 'tests': ['tp5o']}, 15:48:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'tests': ['tp5o']}, 15:48:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'talos_options': ['--disable-e10s', 15:48:34 INFO - '--xperf_path', 15:48:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:34 INFO - 'tests': ['tp5n']}, 15:48:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:48:34 INFO - 'talos_options': ['--xperf_path', 15:48:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:48:34 INFO - 'tests': ['tp5n']}}, 15:48:34 INFO - 'talos.zip': {'path': '', 15:48:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:48:34 INFO - Running post-action listener: _resource_record_post_action 15:48:34 INFO - ##### 15:48:34 INFO - ##### Finished populate-webroot step (success) 15:48:34 INFO - ##### 15:48:34 INFO - ##### 15:48:34 INFO - ##### Running create-virtualenv step. 15:48:34 INFO - ##### 15:48:34 INFO - Running pre-action listener: _resource_record_pre_action 15:48:34 INFO - Running main action method: create_virtualenv 15:48:34 INFO - Creating virtualenv /builds/slave/test/build/venv 15:48:34 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 15:48:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:48:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:48:34 INFO - Using real prefix '/usr' 15:48:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:48:34 INFO - Installing distribute.............................................................................................................................................................................................done. 15:48:36 INFO - Installing pip.................done. 15:48:36 INFO - Return code: 0 15:48:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:36 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:36 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 15:48:36 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 15:48:36 INFO - Using env: {'DISPLAY': ':0', 15:48:36 INFO - 'HOME': '/home/cltbld', 15:48:36 INFO - 'LANG': 'en_US.UTF-8', 15:48:36 INFO - 'LANGUAGE': 'en_US:en', 15:48:36 INFO - 'LOGNAME': 'cltbld', 15:48:36 INFO - 'MAIL': '/var/mail/cltbld', 15:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:36 INFO - 'MOZ_NO_REMOTE': '1', 15:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:36 INFO - 'NO_EM_RESTART': '1', 15:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:36 INFO - 'PWD': '/builds/slave/test', 15:48:36 INFO - 'SHELL': '/bin/bash', 15:48:36 INFO - 'SHLVL': '1', 15:48:36 INFO - 'TERM': 'linux', 15:48:36 INFO - 'TMOUT': '86400', 15:48:36 INFO - 'USER': 'cltbld', 15:48:36 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:36 INFO - '_': '/tools/buildbot/bin/python'} 15:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:37 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 15:48:37 INFO - Cleaning up... 15:48:37 INFO - Return code: 0 15:48:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:48:37 INFO - Using env: {'DISPLAY': ':0', 15:48:37 INFO - 'HOME': '/home/cltbld', 15:48:37 INFO - 'LANG': 'en_US.UTF-8', 15:48:37 INFO - 'LANGUAGE': 'en_US:en', 15:48:37 INFO - 'LOGNAME': 'cltbld', 15:48:37 INFO - 'MAIL': '/var/mail/cltbld', 15:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:37 INFO - 'MOZ_NO_REMOTE': '1', 15:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:37 INFO - 'NO_EM_RESTART': '1', 15:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:37 INFO - 'PWD': '/builds/slave/test', 15:48:37 INFO - 'SHELL': '/bin/bash', 15:48:37 INFO - 'SHLVL': '1', 15:48:37 INFO - 'TERM': 'linux', 15:48:37 INFO - 'TMOUT': '86400', 15:48:37 INFO - 'USER': 'cltbld', 15:48:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:37 INFO - '_': '/tools/buildbot/bin/python'} 15:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:37 INFO - Downloading/unpacking psutil>=3.1.1 15:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:48:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:39 INFO - Installing collected packages: psutil 15:48:39 INFO - Running setup.py install for psutil 15:48:39 INFO - building 'psutil._psutil_linux' extension 15:48:39 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 15:48:40 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 15:48:40 INFO - building 'psutil._psutil_posix' extension 15:48:40 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 15:48:40 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 15:48:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:48:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:48:40 INFO - Successfully installed psutil 15:48:40 INFO - Cleaning up... 15:48:40 INFO - Return code: 0 15:48:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:48: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')]} 15:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48: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')]} 15:48:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:48:40 INFO - Using env: {'DISPLAY': ':0', 15:48:40 INFO - 'HOME': '/home/cltbld', 15:48:40 INFO - 'LANG': 'en_US.UTF-8', 15:48:40 INFO - 'LANGUAGE': 'en_US:en', 15:48:40 INFO - 'LOGNAME': 'cltbld', 15:48:40 INFO - 'MAIL': '/var/mail/cltbld', 15:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:40 INFO - 'MOZ_NO_REMOTE': '1', 15:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:40 INFO - 'NO_EM_RESTART': '1', 15:48:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:40 INFO - 'PWD': '/builds/slave/test', 15:48:40 INFO - 'SHELL': '/bin/bash', 15:48:40 INFO - 'SHLVL': '1', 15:48:40 INFO - 'TERM': 'linux', 15:48:40 INFO - 'TMOUT': '86400', 15:48:40 INFO - 'USER': 'cltbld', 15:48:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:40 INFO - '_': '/tools/buildbot/bin/python'} 15:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:48:43 INFO - Installing collected packages: mozsystemmonitor 15:48:43 INFO - Running setup.py install for mozsystemmonitor 15:48:43 INFO - Successfully installed mozsystemmonitor 15:48:43 INFO - Cleaning up... 15:48:43 INFO - Return code: 0 15:48:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:48:43 INFO - Using env: {'DISPLAY': ':0', 15:48:43 INFO - 'HOME': '/home/cltbld', 15:48:43 INFO - 'LANG': 'en_US.UTF-8', 15:48:43 INFO - 'LANGUAGE': 'en_US:en', 15:48:43 INFO - 'LOGNAME': 'cltbld', 15:48:43 INFO - 'MAIL': '/var/mail/cltbld', 15:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:43 INFO - 'MOZ_NO_REMOTE': '1', 15:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:43 INFO - 'NO_EM_RESTART': '1', 15:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:43 INFO - 'PWD': '/builds/slave/test', 15:48:43 INFO - 'SHELL': '/bin/bash', 15:48:43 INFO - 'SHLVL': '1', 15:48:43 INFO - 'TERM': 'linux', 15:48:43 INFO - 'TMOUT': '86400', 15:48:43 INFO - 'USER': 'cltbld', 15:48:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:43 INFO - '_': '/tools/buildbot/bin/python'} 15:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:43 INFO - Downloading/unpacking jsonschema==2.5.1 15:48:43 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 15:48:43 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 15:48:43 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 15:48:43 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 15:48:43 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 15:48:43 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 15:48:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:48:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:48:45 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 15:48:45 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 15:48:45 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 15:48:45 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 15:48:45 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 15:48:45 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 15:48:45 INFO - Downloading functools32-3.2.3-2.tar.gz 15:48:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:48:45 INFO - warning: no files found matching '*.txt' 15:48:45 INFO - no previously-included directories found matching 'build' 15:48:45 INFO - no previously-included directories found matching 'dist' 15:48:45 INFO - no previously-included directories found matching '.git*' 15:48:45 INFO - Installing collected packages: jsonschema, functools32 15:48:45 INFO - Running setup.py install for functools32 15:48:45 INFO - warning: no files found matching '*.txt' 15:48:45 INFO - no previously-included directories found matching 'build' 15:48:45 INFO - no previously-included directories found matching 'dist' 15:48:45 INFO - no previously-included directories found matching '.git*' 15:48:45 INFO - Successfully installed jsonschema functools32 15:48:45 INFO - Cleaning up... 15:48:45 INFO - Return code: 0 15:48:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:45 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:45 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 15:48:45 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 15:48:45 INFO - Using env: {'DISPLAY': ':0', 15:48:45 INFO - 'HOME': '/home/cltbld', 15:48:45 INFO - 'LANG': 'en_US.UTF-8', 15:48:45 INFO - 'LANGUAGE': 'en_US:en', 15:48:45 INFO - 'LOGNAME': 'cltbld', 15:48:45 INFO - 'MAIL': '/var/mail/cltbld', 15:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:45 INFO - 'MOZ_NO_REMOTE': '1', 15:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:45 INFO - 'NO_EM_RESTART': '1', 15:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:45 INFO - 'PWD': '/builds/slave/test', 15:48:45 INFO - 'SHELL': '/bin/bash', 15:48:45 INFO - 'SHLVL': '1', 15:48:45 INFO - 'TERM': 'linux', 15:48:45 INFO - 'TMOUT': '86400', 15:48:45 INFO - 'USER': 'cltbld', 15:48:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:45 INFO - '_': '/tools/buildbot/bin/python'} 15:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:46 INFO - Downloading/unpacking blobuploader==1.2.4 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:47 INFO - Downloading blobuploader-1.2.4.tar.gz 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:48:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:48:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:48:48 INFO - Downloading docopt-0.6.1.tar.gz 15:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:48:48 INFO - Installing collected packages: blobuploader, requests, docopt 15:48:48 INFO - Running setup.py install for blobuploader 15:48:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:48:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:48:48 INFO - Running setup.py install for requests 15:48:49 INFO - Running setup.py install for docopt 15:48:49 INFO - Successfully installed blobuploader requests docopt 15:48:49 INFO - Cleaning up... 15:48:49 INFO - Return code: 0 15:48:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:49 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:49 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 15:48:49 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 15:48:49 INFO - Using env: {'DISPLAY': ':0', 15:48:49 INFO - 'HOME': '/home/cltbld', 15:48:49 INFO - 'LANG': 'en_US.UTF-8', 15:48:49 INFO - 'LANGUAGE': 'en_US:en', 15:48:49 INFO - 'LOGNAME': 'cltbld', 15:48:49 INFO - 'MAIL': '/var/mail/cltbld', 15:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:49 INFO - 'MOZ_NO_REMOTE': '1', 15:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:49 INFO - 'NO_EM_RESTART': '1', 15:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:49 INFO - 'PWD': '/builds/slave/test', 15:48:49 INFO - 'SHELL': '/bin/bash', 15:48:49 INFO - 'SHLVL': '1', 15:48:49 INFO - 'TERM': 'linux', 15:48:49 INFO - 'TMOUT': '86400', 15:48:49 INFO - 'USER': 'cltbld', 15:48:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:49 INFO - '_': '/tools/buildbot/bin/python'} 15:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:49 INFO - Running setup.py (path:/tmp/pip-VNDehS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:49 INFO - Running setup.py (path:/tmp/pip-y06KIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:49 INFO - Running setup.py (path:/tmp/pip-W_iyBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:49 INFO - Running setup.py (path:/tmp/pip-4Plt53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:49 INFO - Running setup.py (path:/tmp/pip-VAtd_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:49 INFO - Running setup.py (path:/tmp/pip-_qoD9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:50 INFO - Running setup.py (path:/tmp/pip-wJ4Omj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:50 INFO - Running setup.py (path:/tmp/pip-K4ubdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:50 INFO - Running setup.py (path:/tmp/pip-kyRzaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:50 INFO - Running setup.py (path:/tmp/pip-b0maln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:50 INFO - Running setup.py (path:/tmp/pip-A2Odjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:50 INFO - Running setup.py (path:/tmp/pip-18d_Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:50 INFO - Running setup.py (path:/tmp/pip-Ma46dS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:50 INFO - Running setup.py (path:/tmp/pip-md1yj3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:50 INFO - Running setup.py (path:/tmp/pip-5Vs8jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:50 INFO - Running setup.py (path:/tmp/pip-UtCLIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:50 INFO - Running setup.py (path:/tmp/pip-eJzy3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:48:50 INFO - Running setup.py install for manifestparser 15:48:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:48:50 INFO - Running setup.py install for mozcrash 15:48:51 INFO - Running setup.py install for mozdebug 15:48:51 INFO - Running setup.py install for mozdevice 15:48:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozfile 15:48:51 INFO - Running setup.py install for mozhttpd 15:48:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozinfo 15:48:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozInstall 15:48:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozleak 15:48:51 INFO - Running setup.py install for mozlog 15:48:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for moznetwork 15:48:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:48:51 INFO - Running setup.py install for mozprocess 15:48:52 INFO - Running setup.py install for mozprofile 15:48:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:48:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:48:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:48:52 INFO - Running setup.py install for mozrunner 15:48:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:48:52 INFO - Running setup.py install for mozscreenshot 15:48:52 INFO - Running setup.py install for moztest 15:48:52 INFO - Running setup.py install for mozversion 15:48:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:48:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:48:52 INFO - Cleaning up... 15:48:52 INFO - Return code: 0 15:48:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:48:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:52 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:52 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 15:48:52 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 15:48:52 INFO - Using env: {'DISPLAY': ':0', 15:48:52 INFO - 'HOME': '/home/cltbld', 15:48:52 INFO - 'LANG': 'en_US.UTF-8', 15:48:52 INFO - 'LANGUAGE': 'en_US:en', 15:48:52 INFO - 'LOGNAME': 'cltbld', 15:48:52 INFO - 'MAIL': '/var/mail/cltbld', 15:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:52 INFO - 'MOZ_NO_REMOTE': '1', 15:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:52 INFO - 'NO_EM_RESTART': '1', 15:48:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:52 INFO - 'PWD': '/builds/slave/test', 15:48:52 INFO - 'SHELL': '/bin/bash', 15:48:52 INFO - 'SHLVL': '1', 15:48:52 INFO - 'TERM': 'linux', 15:48:52 INFO - 'TMOUT': '86400', 15:48:52 INFO - 'USER': 'cltbld', 15:48:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:52 INFO - '_': '/tools/buildbot/bin/python'} 15:48:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:48:52 INFO - Running setup.py (path:/tmp/pip-gJ_2zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:48:52 INFO - Running setup.py (path:/tmp/pip-o_QiW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:48:52 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)) 15:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:48:52 INFO - Running setup.py (path:/tmp/pip-J2y6cK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:48:53 INFO - Running setup.py (path:/tmp/pip-9m_RdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:48:53 INFO - Running setup.py (path:/tmp/pip-08uGCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:48:53 INFO - Running setup.py (path:/tmp/pip-bLduY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:48:53 INFO - Running setup.py (path:/tmp/pip-u6TsGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:48:53 INFO - Running setup.py (path:/tmp/pip-AvitoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:48:53 INFO - Running setup.py (path:/tmp/pip-j2Y1Yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:48:53 INFO - Running setup.py (path:/tmp/pip-QHzQCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:48:53 INFO - Running setup.py (path:/tmp/pip-wbHcwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:48:53 INFO - Running setup.py (path:/tmp/pip-_wUIIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:48:53 INFO - Running setup.py (path:/tmp/pip-yMRESc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:48:53 INFO - Running setup.py (path:/tmp/pip-LyHmgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:53 INFO - Running setup.py (path:/tmp/pip-bVIjcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:48:53 INFO - Running setup.py (path:/tmp/pip-2qo375-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:48:53 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)) 15:48:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:48:53 INFO - Running setup.py (path:/tmp/pip-eldm_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:48:54 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)) 15:48:54 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)) 15:48:54 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)) 15:48:54 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)) 15:48:54 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)) 15:48:54 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)) 15:48:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:48:54 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 15:48:54 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 15:48:54 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 15:48:54 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 15:48:54 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 15:48:54 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 15:48:55 INFO - Downloading blessings-1.6.tar.gz 15:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:48:56 INFO - Installing collected packages: blessings 15:48:56 INFO - Running setup.py install for blessings 15:48:56 INFO - Successfully installed blessings 15:48:56 INFO - Cleaning up... 15:48:56 INFO - Return code: 0 15:48:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:56 INFO - Reading from file tmpfile_stdout 15:48:56 INFO - Current package versions: 15:48:56 INFO - argparse == 1.2.1 15:48:56 INFO - blessings == 1.6 15:48:56 INFO - blobuploader == 1.2.4 15:48:56 INFO - docopt == 0.6.1 15:48:56 INFO - functools32 == 3.2.3-2 15:48:56 INFO - jsonschema == 2.5.1 15:48:56 INFO - manifestparser == 1.1 15:48:56 INFO - mozInstall == 1.12 15:48:56 INFO - mozcrash == 0.17 15:48:56 INFO - mozdebug == 0.1 15:48:56 INFO - mozdevice == 0.48 15:48:56 INFO - mozfile == 1.2 15:48:56 INFO - mozhttpd == 0.7 15:48:56 INFO - mozinfo == 0.9 15:48:56 INFO - mozleak == 0.1 15:48:56 INFO - mozlog == 3.2 15:48:56 INFO - moznetwork == 0.27 15:48:56 INFO - mozprocess == 0.22 15:48:56 INFO - mozprofile == 0.28 15:48:56 INFO - mozrunner == 6.11 15:48:56 INFO - mozscreenshot == 0.1 15:48:56 INFO - mozsystemmonitor == 0.3 15:48:56 INFO - moztest == 0.7 15:48:56 INFO - mozversion == 1.4 15:48:56 INFO - psutil == 3.1.1 15:48:56 INFO - requests == 1.2.3 15:48:56 INFO - wsgiref == 0.1.2 15:48:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:48:56 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')]} 15:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 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')]} 15:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:56 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 15:48:56 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 15:48:56 INFO - Using env: {'DISPLAY': ':0', 15:48:56 INFO - 'HOME': '/home/cltbld', 15:48:56 INFO - 'LANG': 'en_US.UTF-8', 15:48:56 INFO - 'LANGUAGE': 'en_US:en', 15:48:56 INFO - 'LOGNAME': 'cltbld', 15:48:56 INFO - 'MAIL': '/var/mail/cltbld', 15:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:56 INFO - 'MOZ_NO_REMOTE': '1', 15:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:56 INFO - 'NO_EM_RESTART': '1', 15:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:56 INFO - 'PWD': '/builds/slave/test', 15:48:56 INFO - 'SHELL': '/bin/bash', 15:48:56 INFO - 'SHLVL': '1', 15:48:56 INFO - 'TERM': 'linux', 15:48:56 INFO - 'TMOUT': '86400', 15:48:56 INFO - 'USER': 'cltbld', 15:48:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:56 INFO - '_': '/tools/buildbot/bin/python'} 15:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 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)) 15:48:56 INFO - Cleaning up... 15:48:56 INFO - Return code: 0 15:48:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:48:56 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')]} 15:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 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')]} 15:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:48:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:48:56 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 0xefc030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x112b400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', '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 15:48:56 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 15:48:56 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 15:48:56 INFO - Using env: {'DISPLAY': ':0', 15:48:56 INFO - 'HOME': '/home/cltbld', 15:48:56 INFO - 'LANG': 'en_US.UTF-8', 15:48:56 INFO - 'LANGUAGE': 'en_US:en', 15:48:56 INFO - 'LOGNAME': 'cltbld', 15:48:56 INFO - 'MAIL': '/var/mail/cltbld', 15:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:48:56 INFO - 'MOZ_NO_REMOTE': '1', 15:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:48:56 INFO - 'NO_EM_RESTART': '1', 15:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:48:56 INFO - 'PWD': '/builds/slave/test', 15:48:56 INFO - 'SHELL': '/bin/bash', 15:48:56 INFO - 'SHLVL': '1', 15:48:56 INFO - 'TERM': 'linux', 15:48:56 INFO - 'TMOUT': '86400', 15:48:56 INFO - 'USER': 'cltbld', 15:48:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:48:56 INFO - '_': '/tools/buildbot/bin/python'} 15:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:48:56 INFO - Cleaning up... 15:48:56 INFO - Return code: 0 15:48:56 INFO - Running post-action listener: _resource_record_post_action 15:48:56 INFO - Running post-action listener: _start_resource_monitoring 15:48:56 INFO - Starting resource monitoring. 15:48:56 INFO - ##### 15:48:56 INFO - ##### Finished create-virtualenv step (success) 15:48:56 INFO - ##### 15:48:56 INFO - ##### 15:48:56 INFO - ##### Running install step. 15:48:56 INFO - ##### 15:48:56 INFO - Running pre-action listener: _resource_record_pre_action 15:48:56 INFO - Running main action method: install 15:48:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:48:57 INFO - Reading from file tmpfile_stdout 15:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:48:57 INFO - Reading from file tmpfile_stdout 15:48:57 INFO - Output received: 15:48:57 INFO - Usage: mozinstall [options] installer 15:48:57 INFO - Options: 15:48:57 INFO - -h, --help show this help message and exit 15:48:57 INFO - -d DEST, --destination=DEST 15:48:57 INFO - Directory to install application into. [default: 15:48:57 INFO - "/builds/slave/test"] 15:48:57 INFO - --app=APP Application being installed. [default: firefox] 15:48:57 INFO - mkdir: /builds/slave/test/build/application 15:48:57 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'] 15:48:57 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 15:49:13 INFO - Reading from file tmpfile_stdout 15:49:13 INFO - Output received: 15:49:13 INFO - /builds/slave/test/build/application/firefox/firefox 15:49:13 INFO - Running post-action listener: _resource_record_post_action 15:49:13 INFO - ##### 15:49:13 INFO - ##### Finished install step (success) 15:49:13 INFO - ##### 15:49:13 INFO - ##### 15:49:13 INFO - ##### Running run-tests step. 15:49:13 INFO - ##### 15:49:13 INFO - Running pre-action listener: _resource_record_pre_action 15:49:13 INFO - Running main action method: run_tests 15:49:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:49:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:49:13 INFO - Python 2.7.3 15:49:13 INFO - Return code: 0 15:49:13 INFO - grabbing minidump binary from tooltool 15:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:49:13 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 0x11ba570>, '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 0x11bb470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bb900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:49:13 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 15:49:13 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 15:49:13 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 15:49:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:49:13 INFO - Return code: 0 15:49:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:49:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:49:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:49:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:49:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:49:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:49:13 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:49:13 INFO - Using env: {'DISPLAY': ':0', 15:49:13 INFO - 'HOME': '/home/cltbld', 15:49:13 INFO - 'LANG': 'en_US.UTF-8', 15:49:13 INFO - 'LANGUAGE': 'en_US:en', 15:49:13 INFO - 'LOGNAME': 'cltbld', 15:49:13 INFO - 'MAIL': '/var/mail/cltbld', 15:49:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:49:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:13 INFO - 'MOZ_NO_REMOTE': '1', 15:49:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:13 INFO - 'NO_EM_RESTART': '1', 15:49:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:13 INFO - 'PWD': '/builds/slave/test', 15:49:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:49:13 INFO - 'SHELL': '/bin/bash', 15:49:13 INFO - 'SHLVL': '1', 15:49:13 INFO - 'TERM': 'linux', 15:49:13 INFO - 'TMOUT': '86400', 15:49:13 INFO - 'USER': 'cltbld', 15:49:13 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737', 15:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:13 INFO - '_': '/tools/buildbot/bin/python'} 15:49:13 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:49:14 INFO - mozversion application_buildid: 20160705151823 15:49:14 INFO - mozversion application_changeset: e08bba68cf4700aefa9c6b6e79750a396e921268 15:49:14 INFO - mozversion application_display_name: Nightly 15:49:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:49:14 INFO - mozversion application_name: Firefox 15:49:14 INFO - mozversion application_remotingname: firefox 15:49:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:49:14 INFO - mozversion application_vendor: Mozilla 15:49:14 INFO - mozversion application_version: 50.0a1 15:49:14 INFO - mozversion platform_buildid: 20160705151823 15:49:14 INFO - mozversion platform_changeset: e08bba68cf4700aefa9c6b6e79750a396e921268 15:49:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:49:14 INFO - mozversion platform_version: 50.0a1 15:49:14 INFO - using testdate: 1467758954 15:49:14 INFO - actual date: 1467758954 15:49:14 INFO - starting webserver on 'localhost:47384' 15:49:14 INFO - SUITE-START | Running 2 tests 15:49:14 INFO - TEST-START | dromaeo_css 15:49:14 INFO - operating with platform_type : linux_ 15:49:14 INFO - Initialising browser for dromaeo_css test... 15:49:14 INFO - TEST-INFO | started process 3298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOSeDU/profile http://localhost:47384/getInfo.html) 15:49:19 INFO - PROCESS | 3298 | __metrics Screen width/height:1600/1200 15:49:19 INFO - PROCESS | 3298 | colorDepth:24 15:49:19 INFO - PROCESS | 3298 | Browser inner width/height: 1024/697 15:49:19 INFO - PROCESS | 3298 | __metrics 15:49:20 ERROR - PROCESS | 3298 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 15:49:21 INFO - TEST-INFO | 3298: exit 0 15:49:21 INFO - Browser initialized. 15:49:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:49:21 INFO - TEST-INFO | started process 3416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphOSeDU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:49:33 INFO - PROCESS | 3416 | RSS: Main: 169689088 15:49:33 INFO - PROCESS | 3416 | 15:50:22 INFO - PROCESS | 3416 | 1467759022875 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] 15:52:35 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47384/tests/dromaeo/cssquery-ext.html) 15:52:36 INFO - PROCESS | 3416 | RSS: Main: 172646400 15:52:36 INFO - PROCESS | 3416 | 15:55:38 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-ext.html (next: http://localhost:47384/tests/dromaeo/cssquery-jquery.html) 15:55:39 INFO - PROCESS | 3416 | RSS: Main: 169046016 15:55:39 INFO - PROCESS | 3416 | 15:58:41 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47384/tests/dromaeo/cssquery-mootools.html) 15:58:42 INFO - PROCESS | 3416 | RSS: Main: 172797952 15:58:42 INFO - PROCESS | 3416 | 16:01:44 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47384/tests/dromaeo/cssquery-prototype.html) 16:01:44 INFO - PROCESS | 3416 | RSS: Main: 168304640 16:01:44 INFO - PROCESS | 3416 | 16:04:47 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47384/tests/dromaeo/cssquery-yui.html) 16:04:48 INFO - PROCESS | 3416 | RSS: Main: 170020864 16:04:48 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | Cycle 1(1): loaded http://localhost:47384/tests/dromaeo/cssquery-yui.html (next: http://localhost:47384/tests/dromaeo/cssquery-dojo.html) 16:07:50 INFO - PROCESS | 3416 | RSS: Main: 171028480 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | __start_tp_report 16:07:50 INFO - PROCESS | 3416 | _x_x_mozilla_page_load 16:07:50 INFO - PROCESS | 3416 | _x_x_mozilla_page_load_details 16:07:50 INFO - PROCESS | 3416 | |i|pagename|runs| 16:07:50 INFO - PROCESS | 3416 | |0;dojo.html;2630.0926180467736;2685.7851371890256;2705.4589082183556;2705.7429544193305;2720.3743139078024;4751.311059896313;4805.8798530036765;4815.157347464193;4894.070126675938;4940.234263689125;4705.717656940577;4754.072955773626;4764.5235476452335;4783.258594917794;4802.735849528274;4346.261135606938;4413.88965275869;4429.9114017719785;4467.463904331485;4489.102179564084;536.9351055063127;4129.375891018526;4342.522322544518;4364.759938203398;4409.338599210128;4362.912741745179;4364.847230346954;4365.497967733703;4373.103513779699;4395.724746984496;4343.19650864591;4389.890252743675;4394.78026098697;4401.009772801126;4427.734335939822;4400.383946247496;4457.621102206316;4465.218586747306;4484.304932735431;4494.483134439549;4848.612111031144;4884.926726099111;4897.3878265216845;4898.608111351084;4905.632077594195;4986.4514903360605;5079.466656001104;5211.296474975868;5279.577633789288;5331.920021199685;5112.156494178456;5133.743312834344;5138.614603904722;5153.458886816868;5223.451537588575;4778.546038126373;4787.281907713871;4798.2802579613335;4802.159622066124;4820.469748327716;5141.717205553656;5211.557017653466;5228.424873263938;5239.29269548606;5313.920291195635;5062.924056139161;5073.644844860898;5090.796368145307;5092.490750924878;5104.3109180260935;5145.691258524501;5154.896902061938;5172.939547392775;5184.37787465499;5196.428392876781;4968.577670898014;5092.134337162691;5100.974495127501;5124.359455068116;5159.122949098587;5120.948790512121;5139.280500729901;5150.639455238097;5162.664426812245;5164.638475306768;4350.60844523988;4351.173277077345;4357.67317451186;4385.3641222022625;4401.867943961686;3685.760425572329;3705.7405981581032;3717.8141092945784;3719.628037196313;3758.4550240215563;4355.542668019875;4373.431453910971;4399.428074350378;4443.977780111079;4477.28363461851;5183.974080129575;5186.884819763769;5193.350831146106;5198.610104242197;5206.114960456732;4283.935740963888;4337.956620433818;4357.520672725997;4399.252127138394;4454.4877339106415;4589.931151032737;4592.2422800238255;4599.103174880866;4602.677812553089;4609.101225261042;4804.039192161512;4811.254255590389;4846.224604063333;4859.659823812299;4913.606911447004;5056.544910957884;5204.0892843752945;5217.452167522356;5220.869478263074;5311.521963023347;4951.529604687549;4973.328600638867;4981.1283025469675;4983.152864013199;5032.798688052437;5191.143461328838;5194.091034069098;5197.324347834758;5203.427622961547;5205.167173252262;5082.949170508396;5084.923726144037;5108.719020453911;5126.102931986813;5137.255098010843;4956.8760780980765;5006.574441172541;5010.799568017384;5012.949870501248;5047.091523525801;4800.159972004955;4937.864291213113;4983.377077865267;4991;5037.596992240538;4840.080384726891;4898.4121905371585;4901.1913034350355;4911.901761964812;4943.678660887031;5053.267276244997;5060.873478163076;5072.9746351268;5076.238564215398;5120.641555091257;4815.061063092663;4861.565838077705;4934.975325123495;4950.653454258168;5006.023825354021 16:07:50 INFO - PROCESS | 3416 | |1;ext.html;571.954243660507;581.293728120334;581.8050952930768;599.1731410653299;620.6648409858676;35501.46747798782;39067;39070.6325278615;39093.80453097737;39116;38981;39408.408873866916;39524.60475395245;39545.209095818136;39555.40666889999;7616.733414330513;7851.528908265494;7856.882146767803;7865.331446826998;7867;7764.767056988299;7773.805654858617;7813.140554539024;7833.412494062968;7857.567833769141;7780.8832867507035;7827.569483678395;7850.371970242395;7881.921180788176;7883.881741773878;7797.454178207528;7830.921690783133;7837.725679601243;7856.960715196445;7857;7724.691012359499;7771.883421748678;7788.182240864684;7794.649240784178;7808.063032436087;37030;37186.62813371859;37453.81273093644;37539.249215015545;37574.624253757385;2331.440454290975;2823.9294017649518;2826.51607905849;2950.8967186148384;3051.5422686596967;26508.60237096445;28155;28302.575461368095;29729;30820.2294942626;3286.4905939579403;3319.5684561007156;3345;3350.5811773528308;3439.8968030959113;234354;235223;235729;236698;237516;31434.84282578618;31695.683043169272;31709.365812683616;31748.365032699217;31843.84078079595;32369.51445728316;33084;33344.49949752267;34874.12814679653;34924.825375872955;14062.507812226522;14306.427742890168;14310.785338219936;14343.713125737428;14345.282735863166;10618.09746171584;10660.520276587573;10748.140148788078;10768.246222764332;10808.135349172047;18177.818221817877;18292.176852041423;18298.359557415428;18367.72448413275;18419.447416577525;6720.294369091175;6824.6928888200155;6870.62211578368;6880.69036893341;6943.89584156238;813.4631143445416;891.1311471315415;900.1223806788329;940.722486866376;1023.4166525080782;26577.601335979976;28512.85743571269;28549.71450285512;28749.425011499654;28793;937.6015193542717;980.475445636581;980.9117179453883;1028.290479569095;1041.953112109957;14720.263986800832;14750;14777.408903643734;14820.3330850112;14895.180765058027;406739;408785;409326;409942;411886;48666.75666621644;48667;49067;49153;49295;1169.6783384569142;1185.3065956415421;1190.3215167354524;1216.4951545108859;1222.3949145173196;26105.347366315233;27113;27173.456530868876;27572.58641120425;27870.3032424191;40658.1868362637;40733;40827.38758918678;41306;41368.586314136475;266550;267212;267593;268097;269430;24652;24833.255002349957;24941;25066.37334066663;25076.498470030863;40570.59429405668;40711.389329159494;41407;41802.163956720084;42073;33589;36045.45931810972;36877.44683829691;37009.81495092615;37266.8136659315;36002.4599631011;36237.818810905774;36297;36947.261054779294;37135.25729485449;31700.36599268048;32008.19979500438;35131.824340878135;35453;35822.28355432929;31108.688913110578;32777.344453111284;33135.834320829206;33203.50194747129;33217;25112.37219069538;25177;25536.616950746124;25624.61563076518;25969.48061038731 16:07:50 INFO - PROCESS | 3416 | |2;jquery.html;370.17635760433024;371.6952099278592;375.76514678326043;383.78316251318023;390.47871092092055;16423.671526569462;17152.228149733262;17284.740728889075;17538;17595.12024398778;17162.485125446256;17424.651506969854;17489.65020699585;18431.44705658829;18434;5670.007748643991;5817.389174136718;5863.442972917566;5882.088276317178;5892.263467066617;5741.110127930177;5823.621464604808;5851.414858514136;5880.3825598312205;5881.588288819784;5633;5787.074068149076;5798.2172406725185;5816.621919575236;5877.2065771121;5718.828435146952;5802.622829516068;5891.469767720926;5891.64650120992;5899.616524925909;5451.563874889999;5669.348024977139;5679.858003549944;5696.743646535916;5723.112917497753;23995.520089598285;24183.87908060466;24797.256082317377;24884.129055483154;25133.24600261977;2070.6272870883236;2073.8651987620756;2104.400245929918;2135.29535253366;2162.416147640128;14807.70384592302;14869.479568215169;15210.239488025554;15258.542243732594;15534.766978495332;1931.0730849192325;1951.1414977409895;1960.127743154297;1962.8135327144041;1995.6906679464705;64421;70823.04238703293;75403;79337.60331198365;80705.59647201785;16338.222502174658;16921.323147073977;17044.829551704323;17180.91409542944;17316.740248896276;30200.395992080474;30351.848240758656;30587.388252234832;30628.69371306303;30713.846430767702;8629.395942284105;8833.911660883437;8886.186843141297;8957.820843583091;9080.500572468445;7095.184053833772;7140.678669459887;7201.89197162043;7227.1327440707455;7310.780676579711;8405;8435.312937412542;8520.957395212985;8555.075108100753;8557;3363.983180084084;3458.654134586521;3542.362374772514;3640.8543658253375;3681.159420289855;803.5098589860181;841.5539763925129;850.0988951711082;901.0898992018109;927.823713494434;17116;17861.106944652714;18085.638287234182;18237.54406139857;18264.945136210303;833.1876420489974;838.2288294768828;857.5540718826176;860.5611138319377;866.1468453573225;10119.291649584458;10146.340487868265;10224.233182511342;10261.538230779634;10287.382757034602;350493;353763;356338;370768;375653;60722.392776071676;78439.60780196062;80021;81288.59355703302;81561.59219203866;887.942283751567;893.0622846011662;903.6566104880103;908.2370808520874;918.334207699426;15971.12158831229;16187.919060404623;16350;16473.176341183134;16856.15719214059;35988.4601730969;36900.446493302086;37396.43905341368;38801.223975519766;39081.218375632896;51085;51593.226101607754;52647;52903.20645190402;53004.73497632487;6827.761028363983;7165.677544510614;7495.925040749523;7886.763397098096;7943.086545047394;11612.767744645229;12305;12472.251664900135;12613.36933153357;12745.490180393052;10293.845592316271;10602.681919542427;10766.95651308267;10770.515326810155;10813.29713568647;10350.327228730108;10389.9480502597;10551.94724026375;10608.522616482123;10822.188335874998;9180.908190918006;9187.862182067141;10231.897681023094;10441.791164176826;10567.260291779501;7413.258674132544;7791.649375778217;7897.644605992629;7988.680452781824;8209.09699932995;8259.545724985184;10332.328398654063;10691.305065171051;10711.464426778786;10720.678379648623 16:07:50 INFO - PROCESS | 3416 | |3;mootools.html;1357.9728405431892;1412.0186470403069;1497.1915165810462;1702.1659386900408;1729.9308027678894;6829.795106146811;7479;7571.848563028743;8059.7179098731485;8068.233517815813;7618.809529761758;7934.801629959254;7950.1652326505755;7951.244631759988;7991.041075070985;2215.944601384966;2242.8542144760618;2249.5725812095648;2257.1761307122865;2266.3314322274887;2242.4169715873827;2244.4837687331924;2281.5094754627753;2288.0733303012307;2292.4727312718087;2217.9001944912516;2229.9331020069344;2237.038073628339;2241.551689662066;2252.6621006849023;2169.8155656769113;2173.445771328317;2178.803907648319;2179.204590324536;2179.226374637005;2185.093186327672;2191.4411824984686;2199.1093607089156;2200.460887082659;2201.1635578480236;7935;8003.399745019147;8025.799355016113;8028.4781489203015;8041.718539851136;4494.9775251123865;4655.720656760605;4661.650376221797;4666.090112428078;4681.040386720714;2826.5336219523756;2967.4806908791093;2979.61265035544;2997.715217054398;3001.5347621118544;932.4591736792644;957.0716405087054;968.8546717992288;997.0777031246141;1002.158187122813;10854.403007834566;10885.510152043098;10898.782024359547;10902.5093870776;10930.125589952784;4095.6313931746286;4190.790460476964;4363.6072753452345;4412.580804823537;4413;9438;9450.810983780286;9460.52697365129;9461.621535138518;9470.431774093438;4594.88512787183;4604.7927843247135;4612.469565999953;4636.4899861015265;4638.5593368629925;3479.7042251408916;4107.301758701028;4147.232761939051;4165.604267594574;4240.618344349024;3708.072981754561;3728.627137286304;3830.4062870255157;3887.688984881203;3958.6041395860184;1196.8085106382937;1228.3673907937418;1236.9257844529357;1242.8260043593905;1245.1781823996118;697.2191145916504;774.9457537972288;806.3106044332012;817.894418168376;822.8560001999626;5115.64190506661;5150.047241260304;5179.507946745053;5307.814226502054;5344.679319240858;403.8303912356817;426.0541597653205;430.8298222202213;848.4951453884929;936.0405584276172;3379.4930760386137;3546.556680414948;3577.409727395003;3591.102224443889;3593.874214402483;9602.519874006271;9883.752906177404;9976.950115249378;9979.850302245472;9987.750306242402;9701.854472182922;9838.262130340254;9851.359661621971;9886.505674716236;9915.355501892354;7325.304096110861;7497.887531687029;7513.812154696067;7515.549067055994;7520.699172033167;4931.753412329297;4998.225275082368;5104.081265372269;5128.974355128201;5144.614153938394;9253.537323133682;9269.119433653792;9340.299477539347;9340.626374944926;9379.859302110337;8630.78423039429;8879.955600221958;8895.199432051146;9187.77030574241;9352.719418417459;6002.159697642421;6575.868482630416;6671.199456065303;6740.9325906740305;6793.320667933167;7644.044494438195;7670.539767613961;7687.654055567625;7711.1517733048195;7753;6829.863402732017;6849.31506849331;6870.519063665695;6905;7107.253738357605;6870.587764734132;6967.54710943787;6984.476164287597;7025.789226323219;7107.893381599177;6170.660613666291;6206.844828879314;6225.066240064027;6314.968425158028;6334.746610135728;4340.565943405634;4418.160549495586;4430.069685366109;4478.104379124123;4516.503184649751;4462;4463.843765468193;4495.393121928498;4532.342810292424;4534.365188873494 16:07:50 INFO - PROCESS | 3416 | |4;prototype.html;298.2796546340588;304.75771761449647;306.1183790682834;308.02970642476214;308.3078488792661;5070.898582028357;5076.746162691865;5078;5130.256112863633;5142.588592912567;5038.470960549144;5060.898782024357;5066.620003499734;5083.686922450285;5096.362954630671;3754.549454065516;3886.514185726784;3971.3248747712814;3977.403389491585;3995.4805875236325;3966.464527288808;3968.365061590146;3974.701897357695;3991.501062367204;4008.8196031178522;3960.544537378195;3970.563238043813;4011.5186177658575;4012.1775036117524;4015.6185162409524;3665.248624032067;3884.1066554692297;3911.1395492991783;4005.3991901214904;4011.3782363733667;3402.4726167444087;3405.3700065487965;3414.9487757683655;3416.1118109291515;3417.2652879631;4925.975370123162;4959.305697202359;4966.87582810429;4968.403791545002;4974.253861920704;4232.984083819892;4474.261746811772;4494.37078808967;4502.302143167814;4524.954750452486;5242.292290540767;5243.842684719464;5265.341832270966;5265.868353291198;5278.155495120801;3687.8524859005875;3704.981475092607;3723.590405055442;3732.5520937487404;3743.326201283795;5343.973280133613;5495.148252020943;5528.364238112588;5531.751071201806;5563.471470210324;3783.281176576442;3832.559255685632;3834.1181528248103;3835;3838.213166300902;3800.9429858552144;3849.6535311821513;3853.0560012797046;3854;3879.80600969956;4427.380166776654;4470.776461176928;4493.663295086602;4503.301988191835;4536.977315113403;5218.999075531585;5273.736313184326;5299.5760339172775;5335.199720042025;5394.165983565606;1334.2394834944182;1339.4462423588784;1350.8784209421199;1356.959291221265;1362.9795553066713;845.3913182508584;854.3122786157079;867.2584939876441;870.7387783664875;887.2591386192602;4500.302453119772;4516.774161291923;4552.317152427162;4553.089382123589;4559.133764584718;5338.199270109515;5370.167624018283;5403.297961142306;5412.648177868426;5419.4283657738815;4359.607635312837;4540.523245059288;4542.273236282179;4545.636349092065;4545.749983750926;2894.8697308621163;2920.707929207062;2946.6169397978124;2953.4093181363814;2957.024182019928;5116;5116.2372318947355;5146.279520867081;5181.274621552986;5207.635465517453;5320.388155362106;5551.694656793834;5561.499465048084;5584.760838713536;5615;5141.640085194001;5160.200168973815;5168.7415629218385;5193.195054766517;5199.376074870888;5483.150111732688;5488.807891723771;5499.752511136929;5524.14375771756;5547.140193270049;5210.5150032242145;5281.709505977208;5371.63647994881;5373.032854086146;5377.758000890048;5151.5363617274625;5178.922316165336;5184.185535062697;5186.377634683862;5189.636725429184;3829.8659546915724;3846.115393459464;3861.0347413146715;3867.864624738233;3869.477620521194;5193.961207758539;5567.972160139173;5571.3871474137;5589.875847178047;5614.24207731951;5397.136458166831;5425.348958125051;5435.266239057834;5435.945640543702;5454;5166.819161329336;5349.57203423733;5357.866053348697;5362.329708786402;5377.247185394126;5285.418603953639;5288.312519372457;5294.682319060868;5299.258103865385;5303.973480132575;5133.948660513496;5239.397469291081;5357.812476563302;5382.9192562112385;5424.53891419218;5232.738363081755;5274.841754747364;5283.445238250082;5287.867803304948;5289.153735402318 16:07:50 INFO - PROCESS | 3416 | |5;yui.html;538.3674182835169;568.3691102875807;570.4352690836074;594.064348650875;656.8587753632968;12087.335196564185;13268.402921868515;13295.202287862723;13438.395272212749;13965.301734913264;14222.928885355559;14376.209308488029;14432.5670229893;14463.5660930172;14502.274886255698;628.2366924187112;717.8815495443246;739.26443189027;739.5082270290251;764.5680190692269;779.1079214299624;781.0900301149154;784.8077221080844;787.9369650427981;794.2772077409559;829.0590180145518;831.9708810191645;835.3985130705912;836.6235194162621;839.8866153069349;826.1944604011101;830.5888585150329;832.2925513313695;832.9791755206138;834.6119054639591;602.6022824935566;607.2227548737579;608.5253502268238;610.8381278961078;611.5291225756188;12467.438965246585;12540;12542.68643283916;12601.810972835416;12628;12998.935005324913;13038.934805326007;13354.933225333909;13449.462021519128;13668.863311366958;10007.549660265306;10131.594736210543;10303.433311167882;10357.948210258975;10488.05607495329;3283.819389933553;3292.7530435217213;3331.53358529806;3357.9328413431595;3365.3101114271517;66671.33328666748;68936.3106368935;70227.29772702258;70283.29716702818;70802;10036.24728145392;10040.290650477344;10178.389296642225;10368.326058806153;10445.68662940113;19257.711134332996;19358.612827743647;19359.12883920227;19458.124384402738;19587.706184407245;6924.515283930177;6969.16370035599;7008.649567521604;7017.368436840607;7100.644967751592;3812.199438118026;3821.426785982125;3824.904377390532;3926.764394136304;3936.0356712605594;3020.1845501714415;3121.063680895722;3132.545780861762;3147.4806656901815;3155.4162479941283;479.6738218011786;496.09215136300486;501.78674063522857;502.9647924645313;505.7167985927892;537.1486194381948;542.6798189068469;545.26661640094;548.281750906306;585.6778771675562;8176.6320515576945;8224.62989165477;8264.752057438287;8334.83330333402;8440.11378805229;523.5314393617691;524.7320753598308;537.7230726176023;542.4765101676901;551.7875617887142;3720.497732806091;3797.696184305249;3984.7808370539897;4109.753414795122;4119.855805046869;106690;109554;109682;109723.45138274257;112802;54014;56581.7170914151;72638.63680681668;90897;91044;51045.23432148521;81477.18522814696;83238;83645;85964.57017714746;7279.235680253709;7713.537187768752;7804;8021.759347219593;8051.275385215359;33062.5040624386;41400.37899431451;47058.76470617625;47291.14528655764;48320.516794833005;64018.67990660017;64438.67780661066;72238.63880680563;72645.27354726597;72991.63504182658;9479.715608531755;9637.662681806103;9737.756556086155;9861.605535778488;9889.802203956024;10681.946590266998;10912.454377280945;10972.451377431256;11042.116630669689;11109.166812489257;10162.491875406347;10231.181505479693;10368.222383321432;11370.374629395132;11537.88462115368;10637.468126593794;12300.50797968107;12591.93704031474;12596.796594758274;12946.41741121633;10236.897631023892;11504.137189710638;11602.245854019462;11628.18602697803;11791.941040295087;9897.802043959224;10069.748256293358;10138.239632027775;10191.133753630727;10497.685069447929;9748.707538773848;10268.486575671335;10270.948645256725;10278.126359259248;10330.380177189392 16:07:50 INFO - PROCESS | 3416 | __end_tp_report 16:07:50 INFO - PROCESS | 3416 | __start_cc_report 16:07:50 INFO - PROCESS | 3416 | _x_x_mozilla_cycle_collect,409 16:07:50 INFO - PROCESS | 3416 | __end_cc_report 16:07:50 INFO - PROCESS | 3416 | __startTimestamp1467760070669__endTimestamp 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | ------- Summary: start ------- 16:07:50 INFO - PROCESS | 3416 | Number of tests: 6 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#0] dojo.html Cycles:165 Average:4729.65 Median:4905.63 stddev:609.56 (12.4%) stddev-sans-first:588.76 16:07:50 INFO - PROCESS | 3416 | Values: 2630.1 2685.8 2705.5 2705.7 2720.4 4751.3 4805.9 4815.2 4894.1 4940.2 4705.7 4754.1 4764.5 4783.3 4802.7 4346.3 4413.9 4429.9 4467.5 4489.1 536.9 4129.4 4342.5 4364.8 4409.3 4362.9 4364.8 4365.5 4373.1 4395.7 4343.2 4389.9 4394.8 4401.0 4427.7 4400.4 4457.6 4465.2 4484.3 4494.5 4848.6 4884.9 4897.4 4898.6 4905.6 4986.5 5079.5 5211.3 5279.6 5331.9 5112.2 5133.7 5138.6 5153.5 5223.5 4778.5 4787.3 4798.3 4802.2 4820.5 5141.7 5211.6 5228.4 5239.3 5313.9 5062.9 5073.6 5090.8 5092.5 5104.3 5145.7 5154.9 5172.9 5184.4 5196.4 4968.6 5092.1 5101.0 5124.4 5159.1 5120.9 5139.3 5150.6 5162.7 5164.6 4350.6 4351.2 4357.7 4385.4 4401.9 3685.8 3705.7 3717.8 3719.6 3758.5 4355.5 4373.4 4399.4 4444.0 4477.3 5184.0 5186.9 5193.4 5198.6 5206.1 4283.9 4338.0 4357.5 4399.3 4454.5 4589.9 4592.2 4599.1 4602.7 4609.1 4804.0 4811.3 4846.2 4859.7 4913.6 5056.5 5204.1 5217.5 5220.9 5311.5 4951.5 4973.3 4981.1 4983.2 5032.8 5191.1 5194.1 5197.3 5203.4 5205.2 5082.9 5084.9 5108.7 5126.1 5137.3 4956.9 5006.6 5010.8 5012.9 5047.1 4800.2 4937.9 4983.4 4991.0 5037.6 4840.1 4898.4 4901.2 4911.9 4943.7 5053.3 5060.9 5073.0 5076.2 5120.6 4815.1 4861.6 4935.0 4950.7 5006.0 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#1] ext.html Cycles:180 Average:44793.76 Median:35028.32 stddev:82689.63 (236.1%) stddev-sans-first:82854.94 16:07:50 INFO - PROCESS | 3416 | Values: 572.0 581.3 581.8 599.2 620.7 35501.5 39067.0 39070.6 39093.8 39116.0 38981.0 39408.4 39524.6 39545.2 39555.4 7616.7 7851.5 7856.9 7865.3 7867.0 7764.8 7773.8 7813.1 7833.4 7857.6 7780.9 7827.6 7850.4 7881.9 7883.9 7797.5 7830.9 7837.7 7857.0 7857.0 7724.7 7771.9 7788.2 7794.6 7808.1 37030.0 37186.6 37453.8 37539.2 37574.6 2331.4 2823.9 2826.5 2950.9 3051.5 26508.6 28155.0 28302.6 29729.0 30820.2 3286.5 3319.6 3345.0 3350.6 3439.9 234354.0 235223.0 235729.0 236698.0 237516.0 31434.8 31695.7 31709.4 31748.4 31843.8 32369.5 33084.0 33344.5 34874.1 34924.8 14062.5 14306.4 14310.8 14343.7 14345.3 10618.1 10660.5 10748.1 10768.2 10808.1 18177.8 18292.2 18298.4 18367.7 18419.4 6720.3 6824.7 6870.6 6880.7 6943.9 813.5 891.1 900.1 940.7 1023.4 26577.6 28512.9 28549.7 28749.4 28793.0 937.6 980.5 980.9 1028.3 1042.0 14720.3 14750.0 14777.4 14820.3 14895.2 406739.0 408785.0 409326.0 409942.0 411886.0 48666.8 48667.0 49067.0 49153.0 49295.0 1169.7 1185.3 1190.3 1216.5 1222.4 26105.3 27113.0 27173.5 27572.6 27870.3 40658.2 40733.0 40827.4 41306.0 41368.6 266550.0 267212.0 267593.0 268097.0 269430.0 24652.0 24833.3 24941.0 25066.4 25076.5 40570.6 40711.4 41407.0 41802.2 42073.0 33589.0 36045.5 36877.4 37009.8 37266.8 36002.5 36237.8 36297.0 36947.3 37135.3 31700.4 32008.2 35131.8 35453.0 35822.3 31108.7 32777.3 33135.8 33203.5 33217.0 25112.4 25177.0 25536.6 25624.6 25969.5 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#2] jquery.html Cycles:180 Average:25042.42 Median:18886.10 stddev:59833.19 (316.8%) stddev-sans-first:59972.36 16:07:50 INFO - PROCESS | 3416 | Values: 370.2 371.7 375.8 383.8 390.5 16423.7 17152.2 17284.7 17538.0 17595.1 17162.5 17424.7 17489.7 18431.4 18434.0 5670.0 5817.4 5863.4 5882.1 5892.3 5741.1 5823.6 5851.4 5880.4 5881.6 5633.0 5787.1 5798.2 5816.6 5877.2 5718.8 5802.6 5891.5 5891.6 5899.6 5451.6 5669.3 5679.9 5696.7 5723.1 23995.5 24183.9 24797.3 24884.1 25133.2 2070.6 2073.9 2104.4 2135.3 2162.4 14807.7 14869.5 15210.2 15258.5 15534.8 1931.1 1951.1 1960.1 1962.8 1995.7 64421.0 70823.0 75403.0 79337.6 80705.6 16338.2 16921.3 17044.8 17180.9 17316.7 30200.4 30351.8 30587.4 30628.7 30713.8 8629.4 8833.9 8886.2 8957.8 9080.5 7095.2 7140.7 7201.9 7227.1 7310.8 8405.0 8435.3 8521.0 8555.1 8557.0 3364.0 3458.7 3542.4 3640.9 3681.2 803.5 841.6 850.1 901.1 927.8 17116.0 17861.1 18085.6 18237.5 18264.9 833.2 838.2 857.6 860.6 866.1 10119.3 10146.3 10224.2 10261.5 10287.4 350493.0 353763.0 356338.0 370768.0 375653.0 60722.4 78439.6 80021.0 81288.6 81561.6 887.9 893.1 903.7 908.2 918.3 15971.1 16187.9 16350.0 16473.2 16856.2 35988.5 36900.4 37396.4 38801.2 39081.2 51085.0 51593.2 52647.0 52903.2 53004.7 6827.8 7165.7 7495.9 7886.8 7943.1 11612.8 12305.0 12472.3 12613.4 12745.5 10293.8 10602.7 10767.0 10770.5 10813.3 10350.3 10389.9 10551.9 10608.5 10822.2 9180.9 9187.9 10231.9 10441.8 10567.3 7413.3 7791.6 7897.6 7988.7 8209.1 8259.5 10332.3 10691.3 10711.5 10720.7 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#3] mootools.html Cycles:180 Average:5197.74 Median:5051.15 stddev:2956.22 (58.5%) stddev-sans-first:2950.43 16:07:50 INFO - PROCESS | 3416 | Values: 1358.0 1412.0 1497.2 1702.2 1729.9 6829.8 7479.0 7571.8 8059.7 8068.2 7618.8 7934.8 7950.2 7951.2 7991.0 2215.9 2242.9 2249.6 2257.2 2266.3 2242.4 2244.5 2281.5 2288.1 2292.5 2217.9 2229.9 2237.0 2241.6 2252.7 2169.8 2173.4 2178.8 2179.2 2179.2 2185.1 2191.4 2199.1 2200.5 2201.2 7935.0 8003.4 8025.8 8028.5 8041.7 4495.0 4655.7 4661.7 4666.1 4681.0 2826.5 2967.5 2979.6 2997.7 3001.5 932.5 957.1 968.9 997.1 1002.2 10854.4 10885.5 10898.8 10902.5 10930.1 4095.6 4190.8 4363.6 4412.6 4413.0 9438.0 9450.8 9460.5 9461.6 9470.4 4594.9 4604.8 4612.5 4636.5 4638.6 3479.7 4107.3 4147.2 4165.6 4240.6 3708.1 3728.6 3830.4 3887.7 3958.6 1196.8 1228.4 1236.9 1242.8 1245.2 697.2 774.9 806.3 817.9 822.9 5115.6 5150.0 5179.5 5307.8 5344.7 403.8 426.1 430.8 848.5 936.0 3379.5 3546.6 3577.4 3591.1 3593.9 9602.5 9883.8 9977.0 9979.9 9987.8 9701.9 9838.3 9851.4 9886.5 9915.4 7325.3 7497.9 7513.8 7515.5 7520.7 4931.8 4998.2 5104.1 5129.0 5144.6 9253.5 9269.1 9340.3 9340.6 9379.9 8630.8 8880.0 8895.2 9187.8 9352.7 6002.2 6575.9 6671.2 6740.9 6793.3 7644.0 7670.5 7687.7 7711.2 7753.0 6829.9 6849.3 6870.5 6905.0 7107.3 6870.6 6967.5 6984.5 7025.8 7107.9 6170.7 6206.8 6225.1 6315.0 6334.7 4340.6 4418.2 4430.1 4478.1 4516.5 4462.0 4463.8 4495.4 4532.3 4534.4 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#4] prototype.html Cycles:180 Average:4401.24 Median:5080.84 stddev:1291.42 (25.4%) stddev-sans-first:1257.78 16:07:50 INFO - PROCESS | 3416 | Values: 298.3 304.8 306.1 308.0 308.3 5070.9 5076.7 5078.0 5130.3 5142.6 5038.5 5060.9 5066.6 5083.7 5096.4 3754.5 3886.5 3971.3 3977.4 3995.5 3966.5 3968.4 3974.7 3991.5 4008.8 3960.5 3970.6 4011.5 4012.2 4015.6 3665.2 3884.1 3911.1 4005.4 4011.4 3402.5 3405.4 3414.9 3416.1 3417.3 4926.0 4959.3 4966.9 4968.4 4974.3 4233.0 4474.3 4494.4 4502.3 4525.0 5242.3 5243.8 5265.3 5265.9 5278.2 3687.9 3705.0 3723.6 3732.6 3743.3 5344.0 5495.1 5528.4 5531.8 5563.5 3783.3 3832.6 3834.1 3835.0 3838.2 3800.9 3849.7 3853.1 3854.0 3879.8 4427.4 4470.8 4493.7 4503.3 4537.0 5219.0 5273.7 5299.6 5335.2 5394.2 1334.2 1339.4 1350.9 1357.0 1363.0 845.4 854.3 867.3 870.7 887.3 4500.3 4516.8 4552.3 4553.1 4559.1 5338.2 5370.2 5403.3 5412.6 5419.4 4359.6 4540.5 4542.3 4545.6 4545.7 2894.9 2920.7 2946.6 2953.4 2957.0 5116.0 5116.2 5146.3 5181.3 5207.6 5320.4 5551.7 5561.5 5584.8 5615.0 5141.6 5160.2 5168.7 5193.2 5199.4 5483.2 5488.8 5499.8 5524.1 5547.1 5210.5 5281.7 5371.6 5373.0 5377.8 5151.5 5178.9 5184.2 5186.4 5189.6 3829.9 3846.1 3861.0 3867.9 3869.5 5194.0 5568.0 5571.4 5589.9 5614.2 5397.1 5425.3 5435.3 5435.9 5454.0 5166.8 5349.6 5357.9 5362.3 5377.2 5285.4 5288.3 5294.7 5299.3 5304.0 5133.9 5239.4 5357.8 5382.9 5424.5 5232.7 5274.8 5283.4 5287.9 5289.2 16:07:50 INFO - PROCESS | 3416 | 16:07:50 INFO - PROCESS | 3416 | [#5] yui.html Cycles:180 Average:18160.90 Median:47174.95 stddev:26827.50 (56.9%) stddev-sans-first:26870.13 16:07:50 INFO - PROCESS | 3416 | Values: 538.4 568.4 570.4 594.1 656.9 12087.3 13268.4 13295.2 13438.4 13965.3 14222.9 14376.2 14432.6 14463.6 14502.3 628.2 717.9 739.3 739.5 764.6 779.1 781.1 784.8 787.9 794.3 829.1 832.0 835.4 836.6 839.9 826.2 830.6 832.3 833.0 834.6 602.6 607.2 608.5 610.8 611.5 12467.4 12540.0 12542.7 12601.8 12628.0 12998.9 13038.9 13354.9 13449.5 13668.9 10007.5 10131.6 10303.4 10357.9 10488.1 3283.8 3292.8 3331.5 3357.9 3365.3 66671.3 68936.3 70227.3 70283.3 70802.0 10036.2 10040.3 10178.4 10368.3 10445.7 19257.7 19358.6 19359.1 19458.1 19587.7 6924.5 6969.2 7008.6 7017.4 7100.6 3812.2 3821.4 3824.9 3926.8 3936.0 3020.2 3121.1 3132.5 3147.5 3155.4 479.7 496.1 501.8 503.0 505.7 537.1 542.7 545.3 548.3 585.7 8176.6 8224.6 8264.8 8334.8 8440.1 523.5 524.7 537.7 542.5 551.8 3720.5 3797.7 3984.8 4109.8 4119.9 106690.0 109554.0 109682.0 109723.5 112802.0 54014.0 56581.7 72638.6 90897.0 91044.0 51045.2 81477.2 83238.0 83645.0 85964.6 7279.2 7713.5 7804.0 8021.8 8051.3 33062.5 41400.4 47058.8 47291.1 48320.5 64018.7 64438.7 72238.6 72645.3 72991.6 9479.7 9637.7 9737.8 9861.6 9889.8 10681.9 10912.5 10972.5 11042.1 11109.2 10162.5 10231.2 10368.2 11370.4 11537.9 10637.5 12300.5 12591.9 12596.8 12946.4 10236.9 11504.1 11602.2 11628.2 11791.9 9897.8 10069.7 10138.2 10191.1 10497.7 9748.7 10268.5 10270.9 10278.1 10330.4 16:07:50 INFO - PROCESS | 3416 | -------- Summary: end -------- 16:07:50 INFO - PROCESS | 3416 | 16:07:51 INFO - TEST-INFO | 3416: exit 0 16:07:51 INFO - TEST-OK | dromaeo_css | took 1117229ms 16:07:51 INFO - TEST-START | kraken 16:07:51 INFO - operating with platform_type : linux_ 16:07:51 INFO - Initialising browser for kraken test... 16:07:51 INFO - TEST-INFO | started process 3654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcNRdvL/profile http://localhost:47384/getInfo.html) 16:07:56 INFO - PROCESS | 3654 | __metrics Screen width/height:1600/1200 16:07:56 INFO - PROCESS | 3654 | colorDepth:24 16:07:56 INFO - PROCESS | 3654 | Browser inner width/height: 1024/697 16:07:56 INFO - PROCESS | 3654 | __metrics 16:07:56 ERROR - PROCESS | 3654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 16:07:57 INFO - TEST-INFO | 3654: exit 0 16:07:57 INFO - Browser initialized. 16:07:57 INFO - Running cycle 1/1 for kraken test... 16:07:57 INFO - TEST-INFO | started process 3772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcNRdvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:09 INFO - PROCESS | 3772 | RSS: Main: 169869312 16:08:09 INFO - PROCESS | 3772 | 16:08:12 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47384/tests/kraken/driver.html?testName=audio-beat-detection) 16:08:13 INFO - PROCESS | 3772 | RSS: Main: 174960640 16:08:13 INFO - PROCESS | 3772 | 16:08:15 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47384/tests/kraken/driver.html?testName=audio-dft) 16:08:16 INFO - PROCESS | 3772 | RSS: Main: 174690304 16:08:16 INFO - PROCESS | 3772 | 16:08:19 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47384/tests/kraken/driver.html?testName=audio-fft) 16:08:20 INFO - PROCESS | 3772 | RSS: Main: 169312256 16:08:20 INFO - PROCESS | 3772 | 16:08:22 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47384/tests/kraken/driver.html?testName=audio-oscillator) 16:08:22 INFO - PROCESS | 3772 | RSS: Main: 169472000 16:08:22 INFO - PROCESS | 3772 | 16:08:25 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47384/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:08:25 INFO - PROCESS | 3772 | RSS: Main: 170020864 16:08:25 INFO - PROCESS | 3772 | 16:08:28 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47384/tests/kraken/driver.html?testName=imaging-darkroom) 16:08:29 INFO - PROCESS | 3772 | RSS: Main: 170668032 16:08:29 INFO - PROCESS | 3772 | 16:08:33 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47384/tests/kraken/driver.html?testName=imaging-desaturate) 16:08:33 INFO - PROCESS | 3772 | RSS: Main: 168353792 16:08:33 INFO - PROCESS | 3772 | 16:08:36 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47384/tests/kraken/driver.html?testName=json-parse-financial) 16:08:37 INFO - PROCESS | 3772 | RSS: Main: 169381888 16:08:37 INFO - PROCESS | 3772 | 16:08:39 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47384/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:08:39 INFO - PROCESS | 3772 | RSS: Main: 170213376 16:08:39 INFO - PROCESS | 3772 | 16:08:41 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:08:42 INFO - PROCESS | 3772 | RSS: Main: 170258432 16:08:42 INFO - PROCESS | 3772 | 16:08:44 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:08:45 INFO - PROCESS | 3772 | RSS: Main: 170622976 16:08:45 INFO - PROCESS | 3772 | 16:08:47 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:08:48 INFO - PROCESS | 3772 | RSS: Main: 170852352 16:08:48 INFO - PROCESS | 3772 | 16:08:51 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:08:52 INFO - PROCESS | 3772 | RSS: Main: 170516480 16:08:52 INFO - PROCESS | 3772 | 16:08:53 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:47384/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47384/tests/kraken/driver.html?testName=ai-astar) 16:08:54 INFO - PROCESS | 3772 | RSS: Main: 171704320 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | __start_tp_report 16:08:54 INFO - PROCESS | 3772 | _x_x_mozilla_page_load 16:08:54 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details 16:08:54 INFO - PROCESS | 3772 | |i|pagename|runs| 16:08:54 INFO - PROCESS | 3772 | |0;ai-astar;105;113;106;114;115;116;114;113;113;113 16:08:54 INFO - PROCESS | 3772 | |1;audio-beat-detection;148;122;148;188;124;154;157;123;182;124 16:08:54 INFO - PROCESS | 3772 | |2;audio-dft;162;163;162;168;166;163;162;163;163;163 16:08:54 INFO - PROCESS | 3772 | |3;audio-fft;75;76;76;154;77;76;77;76;156;78 16:08:54 INFO - PROCESS | 3772 | |4;audio-oscillator;86;85;141;86;86;86;138;86;85;138 16:08:54 INFO - PROCESS | 3772 | |5;imaging-gaussian-blur;118;119;118;118;117;118;119;118;119;117 16:08:54 INFO - PROCESS | 3772 | |6;imaging-darkroom;148;148;147;148;149;149;148;148;147;148 16:08:54 INFO - PROCESS | 3772 | |7;imaging-desaturate;95;95;96;95;96;96;96;95;95;95 16:08:54 INFO - PROCESS | 3772 | |8;json-parse-financial;65;66;66;66;70;64;64;65;65;66 16:08:54 INFO - PROCESS | 3772 | |9;json-stringify-tinderbox;65;65;65;65;64;65;65;64;66;67 16:08:54 INFO - PROCESS | 3772 | |10;stanford-crypto-aes;79;79;79;80;80;78;79;80;84;78 16:08:54 INFO - PROCESS | 3772 | |11;stanford-crypto-ccm;131;148;142;134;137;134;132;136;168;130 16:08:54 INFO - PROCESS | 3772 | |12;stanford-crypto-pbkdf2;172;170;166;170;166;169;171;173;169;174 16:08:54 INFO - PROCESS | 3772 | |13;stanford-crypto-sha256-iterative;68;69;69;68;69;67;68;68;67;67 16:08:54 INFO - PROCESS | 3772 | __end_tp_report 16:08:54 INFO - PROCESS | 3772 | __start_cc_report 16:08:54 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,999 16:08:54 INFO - PROCESS | 3772 | __end_cc_report 16:08:54 INFO - PROCESS | 3772 | __startTimestamp1467760134014__endTimestamp 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | ------- Summary: start ------- 16:08:54 INFO - PROCESS | 3772 | Number of tests: 14 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.50 stddev:3.68 (3.2%) stddev-sans-first:2.83 16:08:54 INFO - PROCESS | 3772 | Values: 105.0 113.0 106.0 114.0 115.0 116.0 114.0 113.0 113.0 113.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:151.00 stddev:24.30 (16.1%) stddev-sans-first:25.78 16:08:54 INFO - PROCESS | 3772 | Values: 148.0 122.0 148.0 188.0 124.0 154.0 157.0 123.0 182.0 124.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:1.96 (1.2%) stddev-sans-first:2.00 16:08:54 INFO - PROCESS | 3772 | Values: 162.0 163.0 162.0 168.0 166.0 163.0 162.0 163.0 163.0 163.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#3] audio-fft Cycles:10 Average:92.10 Median:76.00 stddev:33.16 (43.6%) stddev-sans-first:34.59 16:08:54 INFO - PROCESS | 3772 | Values: 75.0 76.0 76.0 154.0 77.0 76.0 77.0 76.0 156.0 78.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#4] audio-oscillator Cycles:10 Average:101.70 Median:86.00 stddev:25.76 (29.9%) stddev-sans-first:26.68 16:08:54 INFO - PROCESS | 3772 | Values: 86.0 85.0 141.0 86.0 86.0 86.0 138.0 86.0 85.0 138.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 16:08:54 INFO - PROCESS | 3772 | Values: 118.0 119.0 118.0 118.0 117.0 118.0 119.0 118.0 119.0 117.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:08:54 INFO - PROCESS | 3772 | Values: 148.0 148.0 147.0 148.0 149.0 149.0 148.0 148.0 147.0 148.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:08:54 INFO - PROCESS | 3772 | Values: 95.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.70 (2.6%) stddev-sans-first:1.79 16:08:54 INFO - PROCESS | 3772 | Values: 65.0 66.0 66.0 66.0 70.0 64.0 64.0 65.0 65.0 66.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 16:08:54 INFO - PROCESS | 3772 | Values: 65.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 66.0 67.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:1.71 (2.2%) stddev-sans-first:1.80 16:08:54 INFO - PROCESS | 3772 | Values: 79.0 79.0 79.0 80.0 80.0 78.0 79.0 80.0 84.0 78.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:136.50 stddev:11.49 (8.4%) stddev-sans-first:11.79 16:08:54 INFO - PROCESS | 3772 | Values: 131.0 148.0 142.0 134.0 137.0 134.0 132.0 136.0 168.0 130.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.50 stddev:2.67 (1.6%) stddev-sans-first:2.73 16:08:54 INFO - PROCESS | 3772 | Values: 172.0 170.0 166.0 170.0 166.0 169.0 171.0 173.0 169.0 174.0 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - PROCESS | 3772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 16:08:54 INFO - PROCESS | 3772 | Values: 68.0 69.0 69.0 68.0 69.0 67.0 68.0 68.0 67.0 67.0 16:08:54 INFO - PROCESS | 3772 | -------- Summary: end -------- 16:08:54 INFO - PROCESS | 3772 | 16:08:54 INFO - TEST-INFO | 3772: exit 0 16:08:55 INFO - TEST-OK | kraken | took 63605ms 16:08:55 INFO - SUITE-END | took 1180s 16:08:55 INFO - Completed test suite (00:19:41) 16:08:55 INFO - javascript benchmark 16:08:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6551.491120828143, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.0926180467736, 2685.7851371890256, 2705.4589082183556, 2705.7429544193305, 2720.3743139078024, 4751.311059896313, 4805.8798530036765, 4815.157347464193, 4894.070126675938, 4940.234263689125, 4705.717656940577, 4754.072955773626, 4764.5235476452335, 4783.258594917794, 4802.735849528274, 4346.261135606938, 4413.88965275869, 4429.9114017719785, 4467.463904331485, 4489.102179564084, 536.9351055063127, 4129.375891018526, 4342.522322544518, 4364.759938203398, 4409.338599210128, 4362.912741745179, 4364.847230346954, 4365.497967733703, 4373.103513779699, 4395.724746984496, 4343.19650864591, 4389.890252743675, 4394.78026098697, 4401.009772801126, 4427.734335939822, 4400.383946247496, 4457.621102206316, 4465.218586747306, 4484.304932735431, 4494.483134439549, 4848.612111031144, 4884.926726099111, 4897.3878265216845, 4898.608111351084, 4905.632077594195, 4986.4514903360605, 5079.466656001104, 5211.296474975868, 5279.577633789288, 5331.920021199685, 5112.156494178456, 5133.743312834344, 5138.614603904722, 5153.458886816868, 5223.451537588575, 4778.546038126373, 4787.281907713871, 4798.2802579613335, 4802.159622066124, 4820.469748327716, 5141.717205553656, 5211.557017653466, 5228.424873263938, 5239.29269548606, 5313.920291195635, 5062.924056139161, 5073.644844860898, 5090.796368145307, 5092.490750924878, 5104.3109180260935, 5145.691258524501, 5154.896902061938, 5172.939547392775, 5184.37787465499, 5196.428392876781, 4968.577670898014, 5092.134337162691, 5100.974495127501, 5124.359455068116, 5159.122949098587, 5120.948790512121, 5139.280500729901, 5150.639455238097, 5162.664426812245, 5164.638475306768, 4350.60844523988, 4351.173277077345, 4357.67317451186, 4385.3641222022625, 4401.867943961686, 3685.760425572329, 3705.7405981581032, 3717.8141092945784, 3719.628037196313, 3758.4550240215563, 4355.542668019875, 4373.431453910971, 4399.428074350378, 4443.977780111079, 4477.28363461851, 5183.974080129575, 5186.884819763769, 5193.350831146106, 5198.610104242197, 5206.114960456732, 4283.935740963888, 4337.956620433818, 4357.520672725997, 4399.252127138394, 4454.4877339106415, 4589.931151032737, 4592.2422800238255, 4599.103174880866, 4602.677812553089, 4609.101225261042, 4804.039192161512, 4811.254255590389, 4846.224604063333, 4859.659823812299, 4913.606911447004, 5056.544910957884, 5204.0892843752945, 5217.452167522356, 5220.869478263074, 5311.521963023347, 4951.529604687549, 4973.328600638867, 4981.1283025469675, 4983.152864013199, 5032.798688052437, 5191.143461328838, 5194.091034069098, 5197.324347834758, 5203.427622961547, 5205.167173252262, 5082.949170508396, 5084.923726144037, 5108.719020453911, 5126.102931986813, 5137.255098010843, 4956.8760780980765, 5006.574441172541, 5010.799568017384, 5012.949870501248, 5047.091523525801, 4800.159972004955, 4937.864291213113, 4983.377077865267, 4991.0, 5037.596992240538, 4840.080384726891, 4898.4121905371585, 4901.1913034350355, 4911.901761964812, 4943.678660887031, 5053.267276244997, 5060.873478163076, 5072.9746351268, 5076.238564215398, 5120.641555091257, 4815.061063092663, 4861.565838077705, 4934.975325123495, 4950.653454258168, 5006.023825354021], "value": 4691.418998943538, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.954243660507, 581.293728120334, 581.8050952930768, 599.1731410653299, 620.6648409858676, 35501.46747798782, 39067.0, 39070.6325278615, 39093.80453097737, 39116.0, 38981.0, 39408.408873866916, 39524.60475395245, 39545.209095818136, 39555.40666889999, 7616.733414330513, 7851.528908265494, 7856.882146767803, 7865.331446826998, 7867.0, 7764.767056988299, 7773.805654858617, 7813.140554539024, 7833.412494062968, 7857.567833769141, 7780.8832867507035, 7827.569483678395, 7850.371970242395, 7881.921180788176, 7883.881741773878, 7797.454178207528, 7830.921690783133, 7837.725679601243, 7856.960715196445, 7857.0, 7724.691012359499, 7771.883421748678, 7788.182240864684, 7794.649240784178, 7808.063032436087, 37030.0, 37186.62813371859, 37453.81273093644, 37539.249215015545, 37574.624253757385, 2331.440454290975, 2823.9294017649518, 2826.51607905849, 2950.8967186148384, 3051.5422686596967, 26508.60237096445, 28155.0, 28302.575461368095, 29729.0, 30820.2294942626, 3286.4905939579403, 3319.5684561007156, 3345.0, 3350.5811773528308, 3439.8968030959113, 234354.0, 235223.0, 235729.0, 236698.0, 237516.0, 31434.84282578618, 31695.683043169272, 31709.365812683616, 31748.365032699217, 31843.84078079595, 32369.51445728316, 33084.0, 33344.49949752267, 34874.12814679653, 34924.825375872955, 14062.507812226522, 14306.427742890168, 14310.785338219936, 14343.713125737428, 14345.282735863166, 10618.09746171584, 10660.520276587573, 10748.140148788078, 10768.246222764332, 10808.135349172047, 18177.818221817877, 18292.176852041423, 18298.359557415428, 18367.72448413275, 18419.447416577525, 6720.294369091175, 6824.6928888200155, 6870.62211578368, 6880.69036893341, 6943.89584156238, 813.4631143445416, 891.1311471315415, 900.1223806788329, 940.722486866376, 1023.4166525080782, 26577.601335979976, 28512.85743571269, 28549.71450285512, 28749.425011499654, 28793.0, 937.6015193542717, 980.475445636581, 980.9117179453883, 1028.290479569095, 1041.953112109957, 14720.263986800832, 14750.0, 14777.408903643734, 14820.3330850112, 14895.180765058027, 406739.0, 408785.0, 409326.0, 409942.0, 411886.0, 48666.75666621644, 48667.0, 49067.0, 49153.0, 49295.0, 1169.6783384569142, 1185.3065956415421, 1190.3215167354524, 1216.4951545108859, 1222.3949145173196, 26105.347366315233, 27113.0, 27173.456530868876, 27572.58641120425, 27870.3032424191, 40658.1868362637, 40733.0, 40827.38758918678, 41306.0, 41368.586314136475, 266550.0, 267212.0, 267593.0, 268097.0, 269430.0, 24652.0, 24833.255002349957, 24941.0, 25066.37334066663, 25076.498470030863, 40570.59429405668, 40711.389329159494, 41407.0, 41802.163956720084, 42073.0, 33589.0, 36045.45931810972, 36877.44683829691, 37009.81495092615, 37266.8136659315, 36002.4599631011, 36237.818810905774, 36297.0, 36947.261054779294, 37135.25729485449, 31700.36599268048, 32008.19979500438, 35131.824340878135, 35453.0, 35822.28355432929, 31108.688913110578, 32777.344453111284, 33135.834320829206, 33203.50194747129, 33217.0, 25112.37219069538, 25177.0, 25536.616950746124, 25624.61563076518, 25969.48061038731], "value": 16813.252963352308, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.17635760433024, 371.6952099278592, 375.76514678326043, 383.78316251318023, 390.47871092092055, 16423.671526569462, 17152.228149733262, 17284.740728889075, 17538.0, 17595.12024398778, 17162.485125446256, 17424.651506969854, 17489.65020699585, 18431.44705658829, 18434.0, 5670.007748643991, 5817.389174136718, 5863.442972917566, 5882.088276317178, 5892.263467066617, 5741.110127930177, 5823.621464604808, 5851.414858514136, 5880.3825598312205, 5881.588288819784, 5633.0, 5787.074068149076, 5798.2172406725185, 5816.621919575236, 5877.2065771121, 5718.828435146952, 5802.622829516068, 5891.469767720926, 5891.64650120992, 5899.616524925909, 5451.563874889999, 5669.348024977139, 5679.858003549944, 5696.743646535916, 5723.112917497753, 23995.520089598285, 24183.87908060466, 24797.256082317377, 24884.129055483154, 25133.24600261977, 2070.6272870883236, 2073.8651987620756, 2104.400245929918, 2135.29535253366, 2162.416147640128, 14807.70384592302, 14869.479568215169, 15210.239488025554, 15258.542243732594, 15534.766978495332, 1931.0730849192325, 1951.1414977409895, 1960.127743154297, 1962.8135327144041, 1995.6906679464705, 64421.0, 70823.04238703293, 75403.0, 79337.60331198365, 80705.59647201785, 16338.222502174658, 16921.323147073977, 17044.829551704323, 17180.91409542944, 17316.740248896276, 30200.395992080474, 30351.848240758656, 30587.388252234832, 30628.69371306303, 30713.846430767702, 8629.395942284105, 8833.911660883437, 8886.186843141297, 8957.820843583091, 9080.500572468445, 7095.184053833772, 7140.678669459887, 7201.89197162043, 7227.1327440707455, 7310.780676579711, 8405.0, 8435.312937412542, 8520.957395212985, 8555.075108100753, 8557.0, 3363.983180084084, 3458.654134586521, 3542.362374772514, 3640.8543658253375, 3681.159420289855, 803.5098589860181, 841.5539763925129, 850.0988951711082, 901.0898992018109, 927.823713494434, 17116.0, 17861.106944652714, 18085.638287234182, 18237.54406139857, 18264.945136210303, 833.1876420489974, 838.2288294768828, 857.5540718826176, 860.5611138319377, 866.1468453573225, 10119.291649584458, 10146.340487868265, 10224.233182511342, 10261.538230779634, 10287.382757034602, 350493.0, 353763.0, 356338.0, 370768.0, 375653.0, 60722.392776071676, 78439.60780196062, 80021.0, 81288.59355703302, 81561.59219203866, 887.942283751567, 893.0622846011662, 903.6566104880103, 908.2370808520874, 918.334207699426, 15971.12158831229, 16187.919060404623, 16350.0, 16473.176341183134, 16856.15719214059, 35988.4601730969, 36900.446493302086, 37396.43905341368, 38801.223975519766, 39081.218375632896, 51085.0, 51593.226101607754, 52647.0, 52903.20645190402, 53004.73497632487, 6827.761028363983, 7165.677544510614, 7495.925040749523, 7886.763397098096, 7943.086545047394, 11612.767744645229, 12305.0, 12472.251664900135, 12613.36933153357, 12745.490180393052, 10293.845592316271, 10602.681919542427, 10766.95651308267, 10770.515326810155, 10813.29713568647, 10350.327228730108, 10389.9480502597, 10551.94724026375, 10608.522616482123, 10822.188335874998, 9180.908190918006, 9187.862182067141, 10231.897681023094, 10441.791164176826, 10567.260291779501, 7413.258674132544, 7791.649375778217, 7897.644605992629, 7988.680452781824, 8209.09699932995, 8259.545724985184, 10332.328398654063, 10691.305065171051, 10711.464426778786, 10720.678379648623], "value": 9307.668006621172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.9728405431892, 1412.0186470403069, 1497.1915165810462, 1702.1659386900408, 1729.9308027678894, 6829.795106146811, 7479.0, 7571.848563028743, 8059.7179098731485, 8068.233517815813, 7618.809529761758, 7934.801629959254, 7950.1652326505755, 7951.244631759988, 7991.041075070985, 2215.944601384966, 2242.8542144760618, 2249.5725812095648, 2257.1761307122865, 2266.3314322274887, 2242.4169715873827, 2244.4837687331924, 2281.5094754627753, 2288.0733303012307, 2292.4727312718087, 2217.9001944912516, 2229.9331020069344, 2237.038073628339, 2241.551689662066, 2252.6621006849023, 2169.8155656769113, 2173.445771328317, 2178.803907648319, 2179.204590324536, 2179.226374637005, 2185.093186327672, 2191.4411824984686, 2199.1093607089156, 2200.460887082659, 2201.1635578480236, 7935.0, 8003.399745019147, 8025.799355016113, 8028.4781489203015, 8041.718539851136, 4494.9775251123865, 4655.720656760605, 4661.650376221797, 4666.090112428078, 4681.040386720714, 2826.5336219523756, 2967.4806908791093, 2979.61265035544, 2997.715217054398, 3001.5347621118544, 932.4591736792644, 957.0716405087054, 968.8546717992288, 997.0777031246141, 1002.158187122813, 10854.403007834566, 10885.510152043098, 10898.782024359547, 10902.5093870776, 10930.125589952784, 4095.6313931746286, 4190.790460476964, 4363.6072753452345, 4412.580804823537, 4413.0, 9438.0, 9450.810983780286, 9460.52697365129, 9461.621535138518, 9470.431774093438, 4594.88512787183, 4604.7927843247135, 4612.469565999953, 4636.4899861015265, 4638.5593368629925, 3479.7042251408916, 4107.301758701028, 4147.232761939051, 4165.604267594574, 4240.618344349024, 3708.072981754561, 3728.627137286304, 3830.4062870255157, 3887.688984881203, 3958.6041395860184, 1196.8085106382937, 1228.3673907937418, 1236.9257844529357, 1242.8260043593905, 1245.1781823996118, 697.2191145916504, 774.9457537972288, 806.3106044332012, 817.894418168376, 822.8560001999626, 5115.64190506661, 5150.047241260304, 5179.507946745053, 5307.814226502054, 5344.679319240858, 403.8303912356817, 426.0541597653205, 430.8298222202213, 848.4951453884929, 936.0405584276172, 3379.4930760386137, 3546.556680414948, 3577.409727395003, 3591.102224443889, 3593.874214402483, 9602.519874006271, 9883.752906177404, 9976.950115249378, 9979.850302245472, 9987.750306242402, 9701.854472182922, 9838.262130340254, 9851.359661621971, 9886.505674716236, 9915.355501892354, 7325.304096110861, 7497.887531687029, 7513.812154696067, 7515.549067055994, 7520.699172033167, 4931.753412329297, 4998.225275082368, 5104.081265372269, 5128.974355128201, 5144.614153938394, 9253.537323133682, 9269.119433653792, 9340.299477539347, 9340.626374944926, 9379.859302110337, 8630.78423039429, 8879.955600221958, 8895.199432051146, 9187.77030574241, 9352.719418417459, 6002.159697642421, 6575.868482630416, 6671.199456065303, 6740.9325906740305, 6793.320667933167, 7644.044494438195, 7670.539767613961, 7687.654055567625, 7711.1517733048195, 7753.0, 6829.863402732017, 6849.31506849331, 6870.519063665695, 6905.0, 7107.253738357605, 6870.587764734132, 6967.54710943787, 6984.476164287597, 7025.789226323219, 7107.893381599177, 6170.660613666291, 6206.844828879314, 6225.066240064027, 6314.968425158028, 6334.746610135728, 4340.565943405634, 4418.160549495586, 4430.069685366109, 4478.104379124123, 4516.503184649751, 4462.0, 4463.843765468193, 4495.393121928498, 4532.342810292424, 4534.365188873494], "value": 4146.05819288055, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2796546340588, 304.75771761449647, 306.1183790682834, 308.02970642476214, 308.3078488792661, 5070.898582028357, 5076.746162691865, 5078.0, 5130.256112863633, 5142.588592912567, 5038.470960549144, 5060.898782024357, 5066.620003499734, 5083.686922450285, 5096.362954630671, 3754.549454065516, 3886.514185726784, 3971.3248747712814, 3977.403389491585, 3995.4805875236325, 3966.464527288808, 3968.365061590146, 3974.701897357695, 3991.501062367204, 4008.8196031178522, 3960.544537378195, 3970.563238043813, 4011.5186177658575, 4012.1775036117524, 4015.6185162409524, 3665.248624032067, 3884.1066554692297, 3911.1395492991783, 4005.3991901214904, 4011.3782363733667, 3402.4726167444087, 3405.3700065487965, 3414.9487757683655, 3416.1118109291515, 3417.2652879631, 4925.975370123162, 4959.305697202359, 4966.87582810429, 4968.403791545002, 4974.253861920704, 4232.984083819892, 4474.261746811772, 4494.37078808967, 4502.302143167814, 4524.954750452486, 5242.292290540767, 5243.842684719464, 5265.341832270966, 5265.868353291198, 5278.155495120801, 3687.8524859005875, 3704.981475092607, 3723.590405055442, 3732.5520937487404, 3743.326201283795, 5343.973280133613, 5495.148252020943, 5528.364238112588, 5531.751071201806, 5563.471470210324, 3783.281176576442, 3832.559255685632, 3834.1181528248103, 3835.0, 3838.213166300902, 3800.9429858552144, 3849.6535311821513, 3853.0560012797046, 3854.0, 3879.80600969956, 4427.380166776654, 4470.776461176928, 4493.663295086602, 4503.301988191835, 4536.977315113403, 5218.999075531585, 5273.736313184326, 5299.5760339172775, 5335.199720042025, 5394.165983565606, 1334.2394834944182, 1339.4462423588784, 1350.8784209421199, 1356.959291221265, 1362.9795553066713, 845.3913182508584, 854.3122786157079, 867.2584939876441, 870.7387783664875, 887.2591386192602, 4500.302453119772, 4516.774161291923, 4552.317152427162, 4553.089382123589, 4559.133764584718, 5338.199270109515, 5370.167624018283, 5403.297961142306, 5412.648177868426, 5419.4283657738815, 4359.607635312837, 4540.523245059288, 4542.273236282179, 4545.636349092065, 4545.749983750926, 2894.8697308621163, 2920.707929207062, 2946.6169397978124, 2953.4093181363814, 2957.024182019928, 5116.0, 5116.2372318947355, 5146.279520867081, 5181.274621552986, 5207.635465517453, 5320.388155362106, 5551.694656793834, 5561.499465048084, 5584.760838713536, 5615.0, 5141.640085194001, 5160.200168973815, 5168.7415629218385, 5193.195054766517, 5199.376074870888, 5483.150111732688, 5488.807891723771, 5499.752511136929, 5524.14375771756, 5547.140193270049, 5210.5150032242145, 5281.709505977208, 5371.63647994881, 5373.032854086146, 5377.758000890048, 5151.5363617274625, 5178.922316165336, 5184.185535062697, 5186.377634683862, 5189.636725429184, 3829.8659546915724, 3846.115393459464, 3861.0347413146715, 3867.864624738233, 3869.477620521194, 5193.961207758539, 5567.972160139173, 5571.3871474137, 5589.875847178047, 5614.24207731951, 5397.136458166831, 5425.348958125051, 5435.266239057834, 5435.945640543702, 5454.0, 5166.819161329336, 5349.57203423733, 5357.866053348697, 5362.329708786402, 5377.247185394126, 5285.418603953639, 5288.312519372457, 5294.682319060868, 5299.258103865385, 5303.973480132575, 5133.948660513496, 5239.397469291081, 5357.812476563302, 5382.9192562112385, 5424.53891419218, 5232.738363081755, 5274.841754747364, 5283.445238250082, 5287.867803304948, 5289.153735402318], "value": 3986.1454647370833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3674182835169, 568.3691102875807, 570.4352690836074, 594.064348650875, 656.8587753632968, 12087.335196564185, 13268.402921868515, 13295.202287862723, 13438.395272212749, 13965.301734913264, 14222.928885355559, 14376.209308488029, 14432.5670229893, 14463.5660930172, 14502.274886255698, 628.2366924187112, 717.8815495443246, 739.26443189027, 739.5082270290251, 764.5680190692269, 779.1079214299624, 781.0900301149154, 784.8077221080844, 787.9369650427981, 794.2772077409559, 829.0590180145518, 831.9708810191645, 835.3985130705912, 836.6235194162621, 839.8866153069349, 826.1944604011101, 830.5888585150329, 832.2925513313695, 832.9791755206138, 834.6119054639591, 602.6022824935566, 607.2227548737579, 608.5253502268238, 610.8381278961078, 611.5291225756188, 12467.438965246585, 12540.0, 12542.68643283916, 12601.810972835416, 12628.0, 12998.935005324913, 13038.934805326007, 13354.933225333909, 13449.462021519128, 13668.863311366958, 10007.549660265306, 10131.594736210543, 10303.433311167882, 10357.948210258975, 10488.05607495329, 3283.819389933553, 3292.7530435217213, 3331.53358529806, 3357.9328413431595, 3365.3101114271517, 66671.33328666748, 68936.3106368935, 70227.29772702258, 70283.29716702818, 70802.0, 10036.24728145392, 10040.290650477344, 10178.389296642225, 10368.326058806153, 10445.68662940113, 19257.711134332996, 19358.612827743647, 19359.12883920227, 19458.124384402738, 19587.706184407245, 6924.515283930177, 6969.16370035599, 7008.649567521604, 7017.368436840607, 7100.644967751592, 3812.199438118026, 3821.426785982125, 3824.904377390532, 3926.764394136304, 3936.0356712605594, 3020.1845501714415, 3121.063680895722, 3132.545780861762, 3147.4806656901815, 3155.4162479941283, 479.6738218011786, 496.09215136300486, 501.78674063522857, 502.9647924645313, 505.7167985927892, 537.1486194381948, 542.6798189068469, 545.26661640094, 548.281750906306, 585.6778771675562, 8176.6320515576945, 8224.62989165477, 8264.752057438287, 8334.83330333402, 8440.11378805229, 523.5314393617691, 524.7320753598308, 537.7230726176023, 542.4765101676901, 551.7875617887142, 3720.497732806091, 3797.696184305249, 3984.7808370539897, 4109.753414795122, 4119.855805046869, 106690.0, 109554.0, 109682.0, 109723.45138274257, 112802.0, 54014.0, 56581.7170914151, 72638.63680681668, 90897.0, 91044.0, 51045.23432148521, 81477.18522814696, 83238.0, 83645.0, 85964.57017714746, 7279.235680253709, 7713.537187768752, 7804.0, 8021.759347219593, 8051.275385215359, 33062.5040624386, 41400.37899431451, 47058.76470617625, 47291.14528655764, 48320.516794833005, 64018.67990660017, 64438.67780661066, 72238.63880680563, 72645.27354726597, 72991.63504182658, 9479.715608531755, 9637.662681806103, 9737.756556086155, 9861.605535778488, 9889.802203956024, 10681.946590266998, 10912.454377280945, 10972.451377431256, 11042.116630669689, 11109.166812489257, 10162.491875406347, 10231.181505479693, 10368.222383321432, 11370.374629395132, 11537.88462115368, 10637.468126593794, 12300.50797968107, 12591.93704031474, 12596.796594758274, 12946.41741121633, 10236.897631023892, 11504.137189710638, 11602.245854019462, 11628.18602697803, 11791.941040295087, 9897.802043959224, 10069.748256293358, 10138.239632027775, 10191.133753630727, 10497.685069447929, 9748.707538773848, 10268.486575671335, 10270.948645256725, 10278.126359259248, 10330.380177189392], "value": 6516.4023625040945, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 106.0, 114.0, 115.0, 116.0, 114.0, 113.0, 113.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 148.0, 188.0, 124.0, 154.0, 157.0, 123.0, 182.0, 124.0], "value": 147.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 168.0, 166.0, 163.0, 162.0, 163.0, 163.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 154.0, 77.0, 76.0, 77.0, 76.0, 156.0, 78.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 141.0, 86.0, 86.0, 86.0, 138.0, 86.0, 85.0, 138.0], "value": 101.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 119.0, 117.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 148.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 70.0, 64.0, 64.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 66.0, 67.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 80.0, 78.0, 79.0, 80.0, 84.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 148.0, 142.0, 134.0, 137.0, 134.0, 132.0, 136.0, 168.0, 130.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 166.0, 170.0, 166.0, 169.0, 171.0, 173.0, 169.0, 174.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 69.0, 67.0, 68.0, 68.0, 67.0, 67.0], "value": 68.0, "unit": "score"}]}]} 16:08:55 INFO - Return code: 0 16:08:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:08:55 ERROR - # TBPL SUCCESS # 16:08:55 INFO - Running post-action listener: _resource_record_post_action 16:08:55 INFO - ##### 16:08:55 INFO - ##### Finished run-tests step (success) 16:08:55 INFO - ##### 16:08:55 INFO - Running post-run listener: _resource_record_post_run 16:08:55 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7778304; Write bytes: 394919936; Read time: 1688; Write time: 367088 16:08:55 INFO - TinderboxPrint: CPU usage
13.3% 16:08:55 INFO - TinderboxPrint: I/O read bytes / time
7,778,304 / 1,688 16:08:55 INFO - TinderboxPrint: I/O write bytes / time
394,919,936 / 367,088 16:08:55 INFO - TinderboxPrint: CPU idle
8,288.0 (86.7%) 16:08:55 INFO - TinderboxPrint: CPU user
1,217.0 (12.7%) 16:08:55 INFO - TinderboxPrint: Swap in / out
0 / 0 16:08:55 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 21307392; Read time: 12; Write time: 4424 16:08:55 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5746688; Write bytes: 285020160; Read time: 1356; Write time: 263956 16:08:55 INFO - Running post-run listener: _upload_blobber_files 16:08:55 INFO - Blob upload gear active. 16:08:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:08:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:08:56 INFO - (blobuploader) - INFO - Open directory for files ... 16:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:56 INFO - (blobuploader) - INFO - Done attempting. 16:08:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:08:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:08:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:08:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:08:57 INFO - (blobuploader) - INFO - Done attempting. 16:08:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:08:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:08:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:01 INFO - (blobuploader) - INFO - Done attempting. 16:09:01 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:01 INFO - Return code: 0 16:09:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc4d612fe0c71db72ccffc494ceef66489852134337a44c42c4a3bb71cd0165758086bca3095eee2bd3042c9d236c9cf59ecbc36bbd8d59df3dffe4bc99625b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb71f421a2867844f96d5de991b89c2b571306f57619b65dae0c6e3202f56bd6b9884a7ed54c8fd76def9b593d4547663ec640852fd64ae775feed67fa3212f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9173d4e8e819d953281611075d5346fb2000df0aace6f0787688608a9e1f6a5d2865498c09a40858ee76c770cd6c3a16233c9e007cfaa07e604908b209f3ac3c"} 16:09:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:01 INFO - Contents: 16:09:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc4d612fe0c71db72ccffc494ceef66489852134337a44c42c4a3bb71cd0165758086bca3095eee2bd3042c9d236c9cf59ecbc36bbd8d59df3dffe4bc99625b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb71f421a2867844f96d5de991b89c2b571306f57619b65dae0c6e3202f56bd6b9884a7ed54c8fd76def9b593d4547663ec640852fd64ae775feed67fa3212f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9173d4e8e819d953281611075d5346fb2000df0aace6f0787688608a9e1f6a5d2865498c09a40858ee76c770cd6c3a16233c9e007cfaa07e604908b209f3ac3c"} 16:09:01 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:01 INFO - Copying logs to upload dir... 16:09:01 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.750451 ========= master_lag: -0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2016-07-05 16:09:01.491042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:01.495052) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc4d612fe0c71db72ccffc494ceef66489852134337a44c42c4a3bb71cd0165758086bca3095eee2bd3042c9d236c9cf59ecbc36bbd8d59df3dffe4bc99625b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb71f421a2867844f96d5de991b89c2b571306f57619b65dae0c6e3202f56bd6b9884a7ed54c8fd76def9b593d4547663ec640852fd64ae775feed67fa3212f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9173d4e8e819d953281611075d5346fb2000df0aace6f0787688608a9e1f6a5d2865498c09a40858ee76c770cd6c3a16233c9e007cfaa07e604908b209f3ac3c"} build_url:https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/VVxlJti2Sg-l_u9uT0k_IA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cc4d612fe0c71db72ccffc494ceef66489852134337a44c42c4a3bb71cd0165758086bca3095eee2bd3042c9d236c9cf59ecbc36bbd8d59df3dffe4bc99625b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fb71f421a2867844f96d5de991b89c2b571306f57619b65dae0c6e3202f56bd6b9884a7ed54c8fd76def9b593d4547663ec640852fd64ae775feed67fa3212f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9173d4e8e819d953281611075d5346fb2000df0aace6f0787688608a9e1f6a5d2865498c09a40858ee76c770cd6c3a16233c9e007cfaa07e604908b209f3ac3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:01.521836) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:01.522198) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1467758736.536487-1403615737 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.30 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 16:09:01.827973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 16:09:01.828296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 16:09:01.831988) ========= ========= Total master_lag: 0.38 =========