builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1467635220.79 results: success (0) buildid: 20160704043125 builduid: 228a179bac024db4ae273ccf6b2ab3ed revision: 99b859906a9ca1e86c31415f98c1f8094c4f67d5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:00.786803) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:00.787264) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:00.787556) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:00.868151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:00.868445) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 05:27:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-07-04 05:27:02 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174619 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:01.063686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:01.064012) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018704 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:01.124393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 05:27:01.124820) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 99b859906a9ca1e86c31415f98c1f8094c4f67d5 --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 99b859906a9ca1e86c31415f98c1f8094c4f67d5 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 05:27:03,021 truncating revision to first 12 chars 2016-07-04 05:27:03,021 Setting DEBUG logging. 2016-07-04 05:27:03,021 attempt 1/10 2016-07-04 05:27:03,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/99b859906a9c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 05:27:04,206 unpacking tar archive at: fx-team-99b859906a9c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.550002 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 05:27:02.688843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:02.689182) ========= script_repo_revision: 99b859906a9ca1e86c31415f98c1f8094c4f67d5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:02.689638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:02.689922) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 05:27:02.699678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-04 05:27:02.700080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:27:04 INFO - MultiFileLogger online at 20160704 05:27:04 in /builds/slave/test 05:27:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:27:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:04 INFO - {'append_to_log': False, 05:27:04 INFO - 'base_work_dir': '/builds/slave/test', 05:27:04 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:27:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:04 INFO - 'branch': 'Fx-Team-Non-PGO', 05:27:04 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:04 INFO - 'config_files': ('talos/linux_config.py',), 05:27:04 INFO - 'default_actions': ('clobber', 05:27:04 INFO - 'read-buildbot-config', 05:27:04 INFO - 'download-and-extract', 05:27:04 INFO - 'populate-webroot', 05:27:04 INFO - 'create-virtualenv', 05:27:04 INFO - 'install', 05:27:04 INFO - 'run-tests'), 05:27:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:04 INFO - 'download_minidump_stackwalk': True, 05:27:04 INFO - 'download_symbols': 'ondemand', 05:27:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:04 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:04 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:04 INFO - 'installer_path': 'installer.exe', 05:27:04 INFO - 'log_level': 'info', 05:27:04 INFO - 'log_name': 'talos', 05:27:04 INFO - 'log_to_console': True, 05:27:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:27:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:27:04 INFO - 'opt_config_files': (), 05:27:04 INFO - 'pip_index': False, 05:27:04 INFO - 'sps_profile': False, 05:27:04 INFO - 'sps_profile_interval': 0, 05:27:04 INFO - 'suite': 'dromaeojs', 05:27:04 INFO - 'system_bits': '32', 05:27:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:04 INFO - 'title': 'talos-linux64-ix-006', 05:27:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:04 INFO - 'use_talos_json': True, 05:27:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:04 INFO - 'work_dir': 'build'} 05:27:04 INFO - ##### 05:27:04 INFO - ##### Running clobber step. 05:27:04 INFO - ##### 05:27:04 INFO - Running pre-action listener: _resource_record_pre_action 05:27:04 INFO - Running main action method: clobber 05:27:04 INFO - rmtree: /builds/slave/test/build 05:27:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:05 INFO - Running post-action listener: _resource_record_post_action 05:27:05 INFO - ##### 05:27:05 INFO - ##### Finished clobber step (success) 05:27:05 INFO - ##### 05:27:05 INFO - ##### 05:27:05 INFO - ##### Running read-buildbot-config step. 05:27:05 INFO - ##### 05:27:05 INFO - Running pre-action listener: _resource_record_pre_action 05:27:05 INFO - Running main action method: read_buildbot_config 05:27:05 INFO - Using buildbot properties: 05:27:05 INFO - { 05:27:05 INFO - "project": "", 05:27:05 INFO - "product": "firefox", 05:27:05 INFO - "script_repo_revision": "production", 05:27:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:27:05 INFO - "repository": "", 05:27:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:27:05 INFO - "buildid": "20160704043125", 05:27:05 INFO - "pgo_build": "False", 05:27:05 INFO - "basedir": "/builds/slave/test", 05:27:05 INFO - "buildnumber": 1927, 05:27:05 INFO - "slavename": "talos-linux64-ix-006", 05:27:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:27:05 INFO - "platform": "ubuntu64_hw", 05:27:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:27:05 INFO - "branch": "fx-team", 05:27:05 INFO - "repo_path": "integration/fx-team", 05:27:05 INFO - "revision": "99b859906a9ca1e86c31415f98c1f8094c4f67d5", 05:27:05 INFO - "stage_platform": "linux64", 05:27:05 INFO - "builduid": "228a179bac024db4ae273ccf6b2ab3ed", 05:27:05 INFO - "slavebuilddir": "test" 05:27:05 INFO - } 05:27:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:27:05 INFO - Running post-action listener: _resource_record_post_action 05:27:05 INFO - ##### 05:27:05 INFO - ##### Finished read-buildbot-config step (success) 05:27:05 INFO - ##### 05:27:05 INFO - ##### 05:27:05 INFO - ##### Running download-and-extract step. 05:27:05 INFO - ##### 05:27:05 INFO - Running pre-action listener: _resource_record_pre_action 05:27:05 INFO - Running main action method: download_and_extract 05:27:05 INFO - mkdir: /builds/slave/test/build/tests 05:27:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:05 INFO - https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:27:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:27:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:27:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:16 INFO - Downloaded 1361 bytes. 05:27:16 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:27:16 INFO - Using the following test package requirements: 05:27:16 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:27:16 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:27:16 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:27:16 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'jsshell-linux-x86_64.zip'], 05:27:16 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:27:16 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:27:16 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:27:16 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:27:16 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:27:16 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:27:16 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:27:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:16 INFO - https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:20 INFO - Downloaded 22709741 bytes. 05:27:20 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'] 05:27:20 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 05:27:21 INFO - Return code: 0 05:27:21 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 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:21 INFO - https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:27:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:27:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:27:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:26 INFO - Downloaded 22709741 bytes. 05:27:26 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'] 05:27:26 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 05:27:27 INFO - Return code: 0 05:27:27 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')]} 05:27:27 INFO - https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:27:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:27:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:27:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:29 INFO - Downloaded 14403333 bytes. 05:27:29 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'] 05:27:29 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 05:27:29 INFO - Return code: 0 05:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:29 INFO - https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YiqlF4U3QyCfT-aWPbuY6g/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 05:27:30 INFO - Downloaded 56481853 bytes. 05:27:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:27:30 INFO - mkdir: /builds/slave/test/properties 05:27:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:30 INFO - Contents: 05:27:30 INFO - build_url:https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:27:31 INFO - Running post-action listener: _resource_record_post_action 05:27:31 INFO - Running post-action listener: set_extra_try_arguments 05:27:31 INFO - ##### 05:27:31 INFO - ##### Finished download-and-extract step (success) 05:27:31 INFO - ##### 05:27:31 INFO - ##### 05:27:31 INFO - ##### Running populate-webroot step. 05:27:31 INFO - ##### 05:27:31 INFO - Running pre-action listener: _resource_record_pre_action 05:27:31 INFO - Running main action method: populate_webroot 05:27:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:31 INFO - '--tppagecycles', 05:27:31 INFO - '7'], 05:27:31 INFO - 'tests': ['tsvgm']}}, 05:27:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['damp', 'tps']}, 05:27:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'tests': ['damp', 'tps']}, 05:27:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['dromaeo_dom']}, 05:27:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['basic_compositor_video']}, 05:27:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['a11yr', 05:27:31 INFO - 'ts_paint', 05:27:31 INFO - 'tpaint', 05:27:31 INFO - 'sessionrestore', 05:27:31 INFO - 'sessionrestore_no_auto_restore', 05:27:31 INFO - 'tabpaint']}, 05:27:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['tsvgx', 05:27:31 INFO - 'tsvgr_opacity', 05:27:31 INFO - 'tart', 05:27:31 INFO - 'tscrollx', 05:27:31 INFO - 'cart']}, 05:27:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:31 INFO - 'tsvgr_opacity', 05:27:31 INFO - 'tart', 05:27:31 INFO - 'tscrollx', 05:27:31 INFO - 'cart']}, 05:27:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'talos_options': ['--disable-e10s'], 05:27:31 INFO - 'tests': ['tp5o']}, 05:27:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'tests': ['tp5o']}, 05:27:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'talos_options': ['--disable-e10s', 05:27:31 INFO - '--xperf_path', 05:27:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:31 INFO - 'tests': ['tp5n']}, 05:27:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:27:31 INFO - 'talos_options': ['--xperf_path', 05:27:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:31 INFO - 'tests': ['tp5n']}}, 05:27:31 INFO - 'talos.zip': {'path': '', 05:27:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:31 INFO - Running post-action listener: _resource_record_post_action 05:27:31 INFO - ##### 05:27:31 INFO - ##### Finished populate-webroot step (success) 05:27:31 INFO - ##### 05:27:31 INFO - ##### 05:27:31 INFO - ##### Running create-virtualenv step. 05:27:31 INFO - ##### 05:27:31 INFO - Running pre-action listener: _resource_record_pre_action 05:27:31 INFO - Running main action method: create_virtualenv 05:27:31 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:31 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 05:27:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:31 INFO - Using real prefix '/usr' 05:27:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:34 INFO - Installing pip.................done. 05:27:34 INFO - Return code: 0 05:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:34 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 05:27:34 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 05:27:34 INFO - Using env: {'DISPLAY': ':0', 05:27:34 INFO - 'HOME': '/home/cltbld', 05:27:34 INFO - 'LANG': 'en_US.UTF-8', 05:27:34 INFO - 'LANGUAGE': 'en_US:en', 05:27:34 INFO - 'LOGNAME': 'cltbld', 05:27:34 INFO - 'MAIL': '/var/mail/cltbld', 05:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:34 INFO - 'MOZ_NO_REMOTE': '1', 05:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:34 INFO - 'NO_EM_RESTART': '1', 05:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:34 INFO - 'PWD': '/builds/slave/test', 05:27:34 INFO - 'SHELL': '/bin/bash', 05:27:34 INFO - 'SHLVL': '1', 05:27:34 INFO - 'TERM': 'linux', 05:27:34 INFO - 'TMOUT': '86400', 05:27:34 INFO - 'USER': 'cltbld', 05:27:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:34 INFO - '_': '/tools/buildbot/bin/python'} 05:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:34 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 05:27:34 INFO - Cleaning up... 05:27:34 INFO - Return code: 0 05:27:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:34 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 05:27:34 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 05:27:34 INFO - Using env: {'DISPLAY': ':0', 05:27:34 INFO - 'HOME': '/home/cltbld', 05:27:34 INFO - 'LANG': 'en_US.UTF-8', 05:27:34 INFO - 'LANGUAGE': 'en_US:en', 05:27:34 INFO - 'LOGNAME': 'cltbld', 05:27:34 INFO - 'MAIL': '/var/mail/cltbld', 05:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:34 INFO - 'MOZ_NO_REMOTE': '1', 05:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:34 INFO - 'NO_EM_RESTART': '1', 05:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:34 INFO - 'PWD': '/builds/slave/test', 05:27:34 INFO - 'SHELL': '/bin/bash', 05:27:34 INFO - 'SHLVL': '1', 05:27:34 INFO - 'TERM': 'linux', 05:27:34 INFO - 'TMOUT': '86400', 05:27:34 INFO - 'USER': 'cltbld', 05:27:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:34 INFO - '_': '/tools/buildbot/bin/python'} 05:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:34 INFO - Downloading/unpacking psutil>=3.1.1 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:36 INFO - Installing collected packages: psutil 05:27:36 INFO - Running setup.py install for psutil 05:27:36 INFO - building 'psutil._psutil_linux' extension 05:27:36 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 05:27:36 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 05:27:36 INFO - building 'psutil._psutil_posix' extension 05:27:36 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 05:27:36 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 05:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:37 INFO - Successfully installed psutil 05:27:37 INFO - Cleaning up... 05:27:37 INFO - Return code: 0 05:27:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:27: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 mozsystemmonitor==0.3 05:27:37 INFO - Using env: {'DISPLAY': ':0', 05:27:37 INFO - 'HOME': '/home/cltbld', 05:27:37 INFO - 'LANG': 'en_US.UTF-8', 05:27:37 INFO - 'LANGUAGE': 'en_US:en', 05:27:37 INFO - 'LOGNAME': 'cltbld', 05:27:37 INFO - 'MAIL': '/var/mail/cltbld', 05:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:37 INFO - 'MOZ_NO_REMOTE': '1', 05:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:37 INFO - 'NO_EM_RESTART': '1', 05:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:37 INFO - 'PWD': '/builds/slave/test', 05:27:37 INFO - 'SHELL': '/bin/bash', 05:27:37 INFO - 'SHLVL': '1', 05:27:37 INFO - 'TERM': 'linux', 05:27:37 INFO - 'TMOUT': '86400', 05:27:37 INFO - 'USER': 'cltbld', 05:27:37 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:37 INFO - '_': '/tools/buildbot/bin/python'} 05:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:39 INFO - Installing collected packages: mozsystemmonitor 05:27:39 INFO - Running setup.py install for mozsystemmonitor 05:27:39 INFO - Successfully installed mozsystemmonitor 05:27:39 INFO - Cleaning up... 05:27:39 INFO - Return code: 0 05:27:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:39 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')]} 05:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:39 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')]} 05:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:39 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:39 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 05:27:39 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 05:27:39 INFO - Using env: {'DISPLAY': ':0', 05:27:39 INFO - 'HOME': '/home/cltbld', 05:27:39 INFO - 'LANG': 'en_US.UTF-8', 05:27:39 INFO - 'LANGUAGE': 'en_US:en', 05:27:39 INFO - 'LOGNAME': 'cltbld', 05:27:39 INFO - 'MAIL': '/var/mail/cltbld', 05:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:39 INFO - 'MOZ_NO_REMOTE': '1', 05:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:39 INFO - 'NO_EM_RESTART': '1', 05:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:39 INFO - 'PWD': '/builds/slave/test', 05:27:39 INFO - 'SHELL': '/bin/bash', 05:27:39 INFO - 'SHLVL': '1', 05:27:39 INFO - 'TERM': 'linux', 05:27:39 INFO - 'TMOUT': '86400', 05:27:39 INFO - 'USER': 'cltbld', 05:27:39 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:39 INFO - '_': '/tools/buildbot/bin/python'} 05:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:39 INFO - Downloading/unpacking jsonschema==2.5.1 05:27:39 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 05:27:39 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 05:27:39 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 05:27:39 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 05:27:39 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 05:27:39 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 05:27:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27: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 05:27:41 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:41 INFO - warning: no files found matching '*.txt' 05:27:41 INFO - no previously-included directories found matching 'build' 05:27:41 INFO - no previously-included directories found matching 'dist' 05:27:41 INFO - no previously-included directories found matching '.git*' 05:27:41 INFO - Installing collected packages: jsonschema, functools32 05:27:41 INFO - Running setup.py install for functools32 05:27:41 INFO - warning: no files found matching '*.txt' 05:27:41 INFO - no previously-included directories found matching 'build' 05:27:41 INFO - no previously-included directories found matching 'dist' 05:27:41 INFO - no previously-included directories found matching '.git*' 05:27:41 INFO - Successfully installed jsonschema functools32 05:27:41 INFO - Cleaning up... 05:27:42 INFO - Return code: 0 05:27:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:42 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')]} 05:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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')]} 05:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:42 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:42 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 05:27:42 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 05:27:42 INFO - Using env: {'DISPLAY': ':0', 05:27:42 INFO - 'HOME': '/home/cltbld', 05:27:42 INFO - 'LANG': 'en_US.UTF-8', 05:27:42 INFO - 'LANGUAGE': 'en_US:en', 05:27:42 INFO - 'LOGNAME': 'cltbld', 05:27:42 INFO - 'MAIL': '/var/mail/cltbld', 05:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:42 INFO - 'MOZ_NO_REMOTE': '1', 05:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:42 INFO - 'NO_EM_RESTART': '1', 05:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:42 INFO - 'PWD': '/builds/slave/test', 05:27:42 INFO - 'SHELL': '/bin/bash', 05:27:42 INFO - 'SHLVL': '1', 05:27:42 INFO - 'TERM': 'linux', 05:27:42 INFO - 'TMOUT': '86400', 05:27:42 INFO - 'USER': 'cltbld', 05:27:42 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:42 INFO - '_': '/tools/buildbot/bin/python'} 05:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:42 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:44 INFO - Downloading docopt-0.6.1.tar.gz 05:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:44 INFO - Running setup.py install for blobuploader 05:27:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:44 INFO - Running setup.py install for requests 05:27:45 INFO - Running setup.py install for docopt 05:27:45 INFO - Successfully installed blobuploader requests docopt 05:27:45 INFO - Cleaning up... 05:27:45 INFO - Return code: 0 05:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:45 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:45 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 05:27:45 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 05:27:45 INFO - Using env: {'DISPLAY': ':0', 05:27:45 INFO - 'HOME': '/home/cltbld', 05:27:45 INFO - 'LANG': 'en_US.UTF-8', 05:27:45 INFO - 'LANGUAGE': 'en_US:en', 05:27:45 INFO - 'LOGNAME': 'cltbld', 05:27:45 INFO - 'MAIL': '/var/mail/cltbld', 05:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:45 INFO - 'MOZ_NO_REMOTE': '1', 05:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:45 INFO - 'NO_EM_RESTART': '1', 05:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:45 INFO - 'PWD': '/builds/slave/test', 05:27:45 INFO - 'SHELL': '/bin/bash', 05:27:45 INFO - 'SHLVL': '1', 05:27:45 INFO - 'TERM': 'linux', 05:27:45 INFO - 'TMOUT': '86400', 05:27:45 INFO - 'USER': 'cltbld', 05:27:45 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:45 INFO - '_': '/tools/buildbot/bin/python'} 05:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:45 INFO - Running setup.py (path:/tmp/pip-H1Rz7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:45 INFO - Running setup.py (path:/tmp/pip-3ASOvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:45 INFO - Running setup.py (path:/tmp/pip-Uj99cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:45 INFO - Running setup.py (path:/tmp/pip-g1z_j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:45 INFO - Running setup.py (path:/tmp/pip-eh7III-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:46 INFO - Running setup.py (path:/tmp/pip-juHiqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:46 INFO - Running setup.py (path:/tmp/pip-GaX1qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:46 INFO - Running setup.py (path:/tmp/pip-ZEDVRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:46 INFO - Running setup.py (path:/tmp/pip-por6p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:46 INFO - Running setup.py (path:/tmp/pip-VhdZEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:46 INFO - Running setup.py (path:/tmp/pip-E6XULo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:46 INFO - Running setup.py (path:/tmp/pip-YMnbtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:46 INFO - Running setup.py (path:/tmp/pip-0Ld8Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:46 INFO - Running setup.py (path:/tmp/pip-XM4Q7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:46 INFO - Running setup.py (path:/tmp/pip-kB0vcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:46 INFO - Running setup.py (path:/tmp/pip-7zEc7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:46 INFO - Running setup.py (path:/tmp/pip-UFsY2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:46 INFO - Running setup.py install for manifestparser 05:27:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for mozcrash 05:27:47 INFO - Running setup.py install for mozdebug 05:27:47 INFO - Running setup.py install for mozdevice 05:27:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for mozfile 05:27:47 INFO - Running setup.py install for mozhttpd 05:27:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for mozinfo 05:27:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for mozInstall 05:27:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for mozleak 05:27:47 INFO - Running setup.py install for mozlog 05:27:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:47 INFO - Running setup.py install for moznetwork 05:27:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Running setup.py install for mozprocess 05:27:48 INFO - Running setup.py install for mozprofile 05:27:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Running setup.py install for mozrunner 05:27:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Running setup.py install for mozscreenshot 05:27:48 INFO - Running setup.py install for moztest 05:27:48 INFO - Running setup.py install for mozversion 05:27:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:48 INFO - Cleaning up... 05:27:48 INFO - Return code: 0 05:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:48 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:48 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 05:27:48 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 05:27:48 INFO - Using env: {'DISPLAY': ':0', 05:27:48 INFO - 'HOME': '/home/cltbld', 05:27:48 INFO - 'LANG': 'en_US.UTF-8', 05:27:48 INFO - 'LANGUAGE': 'en_US:en', 05:27:48 INFO - 'LOGNAME': 'cltbld', 05:27:48 INFO - 'MAIL': '/var/mail/cltbld', 05:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:48 INFO - 'MOZ_NO_REMOTE': '1', 05:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:48 INFO - 'NO_EM_RESTART': '1', 05:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:48 INFO - 'PWD': '/builds/slave/test', 05:27:48 INFO - 'SHELL': '/bin/bash', 05:27:48 INFO - 'SHLVL': '1', 05:27:48 INFO - 'TERM': 'linux', 05:27:48 INFO - 'TMOUT': '86400', 05:27:48 INFO - 'USER': 'cltbld', 05:27:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:48 INFO - '_': '/tools/buildbot/bin/python'} 05:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:48 INFO - Running setup.py (path:/tmp/pip-4qOTJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:49 INFO - Running setup.py (path:/tmp/pip-pEBDiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:49 INFO - Running setup.py (path:/tmp/pip-i74q7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:49 INFO - Running setup.py (path:/tmp/pip-1qlVKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:49 INFO - Running setup.py (path:/tmp/pip-sVz2Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:49 INFO - Running setup.py (path:/tmp/pip-ZWPpOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:49 INFO - Running setup.py (path:/tmp/pip-PHG4Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:49 INFO - Running setup.py (path:/tmp/pip-OW6IUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:49 INFO - Running setup.py (path:/tmp/pip-0L00wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:49 INFO - Running setup.py (path:/tmp/pip-DKEoYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:49 INFO - Running setup.py (path:/tmp/pip-KZ4NEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:49 INFO - Running setup.py (path:/tmp/pip-lnG6s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:49 INFO - Running setup.py (path:/tmp/pip-B0olGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:49 INFO - Running setup.py (path:/tmp/pip-KiFSH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:49 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)) 05:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:49 INFO - Running setup.py (path:/tmp/pip-ylBsbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:50 INFO - Running setup.py (path:/tmp/pip-NW_siI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:50 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)) 05:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:50 INFO - Running setup.py (path:/tmp/pip-5C8x19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:50 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)) 05:27:50 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)) 05:27:50 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)) 05:27:50 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)) 05:27:50 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)) 05:27:50 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)) 05:27:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:52 INFO - Downloading blessings-1.6.tar.gz 05:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:52 INFO - Installing collected packages: blessings 05:27:52 INFO - Running setup.py install for blessings 05:27:52 INFO - Successfully installed blessings 05:27:52 INFO - Cleaning up... 05:27:52 INFO - Return code: 0 05:27:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:52 INFO - Reading from file tmpfile_stdout 05:27:52 INFO - Current package versions: 05:27:52 INFO - argparse == 1.2.1 05:27:52 INFO - blessings == 1.6 05:27:52 INFO - blobuploader == 1.2.4 05:27:52 INFO - docopt == 0.6.1 05:27:52 INFO - functools32 == 3.2.3-2 05:27:52 INFO - jsonschema == 2.5.1 05:27:52 INFO - manifestparser == 1.1 05:27:52 INFO - mozInstall == 1.12 05:27:52 INFO - mozcrash == 0.17 05:27:52 INFO - mozdebug == 0.1 05:27:52 INFO - mozdevice == 0.48 05:27:52 INFO - mozfile == 1.2 05:27:52 INFO - mozhttpd == 0.7 05:27:52 INFO - mozinfo == 0.9 05:27:52 INFO - mozleak == 0.1 05:27:52 INFO - mozlog == 3.2 05:27:52 INFO - moznetwork == 0.27 05:27:52 INFO - mozprocess == 0.22 05:27:52 INFO - mozprofile == 0.28 05:27:52 INFO - mozrunner == 6.11 05:27:52 INFO - mozscreenshot == 0.1 05:27:52 INFO - mozsystemmonitor == 0.3 05:27:52 INFO - moztest == 0.7 05:27:52 INFO - mozversion == 1.4 05:27:52 INFO - psutil == 3.1.1 05:27:52 INFO - requests == 1.2.3 05:27:52 INFO - wsgiref == 0.1.2 05:27:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:52 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:52 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 05:27:52 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 05:27:52 INFO - Using env: {'DISPLAY': ':0', 05:27:52 INFO - 'HOME': '/home/cltbld', 05:27:52 INFO - 'LANG': 'en_US.UTF-8', 05:27:52 INFO - 'LANGUAGE': 'en_US:en', 05:27:52 INFO - 'LOGNAME': 'cltbld', 05:27:52 INFO - 'MAIL': '/var/mail/cltbld', 05:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:52 INFO - 'MOZ_NO_REMOTE': '1', 05:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:52 INFO - 'NO_EM_RESTART': '1', 05:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:52 INFO - 'PWD': '/builds/slave/test', 05:27:52 INFO - 'SHELL': '/bin/bash', 05:27:52 INFO - 'SHLVL': '1', 05:27:52 INFO - 'TERM': 'linux', 05:27:52 INFO - 'TMOUT': '86400', 05:27:52 INFO - 'USER': 'cltbld', 05:27:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:52 INFO - '_': '/tools/buildbot/bin/python'} 05:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 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)) 05:27:52 INFO - Cleaning up... 05:27:52 INFO - Return code: 0 05:27:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:52 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 0x16a7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1968180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', '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 05:27:52 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 05:27:52 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 05:27:52 INFO - Using env: {'DISPLAY': ':0', 05:27:52 INFO - 'HOME': '/home/cltbld', 05:27:52 INFO - 'LANG': 'en_US.UTF-8', 05:27:52 INFO - 'LANGUAGE': 'en_US:en', 05:27:52 INFO - 'LOGNAME': 'cltbld', 05:27:52 INFO - 'MAIL': '/var/mail/cltbld', 05:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:52 INFO - 'MOZ_NO_REMOTE': '1', 05:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:52 INFO - 'NO_EM_RESTART': '1', 05:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:52 INFO - 'PWD': '/builds/slave/test', 05:27:52 INFO - 'SHELL': '/bin/bash', 05:27:52 INFO - 'SHLVL': '1', 05:27:52 INFO - 'TERM': 'linux', 05:27:52 INFO - 'TMOUT': '86400', 05:27:52 INFO - 'USER': 'cltbld', 05:27:52 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:52 INFO - '_': '/tools/buildbot/bin/python'} 05:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:53 INFO - Cleaning up... 05:27:53 INFO - Return code: 0 05:27:53 INFO - Running post-action listener: _resource_record_post_action 05:27:53 INFO - Running post-action listener: _start_resource_monitoring 05:27:53 INFO - Starting resource monitoring. 05:27:53 INFO - ##### 05:27:53 INFO - ##### Finished create-virtualenv step (success) 05:27:53 INFO - ##### 05:27:53 INFO - ##### 05:27:53 INFO - ##### Running install step. 05:27:53 INFO - ##### 05:27:53 INFO - Running pre-action listener: _resource_record_pre_action 05:27:53 INFO - Running main action method: install 05:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:53 INFO - Reading from file tmpfile_stdout 05:27:53 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:53 INFO - Reading from file tmpfile_stdout 05:27:53 INFO - Output received: 05:27:53 INFO - Usage: mozinstall [options] installer 05:27:53 INFO - Options: 05:27:53 INFO - -h, --help show this help message and exit 05:27:53 INFO - -d DEST, --destination=DEST 05:27:53 INFO - Directory to install application into. [default: 05:27:53 INFO - "/builds/slave/test"] 05:27:53 INFO - --app=APP Application being installed. [default: firefox] 05:27:53 INFO - mkdir: /builds/slave/test/build/application 05:27:53 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'] 05:27:53 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 05:28:09 INFO - Reading from file tmpfile_stdout 05:28:09 INFO - Output received: 05:28:09 INFO - /builds/slave/test/build/application/firefox/firefox 05:28:09 INFO - Running post-action listener: _resource_record_post_action 05:28:09 INFO - ##### 05:28:09 INFO - ##### Finished install step (success) 05:28:09 INFO - ##### 05:28:09 INFO - ##### 05:28:09 INFO - ##### Running run-tests step. 05:28:09 INFO - ##### 05:28:09 INFO - Running pre-action listener: _resource_record_pre_action 05:28:09 INFO - Running main action method: run_tests 05:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:28:09 INFO - Python 2.7.3 05:28:09 INFO - Return code: 0 05:28:09 INFO - grabbing minidump binary from tooltool 05:28: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')]} 05:28:09 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 0x19663b0>, '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 0x19672b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1967740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:28:09 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 05:28:09 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 05:28:09 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 05:28:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:28:09 INFO - Return code: 0 05:28:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:28:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:28:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:28:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:28:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:28:09 INFO - Using env: {'DISPLAY': ':0', 05:28:09 INFO - 'HOME': '/home/cltbld', 05:28:09 INFO - 'LANG': 'en_US.UTF-8', 05:28:09 INFO - 'LANGUAGE': 'en_US:en', 05:28:09 INFO - 'LOGNAME': 'cltbld', 05:28:09 INFO - 'MAIL': '/var/mail/cltbld', 05:28:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:28:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:09 INFO - 'MOZ_NO_REMOTE': '1', 05:28:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:28:09 INFO - 'NO_EM_RESTART': '1', 05:28:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:09 INFO - 'PWD': '/builds/slave/test', 05:28:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:28:09 INFO - 'SHELL': '/bin/bash', 05:28:09 INFO - 'SHLVL': '1', 05:28:09 INFO - 'TERM': 'linux', 05:28:09 INFO - 'TMOUT': '86400', 05:28:09 INFO - 'USER': 'cltbld', 05:28:09 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219', 05:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:09 INFO - '_': '/tools/buildbot/bin/python'} 05:28:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:28:10 INFO - mozversion application_buildid: 20160704043125 05:28:10 INFO - mozversion application_changeset: 99b859906a9ca1e86c31415f98c1f8094c4f67d5 05:28:10 INFO - mozversion application_display_name: Nightly 05:28:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:28:10 INFO - mozversion application_name: Firefox 05:28:10 INFO - mozversion application_remotingname: firefox 05:28:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:28:10 INFO - mozversion application_vendor: Mozilla 05:28:10 INFO - mozversion application_version: 50.0a1 05:28:10 INFO - mozversion platform_buildid: 20160704043125 05:28:10 INFO - mozversion platform_changeset: 99b859906a9ca1e86c31415f98c1f8094c4f67d5 05:28:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:28:10 INFO - mozversion platform_version: 50.0a1 05:28:10 INFO - using testdate: 1467635290 05:28:10 INFO - actual date: 1467635290 05:28:10 INFO - starting webserver on 'localhost:38368' 05:28:10 INFO - SUITE-START | Running 2 tests 05:28:10 INFO - TEST-START | dromaeo_css 05:28:10 INFO - operating with platform_type : linux_ 05:28:10 INFO - Initialising browser for dromaeo_css test... 05:28:10 INFO - TEST-INFO | started process 6044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GNWEB/profile http://localhost:38368/getInfo.html) 05:28:14 INFO - PROCESS | 6044 | __metrics Screen width/height:1600/1200 05:28:14 INFO - PROCESS | 6044 | colorDepth:24 05:28:14 INFO - PROCESS | 6044 | Browser inner width/height: 1024/697 05:28:14 INFO - PROCESS | 6044 | __metrics 05:28:15 INFO - PROCESS | 6044 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:16 INFO - TEST-INFO | 6044: exit 0 05:28:16 INFO - Browser initialized. 05:28:16 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:16 INFO - TEST-INFO | started process 6125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1GNWEB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:28 INFO - PROCESS | 6125 | RSS: Main: 159354880 05:28:28 INFO - PROCESS | 6125 | 05:29:18 INFO - PROCESS | 6125 | 1467635358788 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] 05:31:31 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38368/tests/dromaeo/cssquery-ext.html) 05:31:32 INFO - PROCESS | 6125 | RSS: Main: 260755456 05:31:32 INFO - PROCESS | 6125 | 05:34:35 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-ext.html (next: http://localhost:38368/tests/dromaeo/cssquery-jquery.html) 05:34:36 INFO - PROCESS | 6125 | RSS: Main: 244719616 05:34:36 INFO - PROCESS | 6125 | 05:37:38 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38368/tests/dromaeo/cssquery-mootools.html) 05:37:39 INFO - PROCESS | 6125 | RSS: Main: 239321088 05:37:39 INFO - PROCESS | 6125 | 05:40:41 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38368/tests/dromaeo/cssquery-prototype.html) 05:40:42 INFO - PROCESS | 6125 | RSS: Main: 236601344 05:40:42 INFO - PROCESS | 6125 | 05:43:45 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38368/tests/dromaeo/cssquery-yui.html) 05:43:45 INFO - PROCESS | 6125 | RSS: Main: 217260032 05:43:45 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | Cycle 1(1): loaded http://localhost:38368/tests/dromaeo/cssquery-yui.html (next: http://localhost:38368/tests/dromaeo/cssquery-dojo.html) 05:46:48 INFO - PROCESS | 6125 | RSS: Main: 322031616 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | __start_tp_report 05:46:48 INFO - PROCESS | 6125 | _x_x_mozilla_page_load 05:46:48 INFO - PROCESS | 6125 | _x_x_mozilla_page_load_details 05:46:48 INFO - PROCESS | 6125 | |i|pagename|runs| 05:46:48 INFO - PROCESS | 6125 | |0;dojo.html;2601.479704059186;2611.242739605514;2628.1064438091053;2652.694940081891;2657.2028391482563;4625.306204069391;4664.580187783099;4732.550407711266;4755.191617425037;4771.165046116928;4703.90592188156;4723.409573803275;4733.195356789345;4763.2378819388905;4789.80840766369;4141.751494910315;4310.892227694301;4399.934000989988;4421.513633500313;4499.055198408339;4409.867703968886;4436.889077773066;4453.465584129909;4469.351943968123;4502.234620114572;4328.956710432903;4338.2191205582985;4339.804708788112;4356.629686476654;4381.16757816014;4344.804483798237;4349.760763158025;4356.4772227332605;4387.276099443588;4394.538573449806;4362.541933097043;4376.89057773555;4385.276429389147;4423.1153769246275;4428.468583769968;4657.115148121846;4701.036287561042;4706.22347312693;4748.026654535812;4748.881277968044;5059.089363914494;5069.670471419346;5098.337216161913;5117.692938423669;5120.180771076647;5119.257707632372;5132.307138536287;5132.769025393829;5140.948590514085;5141.511556402136;4671.719696818202;4746.5253474652945;4780.1873681474235;4783.449903261169;4840.394950631171;5274.050670879278;5274.841754747364;5289.814856480005;5326.307580014573;5331.81338653153;5033.723145227048;5044.268581055726;5055.393352797614;5101.668391554611;5102.617303702163;4967.826126085642;5095.439501654815;5138.97430512845;5146.974265128725;5183.766730497061;5098.872528186751;5108.770105345268;5111.514406131411;5113.565346945476;5124.300869807492;5079.263506791494;5085.288059671649;5087.058894104603;5111.05445492585;5114.3862736471865;4319.265724826787;4347.239233134189;4351.8694439166875;4395.824167033346;4403.405540252089;3807.3717836556657;3837.520309961255;3850.4609354690365;3884.6503814656817;3960.346542820402;4438.844640437634;4443.37792709021;4446.738396792014;4489.506154323022;4496.39298694672;5024.824131155392;5117.820876269388;5167.044096842096;5169.276301317818;5220.9738951305;4370.519242883281;4385.978070109629;4409.603135717801;4429.734215947054;4491.865244042684;4656.627469802408;4659.930101048487;4667.323238130452;4670.229412147026;4689.788959496763;4802.207635740134;4815.903681926272;4815.903681926342;4818.542238487338;4863.440704318978;5010;5057.544820966131;5087;5096.439391666988;5111.616628752784;4783.1868582341785;4787.3776409066595;4789.042191561772;4793.9041219176115;4821.975890120527;4920.335754673217;5033.6476446648385;5038.521340472649;5041.924371134509;5096.108181068373;5030.4718004608985;5105.489451054865;5109.693418394908;5109.821156259513;5134.4352121267375;4978.576820970258;4990.1516742154645;4990.72551009698;4992.575631071254;5041.117804384291;4789.281607758864;4881.780319885543;4979.651424400257;4982.526659967298;4988.352197618601;4831.347768051268;4855.271709243641;4914.8771280718265;4921.9507804921495;4924.679895806761;4949.307097006494;4953.479884612208;4961.255811628284;4965.950340496549;5010.173321402073;4831.178699621143;4835.854924352275;4856.878578035577;4866.562009419028;4867.537583929521 05:46:48 INFO - PROCESS | 6125 | |1;ext.html;545.9001782531195;573.9540836733064;577.387968753122;583.9984426708196;595.3124141616433;27038.324041898937;39753.80123099384;40642;40691.79654101733;40757.99999999996;41467.58532414675;41857.79071104648;41985;42051;42089.78955105228;7479.9252007480045;7912.327452166573;8071.071826739912;9919.057689519484;10184.847227291597;10181.541830617603;10300.948495257513;10308.226882983769;10313.07182353588;10319.43243121628;10337.379757214554;10381.636642717507;10407;10409.687709368693;10421.374717516936;7529.32236098751;10260.692179234598;10558.736031599272;10562.735931601772;10569.894301056967;10189.59241630334;10261.538230779634;10263.538140783683;10266.230032747573;10272;30233.395332093234;38263.42604860929;38679.80660096682;38722.80638596817;40741.1851762966;3005.654349749785;3040.4831178699674;3079.799813012147;3102.720755132026;3219.0825614699697;30491.847540762155;31036.844815776003;31377.215569610944;31732.206694832814;32705.34589308224;3383.9661603383897;3384.627690953993;3422.26421319415;3451.879184228565;3465.3589086018915;266883;267139;268725;269458;269570;58716.412835871095;59261;59303.70348148232;59327;59360.40639593549;34426;35501;35518.64481355153;37231.62768372336;37268.627313726516;13248.602541923758;15361.692766144615;15376.15431151275;15421.922890385476;15517.767233491506;11599.942000290113;11904.107191960638;11926;12191.756164876653;12230.877691223151;19575.65092188918;19804.20783168686;19859.205631774566;19935.900320498597;19989.400317990483;7278.599677017709;7307.269273072757;7346.33882950537;7439.293267139613;7472.140703819022;768.4774353439603;894.342658146262;904.0597778310615;937.7327461673391;974.4104816586005;29086.27284317909;29111.708882911324;29326.853365733463;29362.559561606595;29729.55405668917;951.0917074194128;952.642758965388;956.8325543029941;960.0687333286701;977.5307852230969;15195.468158614396;15657.608559786097;15663.138527380876;15977;15999.280032398337;405284;408324;411364;411593;413115;51093.74453127785;51585;51660.74169629203;51665;51665.48334516682;1039.3088596083671;1045.268312181476;1114.5820317380983;1139.2936379444798;1160.8723040465543;27480.17559473219;30016.24959376033;30036.699633004264;30466.39067218599;30527.542086869158;43721.34417983669;44210.55789442064;44241.33637995368;44248.55751442573;44266.33600495931;304776;305499;305675;305783;307621;25305;26470.602940955516;26509.469810604067;26578.867105665122;26587.468250635266;41966.79016604897;42398.788006059774;42690.78654606707;43420.782896085315;43929.34105988349;36628;37762.62237377701;37844;37892.810535947145;37899.62100378961;36383.839591804106;36803.26393472169;36841.07897302589;36953.26093478169;37112;35736.463953040206;36388;36439.08902277464;36737.26525469422;36960;31784.523232151074;33401.49897751487;33536.16159595932;33783.32433351369;33920;25407.87296063508;25455.236342909742;25633.359166021;25702.485950281265;26310.60534091952 05:46:48 INFO - PROCESS | 6125 | |2;jquery.html;350.10198839975476;372.30564996281936;372.8340888304705;374.3598446656218;390.1163863848382;13263;16840.15799210039;17524.38664646736;19002.904985475052;19004.14481348339;16556.586085347873;16934.06862622555;17413.216405261763;17425.738613920803;17576.648467030653;4854.514548545144;5282.7622756976025;5301.734913254322;5309.7610607522565;5311.814086506973;3746.868859589915;3920.9607903920883;3922.705797065217;3982.6017398260233;5156.53591176794;3944.7830369329677;4683.086798074377;6048.1834952281315;6177.351378105302;6178.165947597085;5921.970390148022;6110.3889611038985;6114.938850611481;6153.107799369089;6158.322584515699;5342.332208473941;5371.704556249405;5373.032854086263;5377.784888604451;5381.327334083239;16516.917415412965;20150;20873.5825283495;21196.682049769264;21597.568048639096;1890.6313268912568;1941.9514512137168;1987.4534503011644;2104.4318034130697;2470.9011639534397;13433.059685821996;13435.932820335933;13727.725445491134;13941.651458713613;14304.856951430456;1763.7442570827159;1769.2038582637865;1770.4511601403478;1815.7185636226407;1860.692985657365;46617.76691116556;72025.27974720238;73180;73206;73520;8872.467651940904;9411.858822117674;9616.615335386647;9757.512124393752;10103.28244198488;12702.491900324068;13499.257540835348;13506.932465337806;13897.513587024405;13968.371423285977;7766.883496747553;7808.492447990862;7843.294103530709;7911.446198766146;7963.8805417918775;7689.653965571562;7696.769096927102;7697.961510192526;7815.944847445522;7822.530648161129;6371.299157092716;6483.7730679425995;6491.480681545465;6504.5121615879;6568.638724870178;1756.4818378578095;1768.938087166943;1770.2741875830848;1775.9644807103787;1831.2400353853268;851.2594043182471;879.3800370738614;880.4761167105562;881.5900606218139;918.1094338491653;16620.33518659264;17511.474655760347;18442.907785461255;18447.431968282577;18452.630947381247;851.3274513134678;883.0639522106459;886.6143227695973;911.3256190419042;974.8245315843217;9803.264755143393;10456.424896630759;10580.576776928836;10586.364818110784;10616.363018218777;377888;400404;404287;406553;407062;67842.66078669575;72031;72538.27461725421;73251.63374183202;73495.89756153662;857.8027053777666;866.5927014303268;873.3711727556149;875.8160786234835;877.5963056993727;12167.513299468275;15908.443204487787;16182.514524564282;16619.3352265908;17369.652606948042;36455;36461;37239.441408378356;37335.25329493449;37889.621103789716;44113.33829992617;49061.75469122631;49292;49346.01307973892;52254.738726306125;6362.854686156351;6426.453751430994;7643.197464266172;7894.407919405952;8015.158408367038;11866.466009029442;11963.401829908644;12248.326342051272;12268.282440458164;12583.370831458573;7571.545707257582;7684.4236682250175;7692.076950765944;7771.339436147765;10300.072993430627;7340.522866013692;7459.627018648937;7881.093674227308;7990.081140668665;8009.8398032040195;7845.686172553263;7916.461157527032;7947.483413578099;8027.237412445808;8130.918690813016;11146;11650;11863.822042669195;12054.698632533906;12176.695582610506;11186.664400068012;11367;11413.885861141282;11414.714632134263;11681.532738690697 05:46:48 INFO - PROCESS | 6125 | |3;mootools.html;1398.112198753791;1439.323517946565;1512.5991612222756;1665.3255431550226;1694.1783235130952;7639.19788422216;8102.0682621498545;8194.590270486482;8199.303059239965;8205.261526462624;6813.352731490513;7563.281488258606;7790.065192176932;7817.530948143101;8012.599370031489;2257.063318722728;2286.6798648189265;2288.382136823057;2288.4050146961745;2289.2559918026623;1898.221729091073;2252.5044490212126;2256.345659758668;2297.6668383084443;2299.367673889685;2149.151085321297;2218.0462401167492;2228.420610641229;2248.718910136233;2255.605269077913;2258.5482903419215;2264.8867556622185;2270.103309192876;2296.5636529059425;2297.287840769367;2243.719535058118;2247.8426510144295;2254.842161048727;2257.8645281283175;2258.254775923941;8060.838783224362;8153.143919888385;8160.183981601852;8175.3459723222;8195.42632015759;4576.8626941191815;4690.01509682967;4693.9530604693855;4696.060787842411;4705.294205869112;2970.0941212930047;3055.6944305569486;3084.33686757346;3089.026956508715;3099.891503797356;912.9634814607408;946.8816397950256;960.6877764726422;961.2694352292239;961.5480724059681;10445.68662940113;10744.301620394728;10753.677389678322;11163.776724465546;11231.494582743715;4074.348104303297;4116.629503344713;4154.252234597741;4175.227582897173;4220.388043733641;8671.956640216758;8689.6524139035;8693;8694.17405346491;8699.782505437415;4594.839180628662;4600.53994600544;4603.194440972817;4604.861854144381;4609.446866376056;4243.257429949808;4251.383549385322;4263.70154089217;4272.807723652443;4279.486461624625;3432.5709286339206;3444.5522082129164;3447.24160684649;3476.3047390521997;3530.2586456843837;967.1634036558327;1023.9897601023895;1024.0783295034528;1033.9896601033893;1036.445501656625;858.9570521473902;867.6832955971151;868.3747701654798;902.120432578231;904.1410659873015;5430.945690543123;5457.863553411117;5607.074832652566;5750.942490575041;5783.739731712083;896.1038961038961;908.6501696846761;953.9856902146473;965.5172413793103;998.1515711645044;3675.209829886587;3723.8138093095235;3752.9249415011545;3757.981210093932;3811.8856434307013;9656.75858103539;9870;9938.45338506389;9973.501324933724;9976.401415915068;9495.857562136573;9884.802303954024;9889.10998010168;9894.109530142321;9906.702798916043;7339.376153026946;7431.29402706742;7512.060992375953;7518.624068796538;7528.9835872157655;5346.385165705994;5497.422770609029;5564.387917329172;5617.887642247214;5772.624779389326;8791.252743516872;8895.955520222358;9026.638934442548;9215.953920230357;9234.261259099121;8974.551272436483;9291.21024712907;9332.346735728433;9418.905810941802;9425.151736343762;7128.28717128283;7151.60666163366;7231.457640676865;7265.164506081868;7295.963520182578;7680;7798.532088074734;7808.57052862098;7819.218078192135;7821.804454888674;6765.340334480692;7073.434125269863;7162.033125527987;7163.641817909188;7240.131184257712;6804.11546498952;6850.828729281808;6920.273371295942;7003.509754317149;7052.012718219351;6417.582857114459;6458.095866578588;6484.286728459771;6494.837629059311;6538.1827271591055;4841.8547443576745;4853.611711063036;4883.877903052452;4899.118158731462;4943.777530011086;4850.369451971363;4862.149123903374;4898.559129678203;4919.1883339248625;4927.359443272351 05:46:48 INFO - PROCESS | 6125 | |4;prototype.html;295.67032758474306;296.0260742158298;296.52555910543134;304.88109637241473;311.8581045624241;4837.177679794435;4845.418549774032;4863.85408437747;4896.216605343146;4942.579880710144;4838;4854.781534830932;4858.9514104858945;4867.853964381065;4870.902581948359;3642.562892452909;3760.3419401604747;3778.2821263959895;3872.1094148345896;3886.7667939923554;3820.4460353248764;3843.7693738375647;3857.7106716996195;3869.1487872667967;3872.1481274119647;3648.106213977579;3841.058940559553;3842.9615703843024;3849.3824199544297;3852.094757731945;3759.0452964458464;3846.942295865564;3849.7690138591774;3860.575336712959;3883.9223215535812;3423;3425.417678994577;3428.125827913866;3430.1939044324563;3447.5862896452586;4789.161896668069;4804.588741993189;4809.519048095162;4831.830885918976;4849.199882019462;4092.46797916269;4324.22164010478;4324.437823083011;4326.156399502099;4437.822487100512;5079.492050794928;5106.183010718267;5107.591392688576;5110.6422550421485;5130.589552835801;3500.859965601373;3639.1629925117372;3660.4692319613505;3661.6155303692994;3666.5416822897137;5344.518993290622;5366.812161574326;5375.65058271215;5378.489043540857;5389.487998640123;3730.123420996064;3737.906552336159;3740.0836794984857;3754.849806007729;3759.4924685167152;3805.6765174960437;3808.762152300513;3810.571035861552;3810.980945095312;3822.9044273893373;4134.627883490501;4332.465507677981;4332.501762297313;4342.2835232186335;4364.970288815716;5075.873103172376;5090.821821236313;5104.515071068243;5107.157319042316;5126.4876861326;1298.4806077569049;1309.2668105860748;1313.343328335832;1318.813068238593;1319.4985905355904;831.7837362285728;848;925.9212966897754;942.2791564453199;947.8815148106487;4443.133588950123;4467.503386365539;4486.528914463935;4508.639308855284;4512.9774351128035;5219.556337711261;5220.791168353223;5227.869303267449;5233.2935053768015;5242.397124330674;4327.285997810326;4503.797329120198;4515.435570553681;4529.275315949498;4614.607758340511;2805.6492938382703;2806.6351374321207;2826.646669166354;2837.0921305182555;2838.659360876708;4922.975385123052;4923.5814955729165;4926.285688575208;4986.925196122061;4991.126552853236;5153.510416510426;5407.756650950717;5411.080116380225;5436.673799572039;5461.1808228766;4931.408231012301;4966.404031516096;4975.4527002029745;5004.924926126111;5015.147424937696;5348.545373643284;5350.759215835219;5352.411234764095;5353.518183363516;5372.355317361786;5126.666766660304;5160.791466751211;5249.763760630857;5252.44849290819;5252.816151434681;4973.577245933991;4986.451490336132;4989.451160372283;4992.475790041994;5016.122178618654;3783.754055986352;3795.924081518299;3796.52543432071;3799.810009499459;3801.9619803801606;5106.183010718267;5308.708021058879;5318.7340632967425;5326.786928522971;5351.277577526984;5129.846104616868;5153.922691159561;5156.896862062813;5161.071007218737;5179.896402072013;5149.253358262956;5158.303629010035;5173.715445650375;5177.611679124156;5188.533032027136;4836.177849765478;4945.67853089548;5063.5695965843315;5069.695818250917;5078.7206703631655;5005.6996580205305;5180.766865490987;5181.06740786662;5184.326037615086;5189.365349914765;5080.161773307511;5099.388073431212;5108.386993560648;5112.182050871843;5112.616553758408 05:46:48 INFO - PROCESS | 6125 | |5;yui.html;654.4894981914107;704.9118860142482;723.5839392349401;751.3814356965975;763.2329508843611;13339.399727012284;15187.544373668794;15905.761413578777;15908.443204487845;16598.83401165988;15553.377864885391;15617.453389131382;15666.295016724247;15696.921515392407;15775.290111944962;626.7336382037638;769.6575024114244;784.129616126101;789.2383849585149;801.5230937592123;792.2315354106507;793.5199204481263;797.5932274539997;797.7726347990824;799.3046049936535;829.2288172000037;830.248624994378;830.4477522447595;830.8255266394065;831.7047448155909;647.6891092275711;797.529457620007;822.8189798244376;825.9050209225956;832.5961908474385;601.8375038739559;602.9879402411927;603.065248864263;603.8279090459242;604.087827380654;12927.935360323138;12946.741065178643;12950.158239714388;12983.415746291439;13009.284489353082;12433.93783031088;13008.284544350057;13134.408951597201;13143.671408214776;13611;11672.591459298968;11996.940015299868;12020;12068.396580170956;12177.025837932944;4205.894852628709;4250.404943307939;4250.914981700349;4296.990207301282;4342.826286948518;64048;64231.357686423005;64321.67839160821;64851;65463.3453665462;10179.694609161588;10397.32417392867;10407.427591482541;10408.583656653649;10437.217208709377;15972.680546389007;16149.59626009359;16164.595885102966;16348.836511634732;16380.26288817006;6336.366363363719;6360.554761166674;6404.391582799627;6423.678816059179;6616.702248398834;3649.251903359805;3651.8721844735305;3659.359612067931;3665.8533658653355;3685.262947410475;2869.383082637243;2975.7173068558454;2976.9851150744107;2978.731914127739;2981.3292009297734;498.4317877619517;511.4297558222555;512.8948565544055;513.545512221679;594.037658992435;517.4256575201523;579.4147910610313;593.8485686150004;639.4788247578209;642.9421352078335;8362.958185209034;8367;8387.454815436977;8680.91319086801;8699.301957218033;566.5411017076099;625.3152797686525;626.2172284644195;630.8359826445065;633.5058654249692;3836.5971572984436;3987.9003024924027;4045.5954404559307;4048.4131897980596;4094.754314741125;59457.70271148616;59944.40055599388;62618.68690656518;62898;62969.685151574864;88483.55758221296;94348.52825735828;97581;97653;98425;81953;82089.58955205185;83312;84381.57809210915;84647;7545.608200750932;7687.1159816619565;7804;7849.411294153076;7889.092754333095;50400.49599503958;50986;51288.48711512837;51538.74230628823;52404.21393679174;69748;73356;74204.2579574219;76089;77337.61331193533;10169.237307202138;10181.287309888237;10193;10286;10513.316634418738;11220.943895280472;11428;11683.941580292045;11775.646730598095;12161.39193040362;10200.897991020292;10344.637937672145;10561.63034293796;10747.086497647788;10887.891121088687;10040.096391324816;10158.390496569933;10270.178385729274;10312.432816195182;10358.171346292429;9787.80424391494;10075.19398448137;10079.848802267825;10122.746931326776;10391.272610917465;8236.994937576714;8480.363972701949;8706.564671766513;8800.119988001148;8921.509316987369;8512.787180320294;9050.773730656787;9069.727908162766;9108.681196158102;9248.676296329866 05:46:48 INFO - PROCESS | 6125 | __end_tp_report 05:46:48 INFO - PROCESS | 6125 | __start_cc_report 05:46:48 INFO - PROCESS | 6125 | _x_x_mozilla_cycle_collect,949 05:46:48 INFO - PROCESS | 6125 | __end_cc_report 05:46:48 INFO - PROCESS | 6125 | __startTimestamp1467636408749__endTimestamp 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | ------- Summary: start ------- 05:46:48 INFO - PROCESS | 6125 | Number of tests: 6 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#0] dojo.html Cycles:165 Average:4719.81 Median:4818.54 stddev:494.04 (10.3%) stddev-sans-first:466.78 05:46:48 INFO - PROCESS | 6125 | Values: 2601.5 2611.2 2628.1 2652.7 2657.2 4625.3 4664.6 4732.6 4755.2 4771.2 4703.9 4723.4 4733.2 4763.2 4789.8 4141.8 4310.9 4399.9 4421.5 4499.1 4409.9 4436.9 4453.5 4469.4 4502.2 4329.0 4338.2 4339.8 4356.6 4381.2 4344.8 4349.8 4356.5 4387.3 4394.5 4362.5 4376.9 4385.3 4423.1 4428.5 4657.1 4701.0 4706.2 4748.0 4748.9 5059.1 5069.7 5098.3 5117.7 5120.2 5119.3 5132.3 5132.8 5140.9 5141.5 4671.7 4746.5 4780.2 4783.4 4840.4 5274.1 5274.8 5289.8 5326.3 5331.8 5033.7 5044.3 5055.4 5101.7 5102.6 4967.8 5095.4 5139.0 5147.0 5183.8 5098.9 5108.8 5111.5 5113.6 5124.3 5079.3 5085.3 5087.1 5111.1 5114.4 4319.3 4347.2 4351.9 4395.8 4403.4 3807.4 3837.5 3850.5 3884.7 3960.3 4438.8 4443.4 4446.7 4489.5 4496.4 5024.8 5117.8 5167.0 5169.3 5221.0 4370.5 4386.0 4409.6 4429.7 4491.9 4656.6 4659.9 4667.3 4670.2 4689.8 4802.2 4815.9 4815.9 4818.5 4863.4 5010.0 5057.5 5087.0 5096.4 5111.6 4783.2 4787.4 4789.0 4793.9 4822.0 4920.3 5033.6 5038.5 5041.9 5096.1 5030.5 5105.5 5109.7 5109.8 5134.4 4978.6 4990.2 4990.7 4992.6 5041.1 4789.3 4881.8 4979.7 4982.5 4988.4 4831.3 4855.3 4914.9 4922.0 4924.7 4949.3 4953.5 4961.3 4966.0 5010.2 4831.2 4835.9 4856.9 4866.6 4867.5 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#1] ext.html Cycles:180 Average:48638.27 Median:18583.65 stddev:87676.78 (471.8%) stddev-sans-first:87848.39 05:46:48 INFO - PROCESS | 6125 | Values: 545.9 574.0 577.4 584.0 595.3 27038.3 39753.8 40642.0 40691.8 40758.0 41467.6 41857.8 41985.0 42051.0 42089.8 7479.9 7912.3 8071.1 9919.1 10184.8 10181.5 10300.9 10308.2 10313.1 10319.4 10337.4 10381.6 10407.0 10409.7 10421.4 7529.3 10260.7 10558.7 10562.7 10569.9 10189.6 10261.5 10263.5 10266.2 10272.0 30233.4 38263.4 38679.8 38722.8 40741.2 3005.7 3040.5 3079.8 3102.7 3219.1 30491.8 31036.8 31377.2 31732.2 32705.3 3384.0 3384.6 3422.3 3451.9 3465.4 266883.0 267139.0 268725.0 269458.0 269570.0 58716.4 59261.0 59303.7 59327.0 59360.4 34426.0 35501.0 35518.6 37231.6 37268.6 13248.6 15361.7 15376.2 15421.9 15517.8 11599.9 11904.1 11926.0 12191.8 12230.9 19575.7 19804.2 19859.2 19935.9 19989.4 7278.6 7307.3 7346.3 7439.3 7472.1 768.5 894.3 904.1 937.7 974.4 29086.3 29111.7 29326.9 29362.6 29729.6 951.1 952.6 956.8 960.1 977.5 15195.5 15657.6 15663.1 15977.0 15999.3 405284.0 408324.0 411364.0 411593.0 413115.0 51093.7 51585.0 51660.7 51665.0 51665.5 1039.3 1045.3 1114.6 1139.3 1160.9 27480.2 30016.2 30036.7 30466.4 30527.5 43721.3 44210.6 44241.3 44248.6 44266.3 304776.0 305499.0 305675.0 305783.0 307621.0 25305.0 26470.6 26509.5 26578.9 26587.5 41966.8 42398.8 42690.8 43420.8 43929.3 36628.0 37762.6 37844.0 37892.8 37899.6 36383.8 36803.3 36841.1 36953.3 37112.0 35736.5 36388.0 36439.1 36737.3 36960.0 31784.5 33401.5 33536.2 33783.3 33920.0 25407.9 25455.2 25633.4 25702.5 26310.6 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#2] jquery.html Cycles:180 Average:24538.54 Median:225587.67 stddev:65710.56 (29.1%) stddev-sans-first:65869.80 05:46:48 INFO - PROCESS | 6125 | Values: 350.1 372.3 372.8 374.4 390.1 13263.0 16840.2 17524.4 19002.9 19004.1 16556.6 16934.1 17413.2 17425.7 17576.6 4854.5 5282.8 5301.7 5309.8 5311.8 3746.9 3921.0 3922.7 3982.6 5156.5 3944.8 4683.1 6048.2 6177.4 6178.2 5922.0 6110.4 6114.9 6153.1 6158.3 5342.3 5371.7 5373.0 5377.8 5381.3 16516.9 20150.0 20873.6 21196.7 21597.6 1890.6 1942.0 1987.5 2104.4 2470.9 13433.1 13435.9 13727.7 13941.7 14304.9 1763.7 1769.2 1770.5 1815.7 1860.7 46617.8 72025.3 73180.0 73206.0 73520.0 8872.5 9411.9 9616.6 9757.5 10103.3 12702.5 13499.3 13506.9 13897.5 13968.4 7766.9 7808.5 7843.3 7911.4 7963.9 7689.7 7696.8 7698.0 7815.9 7822.5 6371.3 6483.8 6491.5 6504.5 6568.6 1756.5 1768.9 1770.3 1776.0 1831.2 851.3 879.4 880.5 881.6 918.1 16620.3 17511.5 18442.9 18447.4 18452.6 851.3 883.1 886.6 911.3 974.8 9803.3 10456.4 10580.6 10586.4 10616.4 377888.0 400404.0 404287.0 406553.0 407062.0 67842.7 72031.0 72538.3 73251.6 73495.9 857.8 866.6 873.4 875.8 877.6 12167.5 15908.4 16182.5 16619.3 17369.7 36455.0 36461.0 37239.4 37335.3 37889.6 44113.3 49061.8 49292.0 49346.0 52254.7 6362.9 6426.5 7643.2 7894.4 8015.2 11866.5 11963.4 12248.3 12268.3 12583.4 7571.5 7684.4 7692.1 7771.3 10300.1 7340.5 7459.6 7881.1 7990.1 8009.8 7845.7 7916.5 7947.5 8027.2 8130.9 11146.0 11650.0 11863.8 12054.7 12176.7 11186.7 11367.0 11413.9 11414.7 11681.5 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#3] mootools.html Cycles:180 Average:5272.41 Median:5684.42 stddev:2933.90 (51.6%) stddev-sans-first:2927.69 05:46:48 INFO - PROCESS | 6125 | Values: 1398.1 1439.3 1512.6 1665.3 1694.2 7639.2 8102.1 8194.6 8199.3 8205.3 6813.4 7563.3 7790.1 7817.5 8012.6 2257.1 2286.7 2288.4 2288.4 2289.3 1898.2 2252.5 2256.3 2297.7 2299.4 2149.2 2218.0 2228.4 2248.7 2255.6 2258.5 2264.9 2270.1 2296.6 2297.3 2243.7 2247.8 2254.8 2257.9 2258.3 8060.8 8153.1 8160.2 8175.3 8195.4 4576.9 4690.0 4694.0 4696.1 4705.3 2970.1 3055.7 3084.3 3089.0 3099.9 913.0 946.9 960.7 961.3 961.5 10445.7 10744.3 10753.7 11163.8 11231.5 4074.3 4116.6 4154.3 4175.2 4220.4 8672.0 8689.7 8693.0 8694.2 8699.8 4594.8 4600.5 4603.2 4604.9 4609.4 4243.3 4251.4 4263.7 4272.8 4279.5 3432.6 3444.6 3447.2 3476.3 3530.3 967.2 1024.0 1024.1 1034.0 1036.4 859.0 867.7 868.4 902.1 904.1 5430.9 5457.9 5607.1 5750.9 5783.7 896.1 908.7 954.0 965.5 998.2 3675.2 3723.8 3752.9 3758.0 3811.9 9656.8 9870.0 9938.5 9973.5 9976.4 9495.9 9884.8 9889.1 9894.1 9906.7 7339.4 7431.3 7512.1 7518.6 7529.0 5346.4 5497.4 5564.4 5617.9 5772.6 8791.3 8896.0 9026.6 9216.0 9234.3 8974.6 9291.2 9332.3 9418.9 9425.2 7128.3 7151.6 7231.5 7265.2 7296.0 7680.0 7798.5 7808.6 7819.2 7821.8 6765.3 7073.4 7162.0 7163.6 7240.1 6804.1 6850.8 6920.3 7003.5 7052.0 6417.6 6458.1 6484.3 6494.8 6538.2 4841.9 4853.6 4883.9 4899.1 4943.8 4850.4 4862.1 4898.6 4919.2 4927.4 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#4] prototype.html Cycles:180 Average:4269.19 Median:4861.40 stddev:1236.17 (25.4%) stddev-sans-first:1203.12 05:46:48 INFO - PROCESS | 6125 | Values: 295.7 296.0 296.5 304.9 311.9 4837.2 4845.4 4863.9 4896.2 4942.6 4838.0 4854.8 4859.0 4867.9 4870.9 3642.6 3760.3 3778.3 3872.1 3886.8 3820.4 3843.8 3857.7 3869.1 3872.1 3648.1 3841.1 3843.0 3849.4 3852.1 3759.0 3846.9 3849.8 3860.6 3883.9 3423.0 3425.4 3428.1 3430.2 3447.6 4789.2 4804.6 4809.5 4831.8 4849.2 4092.5 4324.2 4324.4 4326.2 4437.8 5079.5 5106.2 5107.6 5110.6 5130.6 3500.9 3639.2 3660.5 3661.6 3666.5 5344.5 5366.8 5375.7 5378.5 5389.5 3730.1 3737.9 3740.1 3754.8 3759.5 3805.7 3808.8 3810.6 3811.0 3822.9 4134.6 4332.5 4332.5 4342.3 4365.0 5075.9 5090.8 5104.5 5107.2 5126.5 1298.5 1309.3 1313.3 1318.8 1319.5 831.8 848.0 925.9 942.3 947.9 4443.1 4467.5 4486.5 4508.6 4513.0 5219.6 5220.8 5227.9 5233.3 5242.4 4327.3 4503.8 4515.4 4529.3 4614.6 2805.6 2806.6 2826.6 2837.1 2838.7 4923.0 4923.6 4926.3 4986.9 4991.1 5153.5 5407.8 5411.1 5436.7 5461.2 4931.4 4966.4 4975.5 5004.9 5015.1 5348.5 5350.8 5352.4 5353.5 5372.4 5126.7 5160.8 5249.8 5252.4 5252.8 4973.6 4986.5 4989.5 4992.5 5016.1 3783.8 3795.9 3796.5 3799.8 3802.0 5106.2 5308.7 5318.7 5326.8 5351.3 5129.8 5153.9 5156.9 5161.1 5179.9 5149.3 5158.3 5173.7 5177.6 5188.5 4836.2 4945.7 5063.6 5069.7 5078.7 5005.7 5180.8 5181.1 5184.3 5189.4 5080.2 5099.4 5108.4 5112.2 5112.6 05:46:48 INFO - PROCESS | 6125 | 05:46:48 INFO - PROCESS | 6125 | [#5] yui.html Cycles:180 Average:17779.42 Median:586.63 stddev:25369.66 (4324.6%) stddev-sans-first:25408.24 05:46:48 INFO - PROCESS | 6125 | Values: 654.5 704.9 723.6 751.4 763.2 13339.4 15187.5 15905.8 15908.4 16598.8 15553.4 15617.5 15666.3 15696.9 15775.3 626.7 769.7 784.1 789.2 801.5 792.2 793.5 797.6 797.8 799.3 829.2 830.2 830.4 830.8 831.7 647.7 797.5 822.8 825.9 832.6 601.8 603.0 603.1 603.8 604.1 12927.9 12946.7 12950.2 12983.4 13009.3 12433.9 13008.3 13134.4 13143.7 13611.0 11672.6 11996.9 12020.0 12068.4 12177.0 4205.9 4250.4 4250.9 4297.0 4342.8 64048.0 64231.4 64321.7 64851.0 65463.3 10179.7 10397.3 10407.4 10408.6 10437.2 15972.7 16149.6 16164.6 16348.8 16380.3 6336.4 6360.6 6404.4 6423.7 6616.7 3649.3 3651.9 3659.4 3665.9 3685.3 2869.4 2975.7 2977.0 2978.7 2981.3 498.4 511.4 512.9 513.5 594.0 517.4 579.4 593.8 639.5 642.9 8363.0 8367.0 8387.5 8680.9 8699.3 566.5 625.3 626.2 630.8 633.5 3836.6 3987.9 4045.6 4048.4 4094.8 59457.7 59944.4 62618.7 62898.0 62969.7 88483.6 94348.5 97581.0 97653.0 98425.0 81953.0 82089.6 83312.0 84381.6 84647.0 7545.6 7687.1 7804.0 7849.4 7889.1 50400.5 50986.0 51288.5 51538.7 52404.2 69748.0 73356.0 74204.3 76089.0 77337.6 10169.2 10181.3 10193.0 10286.0 10513.3 11220.9 11428.0 11683.9 11775.6 12161.4 10200.9 10344.6 10561.6 10747.1 10887.9 10040.1 10158.4 10270.2 10312.4 10358.2 9787.8 10075.2 10079.8 10122.7 10391.3 8237.0 8480.4 8706.6 8800.1 8921.5 8512.8 9050.8 9069.7 9108.7 9248.7 05:46:48 INFO - PROCESS | 6125 | -------- Summary: end -------- 05:46:48 INFO - PROCESS | 6125 | 05:46:49 INFO - TEST-INFO | 6125: exit 0 05:46:49 INFO - TEST-OK | dromaeo_css | took 1119443ms 05:46:49 INFO - TEST-START | kraken 05:46:49 INFO - operating with platform_type : linux_ 05:46:49 INFO - Initialising browser for kraken test... 05:46:49 INFO - TEST-INFO | started process 6316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4KBt3/profile http://localhost:38368/getInfo.html) 05:46:53 INFO - PROCESS | 6316 | __metrics Screen width/height:1600/1200 05:46:53 INFO - PROCESS | 6316 | colorDepth:24 05:46:53 INFO - PROCESS | 6316 | Browser inner width/height: 1024/697 05:46:53 INFO - PROCESS | 6316 | __metrics 05:46:54 INFO - PROCESS | 6316 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:55 INFO - TEST-INFO | 6316: exit 0 05:46:55 INFO - Browser initialized. 05:46:55 INFO - Running cycle 1/1 for kraken test... 05:46:55 INFO - TEST-INFO | started process 6402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF4KBt3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:07 INFO - PROCESS | 6402 | RSS: Main: 158928896 05:47:07 INFO - PROCESS | 6402 | 05:47:09 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38368/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:10 INFO - PROCESS | 6402 | RSS: Main: 216223744 05:47:10 INFO - PROCESS | 6402 | 05:47:13 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38368/tests/kraken/driver.html?testName=audio-dft) 05:47:14 INFO - PROCESS | 6402 | RSS: Main: 205103104 05:47:14 INFO - PROCESS | 6402 | 05:47:17 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38368/tests/kraken/driver.html?testName=audio-fft) 05:47:18 INFO - PROCESS | 6402 | RSS: Main: 270790656 05:47:18 INFO - PROCESS | 6402 | 05:47:20 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38368/tests/kraken/driver.html?testName=audio-oscillator) 05:47:20 INFO - PROCESS | 6402 | RSS: Main: 181211136 05:47:20 INFO - PROCESS | 6402 | 05:47:23 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38368/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:23 INFO - PROCESS | 6402 | RSS: Main: 184221696 05:47:23 INFO - PROCESS | 6402 | 05:47:26 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38368/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:27 INFO - PROCESS | 6402 | RSS: Main: 222408704 05:47:27 INFO - PROCESS | 6402 | 05:47:30 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38368/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:31 INFO - PROCESS | 6402 | RSS: Main: 217776128 05:47:31 INFO - PROCESS | 6402 | 05:47:34 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38368/tests/kraken/driver.html?testName=json-parse-financial) 05:47:35 INFO - PROCESS | 6402 | RSS: Main: 220807168 05:47:35 INFO - PROCESS | 6402 | 05:47:36 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38368/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:37 INFO - PROCESS | 6402 | RSS: Main: 207540224 05:47:37 INFO - PROCESS | 6402 | 05:47:39 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:39 INFO - PROCESS | 6402 | RSS: Main: 212217856 05:47:39 INFO - PROCESS | 6402 | 05:47:41 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:42 INFO - PROCESS | 6402 | RSS: Main: 211644416 05:47:42 INFO - PROCESS | 6402 | 05:47:45 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:46 INFO - PROCESS | 6402 | RSS: Main: 230719488 05:47:46 INFO - PROCESS | 6402 | 05:47:48 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:49 INFO - PROCESS | 6402 | RSS: Main: 224227328 05:47:49 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | Cycle 1(1): loaded http://localhost:38368/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38368/tests/kraken/driver.html?testName=ai-astar) 05:47:51 INFO - PROCESS | 6402 | RSS: Main: 266870784 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | __start_tp_report 05:47:51 INFO - PROCESS | 6402 | _x_x_mozilla_page_load 05:47:51 INFO - PROCESS | 6402 | _x_x_mozilla_page_load_details 05:47:51 INFO - PROCESS | 6402 | |i|pagename|runs| 05:47:51 INFO - PROCESS | 6402 | |0;ai-astar;106;112;113;114;114;113;110;111;112;113 05:47:51 INFO - PROCESS | 6402 | |1;audio-beat-detection;155;122;124;173;123;124;156;127;162;124 05:47:51 INFO - PROCESS | 6402 | |2;audio-dft;162;161;160;162;161;162;162;163;162;163 05:47:51 INFO - PROCESS | 6402 | |3;audio-fft;76;76;77;119;76;77;75;76;103;75 05:47:51 INFO - PROCESS | 6402 | |4;audio-oscillator;85;84;118;85;86;84;121;83;85;137 05:47:51 INFO - PROCESS | 6402 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;118;119;117 05:47:51 INFO - PROCESS | 6402 | |6;imaging-darkroom;146;146;147;146;146;147;147;146;145;146 05:47:51 INFO - PROCESS | 6402 | |7;imaging-desaturate;95;94;95;95;95;95;95;95;96;95 05:47:51 INFO - PROCESS | 6402 | |8;json-parse-financial;64;64;63;64;64;63;64;64;63;64 05:47:51 INFO - PROCESS | 6402 | |9;json-stringify-tinderbox;66;64;64;64;64;64;64;64;65;64 05:47:51 INFO - PROCESS | 6402 | |10;stanford-crypto-aes;79;79;87;77;79;79;88;78;85;78 05:47:51 INFO - PROCESS | 6402 | |11;stanford-crypto-ccm;130;124;126;130;131;136;138;137;180;129 05:47:51 INFO - PROCESS | 6402 | |12;stanford-crypto-pbkdf2;166;174;175;177;166;166;169;169;171;167 05:47:51 INFO - PROCESS | 6402 | |13;stanford-crypto-sha256-iterative;66;67;67;67;72;66;66;67;69;70 05:47:51 INFO - PROCESS | 6402 | __end_tp_report 05:47:51 INFO - PROCESS | 6402 | __start_cc_report 05:47:51 INFO - PROCESS | 6402 | _x_x_mozilla_cycle_collect,1885 05:47:51 INFO - PROCESS | 6402 | __end_cc_report 05:47:51 INFO - PROCESS | 6402 | __startTimestamp1467636471550__endTimestamp 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | ------- Summary: start ------- 05:47:51 INFO - PROCESS | 6402 | Number of tests: 14 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.39 (2.1%) stddev-sans-first:1.33 05:47:51 INFO - PROCESS | 6402 | Values: 106.0 112.0 113.0 114.0 114.0 113.0 110.0 111.0 112.0 113.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:141.00 stddev:19.98 (14.2%) stddev-sans-first:20.34 05:47:51 INFO - PROCESS | 6402 | Values: 155.0 122.0 124.0 173.0 123.0 124.0 156.0 127.0 162.0 124.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:47:51 INFO - PROCESS | 6402 | Values: 162.0 161.0 160.0 162.0 161.0 162.0 162.0 163.0 162.0 163.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:15.25 (20.1%) stddev-sans-first:15.96 05:47:51 INFO - PROCESS | 6402 | Values: 76.0 76.0 77.0 119.0 76.0 77.0 75.0 76.0 103.0 75.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:84.50 stddev:20.29 (24.0%) stddev-sans-first:21.06 05:47:51 INFO - PROCESS | 6402 | Values: 85.0 84.0 118.0 85.0 86.0 84.0 121.0 83.0 85.0 137.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:47:51 INFO - PROCESS | 6402 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 119.0 117.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:47:51 INFO - PROCESS | 6402 | Values: 146.0 146.0 147.0 146.0 146.0 147.0 147.0 146.0 145.0 146.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:47:51 INFO - PROCESS | 6402 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 05:47:51 INFO - PROCESS | 6402 | Values: 64.0 64.0 63.0 64.0 64.0 63.0 64.0 64.0 63.0 64.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.33 05:47:51 INFO - PROCESS | 6402 | Values: 66.0 64.0 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:79.00 stddev:4.09 (5.2%) stddev-sans-first:4.28 05:47:51 INFO - PROCESS | 6402 | Values: 79.0 79.0 87.0 77.0 79.0 79.0 88.0 78.0 85.0 78.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:133.50 stddev:16.09 (12.1%) stddev-sans-first:16.92 05:47:51 INFO - PROCESS | 6402 | Values: 130.0 124.0 126.0 130.0 131.0 136.0 138.0 137.0 180.0 129.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.00 Median:170.00 stddev:4.08 (2.4%) stddev-sans-first:4.07 05:47:51 INFO - PROCESS | 6402 | Values: 166.0 174.0 175.0 177.0 166.0 166.0 169.0 169.0 171.0 167.0 05:47:51 INFO - PROCESS | 6402 | 05:47:51 INFO - PROCESS | 6402 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:2.00 (3.0%) stddev-sans-first:2.03 05:47:51 INFO - PROCESS | 6402 | Values: 66.0 67.0 67.0 67.0 72.0 66.0 66.0 67.0 69.0 70.0 05:47:51 INFO - PROCESS | 6402 | -------- Summary: end -------- 05:47:51 INFO - PROCESS | 6402 | 05:47:52 INFO - TEST-INFO | 6402: exit 0 05:47:52 INFO - TEST-OK | kraken | took 63094ms 05:47:52 INFO - SUITE-END | took 1182s 05:47:52 INFO - Completed test suite (00:19:42) 05:47:52 INFO - javascript benchmark 05:47:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.479704059186, 2611.242739605514, 2628.1064438091053, 2652.694940081891, 2657.2028391482563, 4625.306204069391, 4664.580187783099, 4732.550407711266, 4755.191617425037, 4771.165046116928, 4703.90592188156, 4723.409573803275, 4733.195356789345, 4763.2378819388905, 4789.80840766369, 4141.751494910315, 4310.892227694301, 4399.934000989988, 4421.513633500313, 4499.055198408339, 4409.867703968886, 4436.889077773066, 4453.465584129909, 4469.351943968123, 4502.234620114572, 4328.956710432903, 4338.2191205582985, 4339.804708788112, 4356.629686476654, 4381.16757816014, 4344.804483798237, 4349.760763158025, 4356.4772227332605, 4387.276099443588, 4394.538573449806, 4362.541933097043, 4376.89057773555, 4385.276429389147, 4423.1153769246275, 4428.468583769968, 4657.115148121846, 4701.036287561042, 4706.22347312693, 4748.026654535812, 4748.881277968044, 5059.089363914494, 5069.670471419346, 5098.337216161913, 5117.692938423669, 5120.180771076647, 5119.257707632372, 5132.307138536287, 5132.769025393829, 5140.948590514085, 5141.511556402136, 4671.719696818202, 4746.5253474652945, 4780.1873681474235, 4783.449903261169, 4840.394950631171, 5274.050670879278, 5274.841754747364, 5289.814856480005, 5326.307580014573, 5331.81338653153, 5033.723145227048, 5044.268581055726, 5055.393352797614, 5101.668391554611, 5102.617303702163, 4967.826126085642, 5095.439501654815, 5138.97430512845, 5146.974265128725, 5183.766730497061, 5098.872528186751, 5108.770105345268, 5111.514406131411, 5113.565346945476, 5124.300869807492, 5079.263506791494, 5085.288059671649, 5087.058894104603, 5111.05445492585, 5114.3862736471865, 4319.265724826787, 4347.239233134189, 4351.8694439166875, 4395.824167033346, 4403.405540252089, 3807.3717836556657, 3837.520309961255, 3850.4609354690365, 3884.6503814656817, 3960.346542820402, 4438.844640437634, 4443.37792709021, 4446.738396792014, 4489.506154323022, 4496.39298694672, 5024.824131155392, 5117.820876269388, 5167.044096842096, 5169.276301317818, 5220.9738951305, 4370.519242883281, 4385.978070109629, 4409.603135717801, 4429.734215947054, 4491.865244042684, 4656.627469802408, 4659.930101048487, 4667.323238130452, 4670.229412147026, 4689.788959496763, 4802.207635740134, 4815.903681926272, 4815.903681926342, 4818.542238487338, 4863.440704318978, 5010.0, 5057.544820966131, 5087.0, 5096.439391666988, 5111.616628752784, 4783.1868582341785, 4787.3776409066595, 4789.042191561772, 4793.9041219176115, 4821.975890120527, 4920.335754673217, 5033.6476446648385, 5038.521340472649, 5041.924371134509, 5096.108181068373, 5030.4718004608985, 5105.489451054865, 5109.693418394908, 5109.821156259513, 5134.4352121267375, 4978.576820970258, 4990.1516742154645, 4990.72551009698, 4992.575631071254, 5041.117804384291, 4789.281607758864, 4881.780319885543, 4979.651424400257, 4982.526659967298, 4988.352197618601, 4831.347768051268, 4855.271709243641, 4914.8771280718265, 4921.9507804921495, 4924.679895806761, 4949.307097006494, 4953.479884612208, 4961.255811628284, 4965.950340496549, 5010.173321402073, 4831.178699621143, 4835.854924352275, 4856.878578035577, 4866.562009419028, 4867.537583929521], "value": 4688.002159966081, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.9001782531195, 573.9540836733064, 577.387968753122, 583.9984426708196, 595.3124141616433, 27038.324041898937, 39753.80123099384, 40642.0, 40691.79654101733, 40757.99999999996, 41467.58532414675, 41857.79071104648, 41985.0, 42051.0, 42089.78955105228, 7479.9252007480045, 7912.327452166573, 8071.071826739912, 9919.057689519484, 10184.847227291597, 10181.541830617603, 10300.948495257513, 10308.226882983769, 10313.07182353588, 10319.43243121628, 10337.379757214554, 10381.636642717507, 10407.0, 10409.687709368693, 10421.374717516936, 7529.32236098751, 10260.692179234598, 10558.736031599272, 10562.735931601772, 10569.894301056967, 10189.59241630334, 10261.538230779634, 10263.538140783683, 10266.230032747573, 10272.0, 30233.395332093234, 38263.42604860929, 38679.80660096682, 38722.80638596817, 40741.1851762966, 3005.654349749785, 3040.4831178699674, 3079.799813012147, 3102.720755132026, 3219.0825614699697, 30491.847540762155, 31036.844815776003, 31377.215569610944, 31732.206694832814, 32705.34589308224, 3383.9661603383897, 3384.627690953993, 3422.26421319415, 3451.879184228565, 3465.3589086018915, 266883.0, 267139.0, 268725.0, 269458.0, 269570.0, 58716.412835871095, 59261.0, 59303.70348148232, 59327.0, 59360.40639593549, 34426.0, 35501.0, 35518.64481355153, 37231.62768372336, 37268.627313726516, 13248.602541923758, 15361.692766144615, 15376.15431151275, 15421.922890385476, 15517.767233491506, 11599.942000290113, 11904.107191960638, 11926.0, 12191.756164876653, 12230.877691223151, 19575.65092188918, 19804.20783168686, 19859.205631774566, 19935.900320498597, 19989.400317990483, 7278.599677017709, 7307.269273072757, 7346.33882950537, 7439.293267139613, 7472.140703819022, 768.4774353439603, 894.342658146262, 904.0597778310615, 937.7327461673391, 974.4104816586005, 29086.27284317909, 29111.708882911324, 29326.853365733463, 29362.559561606595, 29729.55405668917, 951.0917074194128, 952.642758965388, 956.8325543029941, 960.0687333286701, 977.5307852230969, 15195.468158614396, 15657.608559786097, 15663.138527380876, 15977.0, 15999.280032398337, 405284.0, 408324.0, 411364.0, 411593.0, 413115.0, 51093.74453127785, 51585.0, 51660.74169629203, 51665.0, 51665.48334516682, 1039.3088596083671, 1045.268312181476, 1114.5820317380983, 1139.2936379444798, 1160.8723040465543, 27480.17559473219, 30016.24959376033, 30036.699633004264, 30466.39067218599, 30527.542086869158, 43721.34417983669, 44210.55789442064, 44241.33637995368, 44248.55751442573, 44266.33600495931, 304776.0, 305499.0, 305675.0, 305783.0, 307621.0, 25305.0, 26470.602940955516, 26509.469810604067, 26578.867105665122, 26587.468250635266, 41966.79016604897, 42398.788006059774, 42690.78654606707, 43420.782896085315, 43929.34105988349, 36628.0, 37762.62237377701, 37844.0, 37892.810535947145, 37899.62100378961, 36383.839591804106, 36803.26393472169, 36841.07897302589, 36953.26093478169, 37112.0, 35736.463953040206, 36388.0, 36439.08902277464, 36737.26525469422, 36960.0, 31784.523232151074, 33401.49897751487, 33536.16159595932, 33783.32433351369, 33920.0, 25407.87296063508, 25455.236342909742, 25633.359166021, 25702.485950281265, 26310.60534091952], "value": 18314.25716134123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.10198839975476, 372.30564996281936, 372.8340888304705, 374.3598446656218, 390.1163863848382, 13263.0, 16840.15799210039, 17524.38664646736, 19002.904985475052, 19004.14481348339, 16556.586085347873, 16934.06862622555, 17413.216405261763, 17425.738613920803, 17576.648467030653, 4854.514548545144, 5282.7622756976025, 5301.734913254322, 5309.7610607522565, 5311.814086506973, 3746.868859589915, 3920.9607903920883, 3922.705797065217, 3982.6017398260233, 5156.53591176794, 3944.7830369329677, 4683.086798074377, 6048.1834952281315, 6177.351378105302, 6178.165947597085, 5921.970390148022, 6110.3889611038985, 6114.938850611481, 6153.107799369089, 6158.322584515699, 5342.332208473941, 5371.704556249405, 5373.032854086263, 5377.784888604451, 5381.327334083239, 16516.917415412965, 20150.0, 20873.5825283495, 21196.682049769264, 21597.568048639096, 1890.6313268912568, 1941.9514512137168, 1987.4534503011644, 2104.4318034130697, 2470.9011639534397, 13433.059685821996, 13435.932820335933, 13727.725445491134, 13941.651458713613, 14304.856951430456, 1763.7442570827159, 1769.2038582637865, 1770.4511601403478, 1815.7185636226407, 1860.692985657365, 46617.76691116556, 72025.27974720238, 73180.0, 73206.0, 73520.0, 8872.467651940904, 9411.858822117674, 9616.615335386647, 9757.512124393752, 10103.28244198488, 12702.491900324068, 13499.257540835348, 13506.932465337806, 13897.513587024405, 13968.371423285977, 7766.883496747553, 7808.492447990862, 7843.294103530709, 7911.446198766146, 7963.8805417918775, 7689.653965571562, 7696.769096927102, 7697.961510192526, 7815.944847445522, 7822.530648161129, 6371.299157092716, 6483.7730679425995, 6491.480681545465, 6504.5121615879, 6568.638724870178, 1756.4818378578095, 1768.938087166943, 1770.2741875830848, 1775.9644807103787, 1831.2400353853268, 851.2594043182471, 879.3800370738614, 880.4761167105562, 881.5900606218139, 918.1094338491653, 16620.33518659264, 17511.474655760347, 18442.907785461255, 18447.431968282577, 18452.630947381247, 851.3274513134678, 883.0639522106459, 886.6143227695973, 911.3256190419042, 974.8245315843217, 9803.264755143393, 10456.424896630759, 10580.576776928836, 10586.364818110784, 10616.363018218777, 377888.0, 400404.0, 404287.0, 406553.0, 407062.0, 67842.66078669575, 72031.0, 72538.27461725421, 73251.63374183202, 73495.89756153662, 857.8027053777666, 866.5927014303268, 873.3711727556149, 875.8160786234835, 877.5963056993727, 12167.513299468275, 15908.443204487787, 16182.514524564282, 16619.3352265908, 17369.652606948042, 36455.0, 36461.0, 37239.441408378356, 37335.25329493449, 37889.621103789716, 44113.33829992617, 49061.75469122631, 49292.0, 49346.01307973892, 52254.738726306125, 6362.854686156351, 6426.453751430994, 7643.197464266172, 7894.407919405952, 8015.158408367038, 11866.466009029442, 11963.401829908644, 12248.326342051272, 12268.282440458164, 12583.370831458573, 7571.545707257582, 7684.4236682250175, 7692.076950765944, 7771.339436147765, 10300.072993430627, 7340.522866013692, 7459.627018648937, 7881.093674227308, 7990.081140668665, 8009.8398032040195, 7845.686172553263, 7916.461157527032, 7947.483413578099, 8027.237412445808, 8130.918690813016, 11146.0, 11650.0, 11863.822042669195, 12054.698632533906, 12176.695582610506, 11186.664400068012, 11367.0, 11413.885861141282, 11414.714632134263, 11681.532738690697], "value": 8374.156288158956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.112198753791, 1439.323517946565, 1512.5991612222756, 1665.3255431550226, 1694.1783235130952, 7639.19788422216, 8102.0682621498545, 8194.590270486482, 8199.303059239965, 8205.261526462624, 6813.352731490513, 7563.281488258606, 7790.065192176932, 7817.530948143101, 8012.599370031489, 2257.063318722728, 2286.6798648189265, 2288.382136823057, 2288.4050146961745, 2289.2559918026623, 1898.221729091073, 2252.5044490212126, 2256.345659758668, 2297.6668383084443, 2299.367673889685, 2149.151085321297, 2218.0462401167492, 2228.420610641229, 2248.718910136233, 2255.605269077913, 2258.5482903419215, 2264.8867556622185, 2270.103309192876, 2296.5636529059425, 2297.287840769367, 2243.719535058118, 2247.8426510144295, 2254.842161048727, 2257.8645281283175, 2258.254775923941, 8060.838783224362, 8153.143919888385, 8160.183981601852, 8175.3459723222, 8195.42632015759, 4576.8626941191815, 4690.01509682967, 4693.9530604693855, 4696.060787842411, 4705.294205869112, 2970.0941212930047, 3055.6944305569486, 3084.33686757346, 3089.026956508715, 3099.891503797356, 912.9634814607408, 946.8816397950256, 960.6877764726422, 961.2694352292239, 961.5480724059681, 10445.68662940113, 10744.301620394728, 10753.677389678322, 11163.776724465546, 11231.494582743715, 4074.348104303297, 4116.629503344713, 4154.252234597741, 4175.227582897173, 4220.388043733641, 8671.956640216758, 8689.6524139035, 8693.0, 8694.17405346491, 8699.782505437415, 4594.839180628662, 4600.53994600544, 4603.194440972817, 4604.861854144381, 4609.446866376056, 4243.257429949808, 4251.383549385322, 4263.70154089217, 4272.807723652443, 4279.486461624625, 3432.5709286339206, 3444.5522082129164, 3447.24160684649, 3476.3047390521997, 3530.2586456843837, 967.1634036558327, 1023.9897601023895, 1024.0783295034528, 1033.9896601033893, 1036.445501656625, 858.9570521473902, 867.6832955971151, 868.3747701654798, 902.120432578231, 904.1410659873015, 5430.945690543123, 5457.863553411117, 5607.074832652566, 5750.942490575041, 5783.739731712083, 896.1038961038961, 908.6501696846761, 953.9856902146473, 965.5172413793103, 998.1515711645044, 3675.209829886587, 3723.8138093095235, 3752.9249415011545, 3757.981210093932, 3811.8856434307013, 9656.75858103539, 9870.0, 9938.45338506389, 9973.501324933724, 9976.401415915068, 9495.857562136573, 9884.802303954024, 9889.10998010168, 9894.109530142321, 9906.702798916043, 7339.376153026946, 7431.29402706742, 7512.060992375953, 7518.624068796538, 7528.9835872157655, 5346.385165705994, 5497.422770609029, 5564.387917329172, 5617.887642247214, 5772.624779389326, 8791.252743516872, 8895.955520222358, 9026.638934442548, 9215.953920230357, 9234.261259099121, 8974.551272436483, 9291.21024712907, 9332.346735728433, 9418.905810941802, 9425.151736343762, 7128.28717128283, 7151.60666163366, 7231.457640676865, 7265.164506081868, 7295.963520182578, 7680.0, 7798.532088074734, 7808.57052862098, 7819.218078192135, 7821.804454888674, 6765.340334480692, 7073.434125269863, 7162.033125527987, 7163.641817909188, 7240.131184257712, 6804.11546498952, 6850.828729281808, 6920.273371295942, 7003.509754317149, 7052.012718219351, 6417.582857114459, 6458.095866578588, 6484.286728459771, 6494.837629059311, 6538.1827271591055, 4841.8547443576745, 4853.611711063036, 4883.877903052452, 4899.118158731462, 4943.777530011086, 4850.369451971363, 4862.149123903374, 4898.559129678203, 4919.1883339248625, 4927.359443272351], "value": 4246.988544816377, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.67032758474306, 296.0260742158298, 296.52555910543134, 304.88109637241473, 311.8581045624241, 4837.177679794435, 4845.418549774032, 4863.85408437747, 4896.216605343146, 4942.579880710144, 4838.0, 4854.781534830932, 4858.9514104858945, 4867.853964381065, 4870.902581948359, 3642.562892452909, 3760.3419401604747, 3778.2821263959895, 3872.1094148345896, 3886.7667939923554, 3820.4460353248764, 3843.7693738375647, 3857.7106716996195, 3869.1487872667967, 3872.1481274119647, 3648.106213977579, 3841.058940559553, 3842.9615703843024, 3849.3824199544297, 3852.094757731945, 3759.0452964458464, 3846.942295865564, 3849.7690138591774, 3860.575336712959, 3883.9223215535812, 3423.0, 3425.417678994577, 3428.125827913866, 3430.1939044324563, 3447.5862896452586, 4789.161896668069, 4804.588741993189, 4809.519048095162, 4831.830885918976, 4849.199882019462, 4092.46797916269, 4324.22164010478, 4324.437823083011, 4326.156399502099, 4437.822487100512, 5079.492050794928, 5106.183010718267, 5107.591392688576, 5110.6422550421485, 5130.589552835801, 3500.859965601373, 3639.1629925117372, 3660.4692319613505, 3661.6155303692994, 3666.5416822897137, 5344.518993290622, 5366.812161574326, 5375.65058271215, 5378.489043540857, 5389.487998640123, 3730.123420996064, 3737.906552336159, 3740.0836794984857, 3754.849806007729, 3759.4924685167152, 3805.6765174960437, 3808.762152300513, 3810.571035861552, 3810.980945095312, 3822.9044273893373, 4134.627883490501, 4332.465507677981, 4332.501762297313, 4342.2835232186335, 4364.970288815716, 5075.873103172376, 5090.821821236313, 5104.515071068243, 5107.157319042316, 5126.4876861326, 1298.4806077569049, 1309.2668105860748, 1313.343328335832, 1318.813068238593, 1319.4985905355904, 831.7837362285728, 848.0, 925.9212966897754, 942.2791564453199, 947.8815148106487, 4443.133588950123, 4467.503386365539, 4486.528914463935, 4508.639308855284, 4512.9774351128035, 5219.556337711261, 5220.791168353223, 5227.869303267449, 5233.2935053768015, 5242.397124330674, 4327.285997810326, 4503.797329120198, 4515.435570553681, 4529.275315949498, 4614.607758340511, 2805.6492938382703, 2806.6351374321207, 2826.646669166354, 2837.0921305182555, 2838.659360876708, 4922.975385123052, 4923.5814955729165, 4926.285688575208, 4986.925196122061, 4991.126552853236, 5153.510416510426, 5407.756650950717, 5411.080116380225, 5436.673799572039, 5461.1808228766, 4931.408231012301, 4966.404031516096, 4975.4527002029745, 5004.924926126111, 5015.147424937696, 5348.545373643284, 5350.759215835219, 5352.411234764095, 5353.518183363516, 5372.355317361786, 5126.666766660304, 5160.791466751211, 5249.763760630857, 5252.44849290819, 5252.816151434681, 4973.577245933991, 4986.451490336132, 4989.451160372283, 4992.475790041994, 5016.122178618654, 3783.754055986352, 3795.924081518299, 3796.52543432071, 3799.810009499459, 3801.9619803801606, 5106.183010718267, 5308.708021058879, 5318.7340632967425, 5326.786928522971, 5351.277577526984, 5129.846104616868, 5153.922691159561, 5156.896862062813, 5161.071007218737, 5179.896402072013, 5149.253358262956, 5158.303629010035, 5173.715445650375, 5177.611679124156, 5188.533032027136, 4836.177849765478, 4945.67853089548, 5063.5695965843315, 5069.695818250917, 5078.7206703631655, 5005.6996580205305, 5180.766865490987, 5181.06740786662, 5184.326037615086, 5189.365349914765, 5080.161773307511, 5099.388073431212, 5108.386993560648, 5112.182050871843, 5112.616553758408], "value": 3877.1113761385227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.4894981914107, 704.9118860142482, 723.5839392349401, 751.3814356965975, 763.2329508843611, 13339.399727012284, 15187.544373668794, 15905.761413578777, 15908.443204487845, 16598.83401165988, 15553.377864885391, 15617.453389131382, 15666.295016724247, 15696.921515392407, 15775.290111944962, 626.7336382037638, 769.6575024114244, 784.129616126101, 789.2383849585149, 801.5230937592123, 792.2315354106507, 793.5199204481263, 797.5932274539997, 797.7726347990824, 799.3046049936535, 829.2288172000037, 830.248624994378, 830.4477522447595, 830.8255266394065, 831.7047448155909, 647.6891092275711, 797.529457620007, 822.8189798244376, 825.9050209225956, 832.5961908474385, 601.8375038739559, 602.9879402411927, 603.065248864263, 603.8279090459242, 604.087827380654, 12927.935360323138, 12946.741065178643, 12950.158239714388, 12983.415746291439, 13009.284489353082, 12433.93783031088, 13008.284544350057, 13134.408951597201, 13143.671408214776, 13611.0, 11672.591459298968, 11996.940015299868, 12020.0, 12068.396580170956, 12177.025837932944, 4205.894852628709, 4250.404943307939, 4250.914981700349, 4296.990207301282, 4342.826286948518, 64048.0, 64231.357686423005, 64321.67839160821, 64851.0, 65463.3453665462, 10179.694609161588, 10397.32417392867, 10407.427591482541, 10408.583656653649, 10437.217208709377, 15972.680546389007, 16149.59626009359, 16164.595885102966, 16348.836511634732, 16380.26288817006, 6336.366363363719, 6360.554761166674, 6404.391582799627, 6423.678816059179, 6616.702248398834, 3649.251903359805, 3651.8721844735305, 3659.359612067931, 3665.8533658653355, 3685.262947410475, 2869.383082637243, 2975.7173068558454, 2976.9851150744107, 2978.731914127739, 2981.3292009297734, 498.4317877619517, 511.4297558222555, 512.8948565544055, 513.545512221679, 594.037658992435, 517.4256575201523, 579.4147910610313, 593.8485686150004, 639.4788247578209, 642.9421352078335, 8362.958185209034, 8367.0, 8387.454815436977, 8680.91319086801, 8699.301957218033, 566.5411017076099, 625.3152797686525, 626.2172284644195, 630.8359826445065, 633.5058654249692, 3836.5971572984436, 3987.9003024924027, 4045.5954404559307, 4048.4131897980596, 4094.754314741125, 59457.70271148616, 59944.40055599388, 62618.68690656518, 62898.0, 62969.685151574864, 88483.55758221296, 94348.52825735828, 97581.0, 97653.0, 98425.0, 81953.0, 82089.58955205185, 83312.0, 84381.57809210915, 84647.0, 7545.608200750932, 7687.1159816619565, 7804.0, 7849.411294153076, 7889.092754333095, 50400.49599503958, 50986.0, 51288.48711512837, 51538.74230628823, 52404.21393679174, 69748.0, 73356.0, 74204.2579574219, 76089.0, 77337.61331193533, 10169.237307202138, 10181.287309888237, 10193.0, 10286.0, 10513.316634418738, 11220.943895280472, 11428.0, 11683.941580292045, 11775.646730598095, 12161.39193040362, 10200.897991020292, 10344.637937672145, 10561.63034293796, 10747.086497647788, 10887.891121088687, 10040.096391324816, 10158.390496569933, 10270.178385729274, 10312.432816195182, 10358.171346292429, 9787.80424391494, 10075.19398448137, 10079.848802267825, 10122.746931326776, 10391.272610917465, 8236.994937576714, 8480.363972701949, 8706.564671766513, 8800.119988001148, 8921.509316987369, 8512.787180320294, 9050.773730656787, 9069.727908162766, 9108.681196158102, 9248.676296329866], "value": 6562.2394229760575, "unit": "score"}], "name": "dromaeo_css", "value": 6532.331667973521, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 113.0, 114.0, 114.0, 113.0, 110.0, 111.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 124.0, 173.0, 123.0, 124.0, 156.0, 127.0, 162.0, 124.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 163.0, 162.0, 163.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 119.0, 76.0, 77.0, 75.0, 76.0, 103.0, 75.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 118.0, 85.0, 86.0, 84.0, 121.0, 83.0, 85.0, 137.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 119.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 87.0, 77.0, 79.0, 79.0, 88.0, 78.0, 85.0, 78.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 126.0, 130.0, 131.0, 136.0, 138.0, 137.0, 180.0, 129.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 174.0, 175.0, 177.0, 166.0, 166.0, 169.0, 169.0, 171.0, 167.0], "value": 170.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 72.0, 66.0, 66.0, 67.0, 69.0, 70.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1533.6, "alertThreshold": 2.0}]} 05:47:52 INFO - Return code: 0 05:47:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:52 INFO - # TBPL SUCCESS # 05:47:52 INFO - Running post-action listener: _resource_record_post_action 05:47:52 INFO - ##### 05:47:52 INFO - ##### Finished run-tests step (success) 05:47:52 INFO - ##### 05:47:52 INFO - Running post-run listener: _resource_record_post_run 05:47:52 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534421504; Read time: 12; Write time: 405604 05:47:52 INFO - TinderboxPrint: CPU usage
13.0% 05:47:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:47:52 INFO - TinderboxPrint: I/O write bytes / time
534,421,504 / 405,604 05:47:52 INFO - TinderboxPrint: CPU idle
8,329.1 (87.0%) 05:47:52 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 05:47:52 INFO - TinderboxPrint: Swap in / out
0 / 0 05:47:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246210560; Read time: 0; Write time: 216988 05:47:52 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288210944; Read time: 0; Write time: 188616 05:47:53 INFO - Running post-run listener: _upload_blobber_files 05:47:53 INFO - Blob upload gear active. 05:47:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:53 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 05:47:53 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'] 05:47:53 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 05:47:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:57 INFO - (blobuploader) - INFO - Done attempting. 05:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:57 INFO - (blobuploader) - INFO - Done attempting. 05:47:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:58 INFO - (blobuploader) - INFO - Done attempting. 05:47:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:58 INFO - Return code: 0 05:47:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80736ec7838d998b8ef351dbae400425c621e3ec76286ed71152142eb180d7339674a52552f715be16953b622f024edef891933d5201ed49aeed38f359f2e43a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1dee6ba6f5d607cd0cc81c405a862cd888713f56bfc511a711f8c9243cc80d2261aad9d6e9a804b5a9dcbcad4f792709a8251af4df3862fd8f21f6ca54a186", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31a69b5ce523cbe1c42faf93018ef329544de8842b2990c402996327473568ea63c28ab4cfc464a8a08bcf9aa7a2ac356a33a70a87c5194dc18980d745ca892f"} 05:47:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:58 INFO - Contents: 05:47:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80736ec7838d998b8ef351dbae400425c621e3ec76286ed71152142eb180d7339674a52552f715be16953b622f024edef891933d5201ed49aeed38f359f2e43a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1dee6ba6f5d607cd0cc81c405a862cd888713f56bfc511a711f8c9243cc80d2261aad9d6e9a804b5a9dcbcad4f792709a8251af4df3862fd8f21f6ca54a186", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31a69b5ce523cbe1c42faf93018ef329544de8842b2990c402996327473568ea63c28ab4cfc464a8a08bcf9aa7a2ac356a33a70a87c5194dc18980d745ca892f"} 05:47:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:58 INFO - Copying logs to upload dir... 05:47:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.095151 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-07-04 05:47:56.822082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:47:56.826326) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80736ec7838d998b8ef351dbae400425c621e3ec76286ed71152142eb180d7339674a52552f715be16953b622f024edef891933d5201ed49aeed38f359f2e43a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1dee6ba6f5d607cd0cc81c405a862cd888713f56bfc511a711f8c9243cc80d2261aad9d6e9a804b5a9dcbcad4f792709a8251af4df3862fd8f21f6ca54a186", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31a69b5ce523cbe1c42faf93018ef329544de8842b2990c402996327473568ea63c28ab4cfc464a8a08bcf9aa7a2ac356a33a70a87c5194dc18980d745ca892f"} build_url:https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/YiqlF4U3QyCfT-aWPbuY6g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/80736ec7838d998b8ef351dbae400425c621e3ec76286ed71152142eb180d7339674a52552f715be16953b622f024edef891933d5201ed49aeed38f359f2e43a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ee1dee6ba6f5d607cd0cc81c405a862cd888713f56bfc511a711f8c9243cc80d2261aad9d6e9a804b5a9dcbcad4f792709a8251af4df3862fd8f21f6ca54a186", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/31a69b5ce523cbe1c42faf93018ef329544de8842b2990c402996327473568ea63c28ab4cfc464a8a08bcf9aa7a2ac356a33a70a87c5194dc18980d745ca892f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 05:47:56.857437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:47:56.858082) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467634184.287104-1914781219 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 05:47:56.942936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:47:56.943529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 05:47:56.944107) ========= ========= Total master_lag: 0.20 =========